builder: mozilla-aurora_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0123 starttime: 1476871804.86 results: success (0) buildid: 20161019004013 builduid: 919dd8a3c54a41ccb915631b45ff1665 revision: ee8df4e3521848a5a2a0c05065ba9db368219843 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-19 03:10:04.857661) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-19 03:10:04.858118) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-19 03:10:04.858406) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-19 03:10:04.884281) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-19 03:10:04.884687) ========= 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.Dnf5CSMSh0/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.CFiLXJkVrI/Listeners TMPDIR=/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-10-19 03:10:04-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 13.7M=0.001s 2016-10-19 03:10:05 (13.7 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.157114 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-19 03:10:05.064108) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-19 03:10:05.064584) ========= 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.Dnf5CSMSh0/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.CFiLXJkVrI/Listeners TMPDIR=/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False program finished with exit code 0 elapsedTime=0.026131 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-19 03:10:05.115302) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-19 03:10:05.115767) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev ee8df4e3521848a5a2a0c05065ba9db368219843 --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 ee8df4e3521848a5a2a0c05065ba9db368219843 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.Dnf5CSMSh0/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.CFiLXJkVrI/Listeners TMPDIR=/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-10-19 03:10:05,190 truncating revision to first 12 chars 2016-10-19 03:10:05,190 Setting DEBUG logging. 2016-10-19 03:10:05,190 attempt 1/10 2016-10-19 03:10:05,190 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/ee8df4e35218?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-19 03:10:05,876 unpacking tar archive at: mozilla-aurora-ee8df4e35218/testing/mozharness/ program finished with exit code 0 elapsedTime=0.968049 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-19 03:10:06.107056) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-19 03:10:06.107381) ========= script_repo_revision: ee8df4e3521848a5a2a0c05065ba9db368219843 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-19 03:10:06.107773) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-19 03:10:06.108035) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-19 03:10:06.128590) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 10 secs) (at 2016-10-19 03:10:06.129006) ========= /tools/buildbot/bin/python -u 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', '-u', '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.Dnf5CSMSh0/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.CFiLXJkVrI/Listeners TMPDIR=/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 03:10:06 INFO - MultiFileLogger online at 20161019 03:10:06 in /builds/slave/test 03:10:06 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 03:10:06 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:10:06 INFO - {'append_to_log': False, 03:10:06 INFO - 'base_work_dir': '/builds/slave/test', 03:10:06 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 03:10:06 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:10:06 INFO - 'branch': 'Mozilla-Aurora', 03:10:06 INFO - 'buildbot_json_path': 'buildprops.json', 03:10:06 INFO - 'config_files': ('talos/mac_config.py',), 03:10:06 INFO - 'default_actions': ('clobber', 03:10:06 INFO - 'read-buildbot-config', 03:10:06 INFO - 'download-and-extract', 03:10:06 INFO - 'populate-webroot', 03:10:06 INFO - 'create-virtualenv', 03:10:06 INFO - 'install', 03:10:06 INFO - 'run-tests'), 03:10:06 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:10:06 INFO - 'download_minidump_stackwalk': True, 03:10:06 INFO - 'download_symbols': 'ondemand', 03:10:06 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:10:06 INFO - 'tooltool.py': '/tools/tooltool.py', 03:10:06 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:10:06 INFO - '/tools/misc-python/virtualenv.py')}, 03:10:06 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:10:06 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:10:06 INFO - 'installer_path': 'installer.exe', 03:10:06 INFO - 'log_level': 'info', 03:10:06 INFO - 'log_name': 'talos', 03:10:06 INFO - 'log_to_console': True, 03:10:06 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 03:10:06 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 03:10:06 INFO - 'opt_config_files': (), 03:10:06 INFO - 'pip_index': False, 03:10:06 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 03:10:06 INFO - 'cmd': ('bash', 03:10:06 INFO - '-c', 03:10:06 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 03:10:06 INFO - 'enabled': True, 03:10:06 INFO - 'halt_on_failure': False, 03:10:06 INFO - 'name': 'check_screen_resolution'},), 03:10:06 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 03:10:06 INFO - 'cmd': ('bash', 03:10:06 INFO - '-c', 03:10:06 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 03:10:06 INFO - 'enabled': True, 03:10:06 INFO - 'halt_on_failure': False, 03:10:06 INFO - 'name': 'check_screen_resolution'},), 03:10:06 INFO - 'run_cmd_checks_enabled': True, 03:10:06 INFO - 'sps_profile': False, 03:10:06 INFO - 'sps_profile_interval': 0, 03:10:06 INFO - 'suite': 'dromaeojs', 03:10:06 INFO - 'system_bits': '32', 03:10:06 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:10:06 INFO - 'title': 't-yosemite-r7-0123', 03:10:06 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:10:06 INFO - 'use_talos_json': True, 03:10:06 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:10:06 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:10:06 INFO - 'work_dir': 'build'} 03:10:06 INFO - [mozharness: 2016-10-19 10:10:06.325634Z] Running clobber step. 03:10:06 INFO - Running pre-action listener: _resource_record_pre_action 03:10:06 INFO - Running main action method: clobber 03:10:06 INFO - rmtree: /builds/slave/test/build 03:10:06 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:10:08 INFO - Running post-action listener: _resource_record_post_action 03:10:08 INFO - [mozharness: 2016-10-19 10:10:08.626789Z] Finished clobber step (success) 03:10:08 INFO - [mozharness: 2016-10-19 10:10:08.626898Z] Running read-buildbot-config step. 03:10:08 INFO - Running pre-action listener: _resource_record_pre_action 03:10:08 INFO - Running main action method: read_buildbot_config 03:10:08 INFO - Using buildbot properties: 03:10:08 INFO - { 03:10:08 INFO - "project": "", 03:10:08 INFO - "product": "firefox", 03:10:08 INFO - "script_repo_revision": "production", 03:10:08 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs", 03:10:08 INFO - "repository": "", 03:10:08 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs", 03:10:08 INFO - "buildid": "20161019004013", 03:10:08 INFO - "stage_platform": "macosx64", 03:10:08 INFO - "basedir": "/builds/slave/test", 03:10:08 INFO - "nightly_build": "True", 03:10:08 INFO - "buildnumber": 56, 03:10:08 INFO - "slavename": "t-yosemite-r7-0123", 03:10:08 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 03:10:08 INFO - "platform": "yosemite_r7", 03:10:08 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 03:10:08 INFO - "branch": "mozilla-aurora", 03:10:08 INFO - "repo_path": "releases/mozilla-aurora", 03:10:08 INFO - "revision": "ee8df4e3521848a5a2a0c05065ba9db368219843", 03:10:08 INFO - "pgo_build": "False", 03:10:08 INFO - "builduid": "919dd8a3c54a41ccb915631b45ff1665", 03:10:08 INFO - "slavebuilddir": "test" 03:10:08 INFO - } 03:10:08 INFO - Found installer url https://queue.taskcluster.net/v1/task/XK_g9cCZST-PfQDbKLFBxA/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg. 03:10:08 INFO - Running post-action listener: _resource_record_post_action 03:10:08 INFO - [mozharness: 2016-10-19 10:10:08.629980Z] Finished read-buildbot-config step (success) 03:10:08 INFO - [mozharness: 2016-10-19 10:10:08.630092Z] Running download-and-extract step. 03:10:08 INFO - Running pre-action listener: _resource_record_pre_action 03:10:08 INFO - Running main action method: download_and_extract 03:10:08 INFO - mkdir: /builds/slave/test/build/tests 03:10:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:10:08 INFO - trying https://queue.taskcluster.net/v1/task/XK_g9cCZST-PfQDbKLFBxA/artifacts/public/build/firefox-51.0a2.en-US.mac.test_packages.json 03:10:08 INFO - Downloading https://queue.taskcluster.net/v1/task/XK_g9cCZST-PfQDbKLFBxA/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 03:10:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/XK_g9cCZST-PfQDbKLFBxA/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 03:10:09 INFO - Downloaded 1199 bytes. 03:10:09 INFO - Reading from file /builds/slave/test/build/firefox-51.0a2.en-US.mac.test_packages.json 03:10:09 INFO - Using the following test package requirements: 03:10:09 INFO - {u'common': [u'firefox-51.0a2.en-US.mac.common.tests.zip'], 03:10:09 INFO - u'cppunittest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 03:10:09 INFO - u'firefox-51.0a2.en-US.mac.cppunittest.tests.zip'], 03:10:09 INFO - u'gtest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 03:10:09 INFO - u'firefox-51.0a2.en-US.mac.gtest.tests.zip'], 03:10:09 INFO - u'jittest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 03:10:09 INFO - u'jsshell-mac.zip'], 03:10:09 INFO - u'mochitest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 03:10:09 INFO - u'firefox-51.0a2.en-US.mac.mochitest.tests.zip'], 03:10:09 INFO - u'mozbase': [u'firefox-51.0a2.en-US.mac.common.tests.zip'], 03:10:09 INFO - u'reftest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 03:10:09 INFO - u'firefox-51.0a2.en-US.mac.reftest.tests.zip'], 03:10:09 INFO - u'talos': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 03:10:09 INFO - u'firefox-51.0a2.en-US.mac.talos.tests.zip'], 03:10:09 INFO - u'web-platform': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 03:10:09 INFO - u'firefox-51.0a2.en-US.mac.web-platform.tests.zip'], 03:10:09 INFO - u'xpcshell': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 03:10:09 INFO - u'firefox-51.0a2.en-US.mac.xpcshell.tests.zip']} 03:10:09 INFO - Downloading packages: [u'firefox-51.0a2.en-US.mac.common.tests.zip'] for test suite category: common 03:10:09 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/XK_g9cCZST-PfQDbKLFBxA/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip 03:10:09 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/XK_g9cCZST-PfQDbKLFBxA/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip'}, attempt #1 03:10:09 INFO - Fetch https://queue.taskcluster.net/v1/task/XK_g9cCZST-PfQDbKLFBxA/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip into memory 03:10:10 INFO - Expected file size: 16436315 03:10:17 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 03:10:17 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/XK_g9cCZST-PfQDbKLFBxA/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip 03:10:17 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/XK_g9cCZST-PfQDbKLFBxA/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip'}, attempt #1 03:10:17 INFO - Fetch https://queue.taskcluster.net/v1/task/XK_g9cCZST-PfQDbKLFBxA/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip into memory 03:10:18 INFO - Expected file size: 16436315 03:10:24 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/XK_g9cCZST-PfQDbKLFBxA/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip 03:10:24 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/XK_g9cCZST-PfQDbKLFBxA/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip'}, attempt #1 03:10:24 INFO - Fetch https://queue.taskcluster.net/v1/task/XK_g9cCZST-PfQDbKLFBxA/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip into memory 03:10:25 INFO - Expected file size: 14414081 03:10:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:10:26 INFO - trying https://queue.taskcluster.net/v1/task/XK_g9cCZST-PfQDbKLFBxA/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 03:10:26 INFO - Downloading https://queue.taskcluster.net/v1/task/XK_g9cCZST-PfQDbKLFBxA/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg 03:10:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/XK_g9cCZST-PfQDbKLFBxA/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 03:10:28 INFO - Downloaded 115571130 bytes. 03:10:28 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/XK_g9cCZST-PfQDbKLFBxA/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 03:10:28 INFO - mkdir: /builds/slave/test/properties 03:10:28 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:10:28 INFO - Writing to file /builds/slave/test/properties/build_url 03:10:28 INFO - Contents: 03:10:28 INFO - build_url:https://queue.taskcluster.net/v1/task/XK_g9cCZST-PfQDbKLFBxA/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 03:10:29 INFO - Running post-action listener: _resource_record_post_action 03:10:29 INFO - Running post-action listener: set_extra_try_arguments 03:10:29 INFO - [mozharness: 2016-10-19 10:10:29.538919Z] Finished download-and-extract step (success) 03:10:29 INFO - [mozharness: 2016-10-19 10:10:29.539053Z] Running populate-webroot step. 03:10:29 INFO - Running pre-action listener: _resource_record_pre_action 03:10:29 INFO - Running main action method: populate_webroot 03:10:29 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:10:29 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:10:29 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:10:29 INFO - '--tppagecycles', 03:10:29 INFO - '7'], 03:10:29 INFO - 'tests': ['tsvgm']}}, 03:10:29 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 03:10:29 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:10:29 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:10:29 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 03:10:29 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:10:29 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:10:29 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:10:29 INFO - 'talos_options': ['--disable-e10s'], 03:10:29 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:10:29 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:10:29 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:10:29 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:10:29 INFO - 'talos_options': ['--disable-e10s'], 03:10:29 INFO - 'tests': ['damp', 'tps']}, 03:10:29 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:10:29 INFO - 'tests': ['damp', 'tps']}, 03:10:29 INFO - 'g3': {'talos_options': ['--disable-e10s'], 03:10:29 INFO - 'tests': ['dromaeo_dom']}, 03:10:29 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:10:29 INFO - 'g4': {'talos_options': ['--disable-e10s'], 03:10:29 INFO - 'tests': ['basic_compositor_video']}, 03:10:29 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 03:10:29 INFO - 'other': {'talos_options': ['--disable-e10s'], 03:10:29 INFO - 'tests': ['a11yr', 03:10:29 INFO - 'ts_paint', 03:10:29 INFO - 'tpaint', 03:10:29 INFO - 'sessionrestore', 03:10:29 INFO - 'sessionrestore_no_auto_restore', 03:10:29 INFO - 'tabpaint']}, 03:10:29 INFO - 'other-e10s': {'tests': ['a11yr', 03:10:29 INFO - 'ts_paint', 03:10:29 INFO - 'tpaint', 03:10:29 INFO - 'sessionrestore', 03:10:29 INFO - 'sessionrestore_no_auto_restore', 03:10:29 INFO - 'tabpaint']}, 03:10:29 INFO - 'other-e10s_l64': {'tests': ['a11yr', 03:10:29 INFO - 'ts_paint', 03:10:29 INFO - 'tpaint', 03:10:29 INFO - 'sessionrestore', 03:10:29 INFO - 'sessionrestore_no_auto_restore', 03:10:29 INFO - 'tabpaint']}, 03:10:29 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 03:10:29 INFO - 'ts_paint', 03:10:29 INFO - 'tpaint', 03:10:29 INFO - 'sessionrestore', 03:10:29 INFO - 'sessionrestore_no_auto_restore', 03:10:29 INFO - 'tabpaint']}, 03:10:29 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 03:10:29 INFO - 'tests': ['a11yr', 03:10:29 INFO - 'ts_paint', 03:10:29 INFO - 'tpaint', 03:10:29 INFO - 'sessionrestore', 03:10:29 INFO - 'sessionrestore_no_auto_restore', 03:10:29 INFO - 'tabpaint']}, 03:10:29 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 03:10:29 INFO - 'tests': ['a11yr', 03:10:29 INFO - 'ts_paint', 03:10:29 INFO - 'tpaint', 03:10:29 INFO - 'sessionrestore', 03:10:29 INFO - 'sessionrestore_no_auto_restore', 03:10:29 INFO - 'tabpaint']}, 03:10:29 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 03:10:29 INFO - 'tests': ['tsvgx', 03:10:29 INFO - 'tsvgr_opacity', 03:10:29 INFO - 'tart', 03:10:29 INFO - 'tscrollx', 03:10:29 INFO - 'cart']}, 03:10:29 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:10:29 INFO - 'tsvgr_opacity', 03:10:29 INFO - 'tart', 03:10:29 INFO - 'tscrollx', 03:10:29 INFO - 'cart']}, 03:10:29 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:10:29 INFO - 'talos_options': ['--disable-e10s'], 03:10:29 INFO - 'tests': ['tp5o']}, 03:10:29 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:10:29 INFO - 'tests': ['tp5o']}, 03:10:29 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:10:29 INFO - 'talos_options': ['--disable-e10s', 03:10:29 INFO - '--xperf_path', 03:10:29 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:10:29 INFO - 'tests': ['tp5n']}, 03:10:29 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:10:29 INFO - 'talos_options': ['--xperf_path', 03:10:29 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:10:29 INFO - 'tests': ['tp5n']}}, 03:10:29 INFO - 'talos.zip': {'path': '', 03:10:29 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:10:29 INFO - Running post-action listener: _resource_record_post_action 03:10:29 INFO - [mozharness: 2016-10-19 10:10:29.557894Z] Finished populate-webroot step (success) 03:10:29 INFO - [mozharness: 2016-10-19 10:10:29.558039Z] Running create-virtualenv step. 03:10:29 INFO - Running pre-action listener: _resource_record_pre_action 03:10:29 INFO - Running main action method: create_virtualenv 03:10:29 INFO - Creating virtualenv /builds/slave/test/build/venv 03:10:29 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 03:10:29 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:10:29 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:10:29 INFO - Using real prefix '/tools/python27' 03:10:29 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:10:30 INFO - Installing distribute.............................................................................................................................................................................................done. 03:10:33 INFO - Installing pip.................done. 03:10:33 INFO - Return code: 0 03:10:33 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:10:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:10:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:10:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:10:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:10:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:10:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:10:33 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10083c490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1007b2570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8582461560>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100650d30>, '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 0x1004b6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100648b20>, '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.Dnf5CSMSh0/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.CFiLXJkVrI/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 03:10:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 03:10:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 03:10:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Dnf5CSMSh0/Render', 03:10:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:10:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:10:33 INFO - 'HOME': '/Users/cltbld', 03:10:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:10:33 INFO - 'LOGNAME': 'cltbld', 03:10:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:10:33 INFO - 'MOZ_NO_REMOTE': '1', 03:10:33 INFO - 'NO_EM_RESTART': '1', 03:10:33 INFO - 'PAGER': '/bin/cat', 03:10:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:10:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:10:33 INFO - 'PWD': '/builds/slave/test', 03:10:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:10:33 INFO - 'SHELL': '/bin/bash', 03:10:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.CFiLXJkVrI/Listeners', 03:10:33 INFO - 'TMPDIR': '/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/', 03:10:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:10:33 INFO - 'USER': 'cltbld', 03:10:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:10:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:10:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:10:33 INFO - 'XPC_FLAGS': '0x0', 03:10:33 INFO - 'XPC_SERVICE_NAME': '0', 03:10:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:10:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:10:33 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 03:10:33 INFO - Cleaning up... 03:10:33 INFO - Return code: 0 03:10:33 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:10:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:10:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:10:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:10:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:10:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:10:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:10:33 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10083c490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1007b2570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8582461560>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100650d30>, '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 0x1004b6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100648b20>, '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.Dnf5CSMSh0/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.CFiLXJkVrI/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 03:10:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 03:10:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 03:10:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Dnf5CSMSh0/Render', 03:10:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:10:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:10:33 INFO - 'HOME': '/Users/cltbld', 03:10:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:10:33 INFO - 'LOGNAME': 'cltbld', 03:10:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:10:33 INFO - 'MOZ_NO_REMOTE': '1', 03:10:33 INFO - 'NO_EM_RESTART': '1', 03:10:33 INFO - 'PAGER': '/bin/cat', 03:10:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:10:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:10:33 INFO - 'PWD': '/builds/slave/test', 03:10:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:10:33 INFO - 'SHELL': '/bin/bash', 03:10:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.CFiLXJkVrI/Listeners', 03:10:33 INFO - 'TMPDIR': '/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/', 03:10:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:10:33 INFO - 'USER': 'cltbld', 03:10:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:10:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:10:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:10:33 INFO - 'XPC_FLAGS': '0x0', 03:10:33 INFO - 'XPC_SERVICE_NAME': '0', 03:10:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:10:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:10:33 INFO - Downloading/unpacking psutil>=3.1.1 03:10:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:10:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:10:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:10:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:10:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:10:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:10:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:10:37 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:10:37 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:10:37 INFO - Installing collected packages: psutil 03:10:37 INFO - Running setup.py install for psutil 03:10:37 INFO - building 'psutil._psutil_osx' extension 03:10:37 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 03:10:37 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 03:10:37 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 03:10:37 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 03:10:38 INFO - building 'psutil._psutil_posix' extension 03:10:38 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 03:10:38 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 03:10:38 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 03:10:38 INFO - ^ 03:10:38 INFO - 1 warning generated. 03:10:38 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 03:10:38 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:10:38 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:10:38 INFO - Successfully installed psutil 03:10:38 INFO - Cleaning up... 03:10:38 INFO - Return code: 0 03:10:38 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:10: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')]} 03:10:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:10:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:10: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')]} 03:10:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:10:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:10: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10083c490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1007b2570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8582461560>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100650d30>, '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 0x1004b6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100648b20>, '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.Dnf5CSMSh0/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.CFiLXJkVrI/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 03:10: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 03:10: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 mozsystemmonitor==0.3 03:10:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Dnf5CSMSh0/Render', 03:10:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:10:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:10:38 INFO - 'HOME': '/Users/cltbld', 03:10:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:10:38 INFO - 'LOGNAME': 'cltbld', 03:10:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:10:38 INFO - 'MOZ_NO_REMOTE': '1', 03:10:38 INFO - 'NO_EM_RESTART': '1', 03:10:38 INFO - 'PAGER': '/bin/cat', 03:10:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:10:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:10:38 INFO - 'PWD': '/builds/slave/test', 03:10:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:10:38 INFO - 'SHELL': '/bin/bash', 03:10:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.CFiLXJkVrI/Listeners', 03:10:38 INFO - 'TMPDIR': '/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/', 03:10:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:10:38 INFO - 'USER': 'cltbld', 03:10:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:10:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:10:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:10:38 INFO - 'XPC_FLAGS': '0x0', 03:10:38 INFO - 'XPC_SERVICE_NAME': '0', 03:10:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:10:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:10:38 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:10:38 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 03:10:38 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 03:10:38 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 03:10:38 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 03:10:38 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 03:10:38 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 03:10:41 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:10:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:10:41 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:10:41 INFO - Installing collected packages: mozsystemmonitor 03:10:41 INFO - Running setup.py install for mozsystemmonitor 03:10:41 INFO - Successfully installed mozsystemmonitor 03:10:41 INFO - Cleaning up... 03:10:41 INFO - Return code: 0 03:10:41 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:10:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:10:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:10:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:10:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:10:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:10:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:10:41 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 0x10083c490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1007b2570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8582461560>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100650d30>, '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 0x1004b6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100648b20>, '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.Dnf5CSMSh0/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.CFiLXJkVrI/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 03:10:41 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 03:10:41 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 03:10:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Dnf5CSMSh0/Render', 03:10:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:10:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:10:41 INFO - 'HOME': '/Users/cltbld', 03:10:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:10:41 INFO - 'LOGNAME': 'cltbld', 03:10:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:10:41 INFO - 'MOZ_NO_REMOTE': '1', 03:10:41 INFO - 'NO_EM_RESTART': '1', 03:10:41 INFO - 'PAGER': '/bin/cat', 03:10:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:10:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:10:41 INFO - 'PWD': '/builds/slave/test', 03:10:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:10:41 INFO - 'SHELL': '/bin/bash', 03:10:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.CFiLXJkVrI/Listeners', 03:10:41 INFO - 'TMPDIR': '/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/', 03:10:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:10:41 INFO - 'USER': 'cltbld', 03:10:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:10:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:10:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:10:41 INFO - 'XPC_FLAGS': '0x0', 03:10:41 INFO - 'XPC_SERVICE_NAME': '0', 03:10:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:10:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:10:41 INFO - Downloading/unpacking jsonschema==2.5.1 03:10: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 03:10: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 03:10: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 03:10: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 03:10: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 03:10: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 03:10:44 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:10:44 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:10:44 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 03:10:44 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 03:10:44 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 03:10:44 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 03:10:44 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 03:10:44 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 03:10:44 INFO - Downloading functools32-3.2.3-2.tar.gz 03:10:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:10:44 INFO - warning: no files found matching '*.txt' 03:10:44 INFO - no previously-included directories found matching 'build' 03:10:44 INFO - no previously-included directories found matching 'dist' 03:10:44 INFO - no previously-included directories found matching '.git*' 03:10:44 INFO - Installing collected packages: jsonschema, functools32 03:10:44 INFO - Running setup.py install for functools32 03:10:44 INFO - warning: no files found matching '*.txt' 03:10:44 INFO - no previously-included directories found matching 'build' 03:10:44 INFO - no previously-included directories found matching 'dist' 03:10:44 INFO - no previously-included directories found matching '.git*' 03:10:44 INFO - Successfully installed jsonschema functools32 03:10:44 INFO - Cleaning up... 03:10:45 INFO - Return code: 0 03:10:45 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 03:10:45 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')]} 03:10:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:10:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:10:45 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')]} 03:10:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:10:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:10:45 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 0x10083c490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1007b2570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8582461560>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100650d30>, '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 0x1004b6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100648b20>, '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.Dnf5CSMSh0/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.CFiLXJkVrI/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 03:10:45 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 03:10:45 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 03:10:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Dnf5CSMSh0/Render', 03:10:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:10:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:10:45 INFO - 'HOME': '/Users/cltbld', 03:10:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:10:45 INFO - 'LOGNAME': 'cltbld', 03:10:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:10:45 INFO - 'MOZ_NO_REMOTE': '1', 03:10:45 INFO - 'NO_EM_RESTART': '1', 03:10:45 INFO - 'PAGER': '/bin/cat', 03:10:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:10:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:10:45 INFO - 'PWD': '/builds/slave/test', 03:10:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:10:45 INFO - 'SHELL': '/bin/bash', 03:10:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.CFiLXJkVrI/Listeners', 03:10:45 INFO - 'TMPDIR': '/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/', 03:10:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:10:45 INFO - 'USER': 'cltbld', 03:10:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:10:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:10:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:10:45 INFO - 'XPC_FLAGS': '0x0', 03:10:45 INFO - 'XPC_SERVICE_NAME': '0', 03:10:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:10:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:10:45 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 03:10:45 INFO - Cleaning up... 03:10:45 INFO - Return code: 0 03:10:45 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:10:45 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')]} 03:10:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:10:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:10:45 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')]} 03:10:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:10:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:10:45 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 0x10083c490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1007b2570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8582461560>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100650d30>, '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 0x1004b6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100648b20>, '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.Dnf5CSMSh0/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.CFiLXJkVrI/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 03:10:45 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 03:10:45 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 03:10:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Dnf5CSMSh0/Render', 03:10:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:10:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:10:45 INFO - 'HOME': '/Users/cltbld', 03:10:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:10:45 INFO - 'LOGNAME': 'cltbld', 03:10:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:10:45 INFO - 'MOZ_NO_REMOTE': '1', 03:10:45 INFO - 'NO_EM_RESTART': '1', 03:10:45 INFO - 'PAGER': '/bin/cat', 03:10:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:10:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:10:45 INFO - 'PWD': '/builds/slave/test', 03:10:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:10:45 INFO - 'SHELL': '/bin/bash', 03:10:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.CFiLXJkVrI/Listeners', 03:10:45 INFO - 'TMPDIR': '/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/', 03:10:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:10:45 INFO - 'USER': 'cltbld', 03:10:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:10:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:10:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:10:45 INFO - 'XPC_FLAGS': '0x0', 03:10:45 INFO - 'XPC_SERVICE_NAME': '0', 03:10:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:10:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:10:45 INFO - Downloading/unpacking blobuploader==1.2.4 03:10: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 03:10: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 03:10: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 03:10: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 03:10: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 03:10: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 03:10:48 INFO - Downloading blobuploader-1.2.4.tar.gz 03:10:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:10:48 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:10:48 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 03:10:48 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 03:10:48 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 03:10:48 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 03:10:48 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 03:10:48 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 03:10:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:10:48 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:10:48 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 03:10:48 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 03:10:48 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 03:10:48 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 03:10:48 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 03:10:48 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 03:10:49 INFO - Downloading docopt-0.6.1.tar.gz 03:10:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:10:49 INFO - Installing collected packages: blobuploader, requests, docopt 03:10:49 INFO - Running setup.py install for blobuploader 03:10:49 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:10:49 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:10:49 INFO - Running setup.py install for requests 03:10:49 INFO - Running setup.py install for docopt 03:10:50 INFO - Successfully installed blobuploader requests docopt 03:10:50 INFO - Cleaning up... 03:10:50 INFO - Return code: 0 03:10:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:10:50 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')]} 03:10:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:10:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:10:50 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')]} 03:10:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:10:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:10:50 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 0x10083c490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1007b2570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8582461560>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100650d30>, '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 0x1004b6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100648b20>, '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.Dnf5CSMSh0/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.CFiLXJkVrI/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 03:10:50 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 03:10:50 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 03:10:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Dnf5CSMSh0/Render', 03:10:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:10:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:10:50 INFO - 'HOME': '/Users/cltbld', 03:10:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:10:50 INFO - 'LOGNAME': 'cltbld', 03:10:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:10:50 INFO - 'MOZ_NO_REMOTE': '1', 03:10:50 INFO - 'NO_EM_RESTART': '1', 03:10:50 INFO - 'PAGER': '/bin/cat', 03:10:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:10:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:10:50 INFO - 'PWD': '/builds/slave/test', 03:10:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:10:50 INFO - 'SHELL': '/bin/bash', 03:10:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.CFiLXJkVrI/Listeners', 03:10:50 INFO - 'TMPDIR': '/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/', 03:10:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:10:50 INFO - 'USER': 'cltbld', 03:10:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:10:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:10:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:10:50 INFO - 'XPC_FLAGS': '0x0', 03:10:50 INFO - 'XPC_SERVICE_NAME': '0', 03:10:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:10:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:10:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:10:50 INFO - Running setup.py (path:/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/pip-HNc7Kb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:10:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:10:50 INFO - Running setup.py (path:/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/pip-6Solji-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:10:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:10:50 INFO - Running setup.py (path:/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/pip-35uavU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:10:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:10:50 INFO - Running setup.py (path:/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/pip-eBtmkd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:10:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:10:50 INFO - Running setup.py (path:/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/pip-Lkr56_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:10:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:10:50 INFO - Running setup.py (path:/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/pip-7ePSSc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:10:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:10:51 INFO - Running setup.py (path:/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/pip-Kl8RDv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:10:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:10:51 INFO - Running setup.py (path:/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/pip-7zj9qZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:10:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:10:51 INFO - Running setup.py (path:/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/pip-H85tp5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:10:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:10:51 INFO - Running setup.py (path:/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/pip-vE8ovz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:10:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:10:51 INFO - Running setup.py (path:/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/pip-v8SDbw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:10:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:10:51 INFO - Running setup.py (path:/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/pip-swEUOv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:10:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:10:51 INFO - Running setup.py (path:/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/pip-K_VF_C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:10:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:10:51 INFO - Running setup.py (path:/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/pip-QtxmRH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:10:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:10:51 INFO - Running setup.py (path:/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/pip-_k4SeE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:10:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:10:52 INFO - Running setup.py (path:/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/pip-25Y0Iv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:10:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:10:52 INFO - Running setup.py (path:/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/pip-KG5QcV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:10:52 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:10:52 INFO - Running setup.py install for manifestparser 03:10:52 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:10:52 INFO - Running setup.py install for mozcrash 03:10:52 INFO - Running setup.py install for mozdebug 03:10:52 INFO - Running setup.py install for mozdevice 03:10:52 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:10:52 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:10:52 INFO - Running setup.py install for mozfile 03:10:52 INFO - Running setup.py install for mozhttpd 03:10:53 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:10:53 INFO - Running setup.py install for mozinfo 03:10:53 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:10:53 INFO - Running setup.py install for mozInstall 03:10:53 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:10:53 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:10:53 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:10:53 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:10:53 INFO - Running setup.py install for mozleak 03:10:53 INFO - Running setup.py install for mozlog 03:10:53 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:10:53 INFO - Running setup.py install for moznetwork 03:10:53 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:10:53 INFO - Running setup.py install for mozprocess 03:10:54 INFO - Running setup.py install for mozprofile 03:10:54 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:10:54 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:10:54 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:10:54 INFO - Running setup.py install for mozrunner 03:10:54 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:10:54 INFO - Running setup.py install for mozscreenshot 03:10:54 INFO - Running setup.py install for moztest 03:10:54 INFO - Running setup.py install for mozversion 03:10:54 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:10:54 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:10:54 INFO - Cleaning up... 03:10:54 INFO - Return code: 0 03:10:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:10:54 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')]} 03:10:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:10:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:10:54 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')]} 03:10:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:10:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:10:54 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 0x10083c490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1007b2570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8582461560>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100650d30>, '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 0x1004b6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100648b20>, '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.Dnf5CSMSh0/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.CFiLXJkVrI/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 03:10:54 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 03:10:54 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 03:10:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Dnf5CSMSh0/Render', 03:10:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:10:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:10:54 INFO - 'HOME': '/Users/cltbld', 03:10:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:10:54 INFO - 'LOGNAME': 'cltbld', 03:10:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:10:54 INFO - 'MOZ_NO_REMOTE': '1', 03:10:54 INFO - 'NO_EM_RESTART': '1', 03:10:54 INFO - 'PAGER': '/bin/cat', 03:10:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:10:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:10:54 INFO - 'PWD': '/builds/slave/test', 03:10:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:10:54 INFO - 'SHELL': '/bin/bash', 03:10:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.CFiLXJkVrI/Listeners', 03:10:54 INFO - 'TMPDIR': '/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/', 03:10:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:10:54 INFO - 'USER': 'cltbld', 03:10:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:10:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:10:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:10:54 INFO - 'XPC_FLAGS': '0x0', 03:10:54 INFO - 'XPC_SERVICE_NAME': '0', 03:10:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:10:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:10:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:10:55 INFO - Running setup.py (path:/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/pip-Drd1Df-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:10:55 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)) 03:10:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:10:55 INFO - Running setup.py (path:/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/pip-AGPMcz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:10:55 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)) 03:10:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:10:55 INFO - Running setup.py (path:/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/pip-eHtAMc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:10:55 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)) 03:10:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:10:55 INFO - Running setup.py (path:/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/pip-5wYQ_d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:10:55 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)) 03:10:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:10:55 INFO - Running setup.py (path:/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/pip-nlemGD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:10:55 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)) 03:10:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:10:55 INFO - Running setup.py (path:/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/pip-dj1Tja-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:10:55 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)) 03:10:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:10:55 INFO - Running setup.py (path:/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/pip-IsB6t4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:10:55 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)) 03:10:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:10:55 INFO - Running setup.py (path:/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/pip-ETVR6S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:10:55 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)) 03:10:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:10:55 INFO - Running setup.py (path:/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/pip-sxdDpw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:10:56 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)) 03:10:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:10:56 INFO - Running setup.py (path:/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/pip-BVVDgQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:10:56 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)) 03:10:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:10:56 INFO - Running setup.py (path:/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/pip-MOh0TM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:10:56 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)) 03:10:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:10:56 INFO - Running setup.py (path:/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/pip-htLHtJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:10:56 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)) 03:10:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:10:56 INFO - Running setup.py (path:/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/pip-NWiTJl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:10:56 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)) 03:10:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:10:56 INFO - Running setup.py (path:/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/pip-UuGXBn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:10:56 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)) 03:10:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:10:56 INFO - Running setup.py (path:/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/pip-b7_Q5n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:10:56 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)) 03:10:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:10:56 INFO - Running setup.py (path:/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/pip-2DaDcI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:10:56 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)) 03:10:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:10:56 INFO - Running setup.py (path:/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/pip-UtK2gl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:10:56 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)) 03:10:56 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)) 03:10:56 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)) 03:10:56 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)) 03:10:56 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)) 03:10:56 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)) 03:10:56 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:10:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:10:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:10:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:10:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:10:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:10:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:10:59 INFO - Downloading blessings-1.6.tar.gz 03:10:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:10:59 INFO - Installing collected packages: blessings 03:10:59 INFO - Running setup.py install for blessings 03:10:59 INFO - Successfully installed blessings 03:10:59 INFO - Cleaning up... 03:10:59 INFO - Return code: 0 03:10:59 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:10:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:10:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:11:00 INFO - Reading from file tmpfile_stdout 03:11:00 INFO - Current package versions: 03:11:00 INFO - blessings == 1.6 03:11:00 INFO - blobuploader == 1.2.4 03:11:00 INFO - docopt == 0.6.1 03:11:00 INFO - functools32 == 3.2.3-2 03:11:00 INFO - jsonschema == 2.5.1 03:11:00 INFO - manifestparser == 1.1 03:11:00 INFO - mozInstall == 1.12 03:11:00 INFO - mozcrash == 0.17 03:11:00 INFO - mozdebug == 0.1 03:11:00 INFO - mozdevice == 0.48 03:11:00 INFO - mozfile == 1.2 03:11:00 INFO - mozhttpd == 0.7 03:11:00 INFO - mozinfo == 0.9 03:11:00 INFO - mozleak == 0.1 03:11:00 INFO - mozlog == 3.4 03:11:00 INFO - moznetwork == 0.27 03:11:00 INFO - mozprocess == 0.23 03:11:00 INFO - mozprofile == 0.28 03:11:00 INFO - mozrunner == 6.12 03:11:00 INFO - mozscreenshot == 0.1 03:11:00 INFO - mozsystemmonitor == 0.3 03:11:00 INFO - moztest == 0.7 03:11:00 INFO - mozversion == 1.4 03:11:00 INFO - psutil == 3.1.1 03:11:00 INFO - requests == 1.2.3 03:11:00 INFO - wsgiref == 0.1.2 03:11:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:11:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:11:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:11:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:11:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:11:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:11:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:11:00 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 0x10083c490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1007b2570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8582461560>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100650d30>, '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 0x1004b6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100648b20>, '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.Dnf5CSMSh0/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.CFiLXJkVrI/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 03:11:00 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 03:11:00 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 03:11:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Dnf5CSMSh0/Render', 03:11:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:11:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:11:00 INFO - 'HOME': '/Users/cltbld', 03:11:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:11:00 INFO - 'LOGNAME': 'cltbld', 03:11:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:11:00 INFO - 'MOZ_NO_REMOTE': '1', 03:11:00 INFO - 'NO_EM_RESTART': '1', 03:11:00 INFO - 'PAGER': '/bin/cat', 03:11:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:11:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:11:00 INFO - 'PWD': '/builds/slave/test', 03:11:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:11:00 INFO - 'SHELL': '/bin/bash', 03:11:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.CFiLXJkVrI/Listeners', 03:11:00 INFO - 'TMPDIR': '/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/', 03:11:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:11:00 INFO - 'USER': 'cltbld', 03:11:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:11:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:11:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:11:00 INFO - 'XPC_FLAGS': '0x0', 03:11:00 INFO - 'XPC_SERVICE_NAME': '0', 03:11:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:11:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:11:00 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)) 03:11:00 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)) 03:11:00 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)) 03:11:00 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)) 03:11:00 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)) 03:11:00 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)) 03:11:00 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)) 03:11:00 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)) 03:11:00 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)) 03:11:00 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)) 03:11:00 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)) 03:11:00 INFO - Cleaning up... 03:11:00 INFO - Return code: 0 03:11:00 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:11:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:11:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:11:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:11:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:11:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:11:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:11:00 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10083c490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1007b2570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8582461560>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100650d30>, '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 0x1004b6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100648b20>, '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.Dnf5CSMSh0/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.CFiLXJkVrI/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 03:11:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 03:11:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 03:11:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Dnf5CSMSh0/Render', 03:11:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:11:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:11:00 INFO - 'HOME': '/Users/cltbld', 03:11:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:11:00 INFO - 'LOGNAME': 'cltbld', 03:11:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:11:00 INFO - 'MOZ_NO_REMOTE': '1', 03:11:00 INFO - 'NO_EM_RESTART': '1', 03:11:00 INFO - 'PAGER': '/bin/cat', 03:11:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:11:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:11:00 INFO - 'PWD': '/builds/slave/test', 03:11:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:11:00 INFO - 'SHELL': '/bin/bash', 03:11:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.CFiLXJkVrI/Listeners', 03:11:00 INFO - 'TMPDIR': '/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/', 03:11:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:11:00 INFO - 'USER': 'cltbld', 03:11:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:11:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:11:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:11:00 INFO - 'XPC_FLAGS': '0x0', 03:11:00 INFO - 'XPC_SERVICE_NAME': '0', 03:11:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:11:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:11:00 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:11:00 INFO - Cleaning up... 03:11:00 INFO - Return code: 0 03:11:00 INFO - Running post-action listener: _resource_record_post_action 03:11:00 INFO - Running post-action listener: _start_resource_monitoring 03:11:00 INFO - Starting resource monitoring. 03:11:00 INFO - [mozharness: 2016-10-19 10:11:00.672376Z] Finished create-virtualenv step (success) 03:11:00 INFO - [mozharness: 2016-10-19 10:11:00.673329Z] Running install step. 03:11:00 INFO - Running pre-action listener: _resource_record_pre_action 03:11:00 INFO - Running main action method: install 03:11:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:11:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:11:00 INFO - Reading from file tmpfile_stdout 03:11:00 INFO - Detecting whether we're running mozinstall >=1.0... 03:11:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:11:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:11:01 INFO - Reading from file tmpfile_stdout 03:11:01 INFO - Output received: 03:11:01 INFO - Usage: mozinstall [options] installer 03:11:01 INFO - Options: 03:11:01 INFO - -h, --help show this help message and exit 03:11:01 INFO - -d DEST, --destination=DEST 03:11:01 INFO - Directory to install application into. [default: 03:11:01 INFO - "/builds/slave/test"] 03:11:01 INFO - --app=APP Application being installed. [default: firefox] 03:11:01 INFO - mkdir: /builds/slave/test/build/application 03:11:01 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'] 03:11:01 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 03:11:33 INFO - Reading from file tmpfile_stdout 03:11:33 INFO - Output received: 03:11:33 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 03:11:33 INFO - Running post-action listener: _resource_record_post_action 03:11:33 INFO - [mozharness: 2016-10-19 10:11:33.427301Z] Finished install step (success) 03:11:33 INFO - [mozharness: 2016-10-19 10:11:33.427443Z] Running run-tests step. 03:11:33 INFO - Running pre-action listener: _resource_record_pre_action 03:11:33 INFO - Running main action method: run_tests 03:11:33 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 03:11:33 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 03:11:33 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 03:11:33 INFO - 2016-10-19 03:11:33.441 screenresolution[1641:8088] starting screenresolution argv=screenresolution get 03:11:33 INFO - 2016-10-19 03:11:33.444 screenresolution[1641:8088] Display 0: 1600x1200x32@60 03:11:33 INFO - 2016-10-19 03:11:33.450 screenresolution[1642:8090] starting screenresolution argv=screenresolution list 03:11:33 INFO - Available Modes on Display 0 03:11:33 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 03:11:33 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 03:11:33 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 03:11:33 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 03:11:33 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 03:11:33 INFO - Intel Iris: 03:11:33 INFO - Chipset Model: Intel Iris 03:11:33 INFO - Type: GPU 03:11:33 INFO - Bus: Built-In 03:11:33 INFO - VRAM (Dynamic, Max): 1536 MB 03:11:33 INFO - Vendor: Intel (0x8086) 03:11:33 INFO - Device ID: 0x0a2e 03:11:33 INFO - Revision ID: 0x0009 03:11:33 INFO - Displays: 03:11:33 INFO - Display: 03:11:33 INFO - Resolution: 1600 x 1200 @ 60 Hz 03:11:33 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 03:11:33 INFO - Display Serial Number: 1600x1200 60 03:11:33 INFO - Main Display: Yes 03:11:33 INFO - Mirror: Off 03:11:33 INFO - Online: Yes 03:11:33 INFO - Rotation: Supported 03:11:33 INFO - Return code: 0 03:11:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:11:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:11:33 INFO - Python 2.7.3 03:11:33 INFO - Return code: 0 03:11:33 INFO - grabbing minidump binary from tooltool 03:11:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:11:33 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 0x100650d30>, '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 0x1004b6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100648b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:11:33 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 03:11:33 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 03:11:33 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 03:11:33 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:11:33 INFO - Return code: 0 03:11:33 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 03:11:33 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:11:33 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:11:33 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 03:11:33 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:11:33 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/XK_g9cCZST-PfQDbKLFBxA/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0123', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 03:11:33 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/XK_g9cCZST-PfQDbKLFBxA/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0123 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 03:11:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Dnf5CSMSh0/Render', 03:11:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:11:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:11:33 INFO - 'HOME': '/Users/cltbld', 03:11:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:11:33 INFO - 'LOGNAME': 'cltbld', 03:11:33 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:11:33 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 03:11:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:11:33 INFO - 'MOZ_NO_REMOTE': '1', 03:11:33 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:11:33 INFO - 'NO_EM_RESTART': '1', 03:11:33 INFO - 'PAGER': '/bin/cat', 03:11:33 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:11:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:11:33 INFO - 'PWD': '/builds/slave/test', 03:11:33 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:11:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:11:33 INFO - 'SHELL': '/bin/bash', 03:11:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.CFiLXJkVrI/Listeners', 03:11:33 INFO - 'TMPDIR': '/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/', 03:11:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:11:33 INFO - 'USER': 'cltbld', 03:11:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:11:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:11:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:11:33 INFO - 'XPC_FLAGS': '0x0', 03:11:33 INFO - 'XPC_SERVICE_NAME': '0', 03:11:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:11:33 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/XK_g9cCZST-PfQDbKLFBxA/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0123', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 03:11:34 INFO - mozversion application_buildid: 20161019004013 03:11:34 INFO - mozversion application_changeset: ee8df4e3521848a5a2a0c05065ba9db368219843 03:11:34 INFO - mozversion application_display_name: FirefoxDeveloperEdition 03:11:34 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:11:34 INFO - mozversion application_name: Firefox 03:11:34 INFO - mozversion application_remotingname: firefox-dev 03:11:34 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:11:34 INFO - mozversion application_vendor: Mozilla 03:11:34 INFO - mozversion application_version: 51.0a2 03:11:34 INFO - mozversion platform_buildid: 20161019004013 03:11:34 INFO - mozversion platform_changeset: ee8df4e3521848a5a2a0c05065ba9db368219843 03:11:34 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:11:34 INFO - mozversion platform_version: 51.0a2 03:11:34 INFO - using testdate: 1476871894 03:11:34 INFO - actual date: 1476871894 03:11:34 INFO - starting webserver on 'localhost:49278' 03:11:34 INFO - SUITE-START | Running 2 tests 03:11:34 INFO - TEST-START | dromaeo_css 03:11:34 INFO - operating with platform_type : mac_ 03:11:34 INFO - Initialising browser for dromaeo_css test... 03:11:34 INFO - TEST-INFO | started process 1652 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/tmpL1jO7O/profile http://localhost:49278/getInfo.html) 03:11:36 INFO - PROCESS | 1652 | __metrics Screen width/height:1600/1200 03:11:36 INFO - PROCESS | 1652 | colorDepth:24 03:11:36 INFO - PROCESS | 1652 | Browser inner width/height: 1024/689 03:11:36 INFO - PROCESS | 1652 | __metrics 03:11:36 INFO - PROCESS | 1652 | 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" 03:11:36 INFO - PROCESS | 1652 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 03:11:37 INFO - TEST-INFO | 1652: exit 0 03:11:37 INFO - Browser initialized. 03:11:37 INFO - Running cycle 1/1 for dromaeo_css test... 03:11:37 INFO - TEST-INFO | started process 1657 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/tmpL1jO7O/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:11:49 INFO - PROCESS | 1657 | RSS: Main: 219312128 03:11:49 INFO - PROCESS | 1657 | 03:12:40 INFO - PROCESS | 1657 | 1476871960902 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] 03:14:52 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49278/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49278/tests/dromaeo/cssquery-ext.html) 03:14:54 INFO - PROCESS | 1657 | RSS: Main: 378302464 03:14:54 INFO - PROCESS | 1657 | 03:17:57 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49278/tests/dromaeo/cssquery-ext.html (next: http://localhost:49278/tests/dromaeo/cssquery-jquery.html) 03:17:57 INFO - PROCESS | 1657 | RSS: Main: 352669696 03:17:57 INFO - PROCESS | 1657 | 03:21:00 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49278/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49278/tests/dromaeo/cssquery-mootools.html) 03:21:00 INFO - PROCESS | 1657 | RSS: Main: 338788352 03:21:00 INFO - PROCESS | 1657 | 03:24:03 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49278/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49278/tests/dromaeo/cssquery-prototype.html) 03:24:03 INFO - PROCESS | 1657 | RSS: Main: 315293696 03:24:03 INFO - PROCESS | 1657 | 03:27:07 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49278/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49278/tests/dromaeo/cssquery-yui.html) 03:27:07 INFO - PROCESS | 1657 | RSS: Main: 309579776 03:27:07 INFO - PROCESS | 1657 | 03:30:11 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49278/tests/dromaeo/cssquery-yui.html (next: http://localhost:49278/tests/dromaeo/cssquery-dojo.html) 03:30:11 INFO - PROCESS | 1657 | RSS: Main: 409825280 03:30:11 INFO - PROCESS | 1657 | 03:30:11 INFO - PROCESS | 1657 | __start_tp_report 03:30:11 INFO - PROCESS | 1657 | _x_x_mozilla_page_load 03:30:11 INFO - PROCESS | 1657 | _x_x_mozilla_page_load_details 03:30:11 INFO - PROCESS | 1657 | |i|pagename|runs| 03:30:11 INFO - PROCESS | 1657 | |0;dojo.html;3365.1923538350798;3394.88117915873;3408.096854333602;3416.5900091988965;3461.117415059161;5929.169916211728;5960.105984102376;5972.910406343897;5980.970095149529;6012.939870601293;5473.507384335399;5803.158542011406;5864.941350586493;5879.52963762899;5896.970515147418;4734.834280800173;5236.31927849379;5266.631335806476;5276.7889284428575;5289.550388217006;4400.97799511002;5160.277561141444;5240.03059434004;5331.893362132755;5348.946510534884;4868.586170175539;5318.734063296839;5320.547753440962;5328;5335.679859208441;5314.893702125955;5333.093374126408;5381.219723140122;5381.461853814626;5389.245505629215;5176.042432150064;5247.947520524822;5325.147976323769;5335.9466405336225;5336.91994620081;4786.808527658889;4857.247126695368;5769.942300576982;5771.394003629601;5774.566907481913;6197.566170368076;6208.324210274894;6231.283402408736;6255.937440625627;6258.43674069336;6168.228971378578;6208.72060757267;6229.159063526411;6232.8130156095385;6234.657093859836;5769.336526299529;5841.678707671119;5854.092615644582;5895.174675545427;5940;6205;6303.779367722108;6312.684365781693;6315.842103947438;6318.304986451487;6275.874482510324;6290.21372328459;6293.905591416133;6293.905591416133;6299.937000629935;6140.907886381708;6185.8144255672405;6260.906086408708;6268.717907694165;6290;6223.37766223374;6253.78111766086;6259;6296.024116261895;6303.212098487689;6222.719977601018;6234.096056071935;6239.126522286792;6266.592671476339;6270.623762574261;4844.927326090041;4911.140550403665;4932.679375840559;5002.849914502571;5031.4213865405945;4463.152001119777;4505.549445055468;4545.159145558082;4564.543545645475;4609.193391156534;6019.398060193946;6021.2473440819895;6021.668808215502;6022.759089636453;6037.909431358533;6243.094751261042;6249.125122482856;6255.43701066897;6264.561480696308;6283.434490895841;5776.364599894008;5807.070868660994;5868.589198756132;5871.647701137946;5969.015112506388;5492.642978206404;5500.257465242221;5501.862453438696;5508;5508.008558459435;6384.042393640898;6388.840278993062;6394.296627371078;6398.264199617103;6410.0705397718;6141.539384546088;6227.501799856092;6234.0337247726675;6241.656708881055;6262.68686565679;6314.652694101868;6327.335629758809;6370.617762934239;6406.23125224976;6423.42189202974;6261.718222680081;6265.655388953652;6271.404216599416;6285.308616052322;6295.653739044214;6144.525313924715;6156.29202641702;6172.9074063889975;6199.721012554536;6221.720022598904;6120.17287048654;6124.3809352984035;6143.481172719164;6187.195664563758;6258.593191442542;5709.486146246858;5805.854853628524;6248.062790581449;6256.7810126645345;6284.183056202664;6053.213082299273;6101.450869421773;6113.786017489367;6122.755089796358;6133.9079913802225;6092.603980741238;6139.815805525842;6149.2313460817395;6156.230471191101;6184.845378865564;6153.323134455296;6166;6167.352427995175;6173.629582225081;6189.81430557084 03:30:11 INFO - PROCESS | 1657 | |1;ext.html;465.62517173675195;472.51095116554376;525.8737902903305;534.0067474497434;553.4797290546883;29996;39939.60060399395;41325.79337103314;41340;43572.128557428834;42044;42232;42370.57629423705;42371.788141059325;42457.93855153623;9745.025497450251;9942.10521053105;9944.353617014907;9948.452835094067;9983.800323993515;9746.31775775696;9866.210703143766;9868.60525578976;9871.506424678773;9897.208223342115;9707.223422126213;9793.118619324296;9854.408735475894;9862.161716254092;9874.420092785156;9792;9840.507974601242;9843.60625574976;9858.359206651545;9864.60541578336;9655.90344096557;9745.658901938468;9750.073742994475;9750.756231094208;9754;40845;41083.38374924379;41168.58831411677;41173;41240.38139427911;3054.770892183073;3406;3435.8282085895607;3450.1374656335915;3740.682042026431;29301.853490732625;30250.84874575635;30701;31982.840085799653;32074;3154.5741324921073;3182.7931184472936;3277.3117645294515;3336.566246387954;3405.080628230389;505137;514005;517821.4108929469;518979;519531;33386.49920251198;48959.51040489621;58321.12518312228;58538.7073064632;58584.53538661567;33807.478663460206;35224;35240.471392929125;35244;35299;14638.926805365905;14740.894432917574;14762.63093422673;14775.113493190443;14778.334974926154;12827.230366178059;12917.870821291855;12931.676708082374;12952.935235323952;12964.935175324063;7707.11368192665;7748.380129589619;7788.493747906368;7845.137034926153;7902.723404680809;2870.669872964594;3252.349530093991;3272.181954511372;3280.5858759203893;3307.355065762153;944.6882528765491;957.5978089202551;962.6871266838166;994.8955359687274;1042.0257059649252;25399.873000634878;29536.261593459905;29800.701992979793;30183.396332073673;30581.23546911345;884.9469031858109;923.607466826596;1053.6364954090827;1069.7967386196597;1096.5778175402368;14954.252287385587;15384.692306153815;15428.691426171414;15665.530034098996;15682.215889205494;669078.6546067238;711342;712136;713998;715116;49305;56926.715366423734;57488.99999999916;57688.71155644195;57724.55688607734;1164.8369228308043;1265.2661456355293;1379.4895888521312;1404.8665376789188;1408.5985494134122;30066.549001764553;31025.68974310228;32008.199795005312;32098.358032838747;32447.837760811046;56258.156127658935;57140.1428978574;57151;57261.42738572561;57262.14106788485;641794;649082;650647;863495;889904;41680.37479437872;42205.94485137773;42456.575434245264;42553;42645.93385165271;37336.81331593324;45991.3101303474;47398.05203895834;47398.763006184745;48107;38516;39117.80441097776;39427.86007965051;39772.80113599414;40876.79561602292;38448.80775596104;38465.03837404087;38600.42112808539;39057.609423906535;39803.2039359217;33846.492302614985;38127.80936095302;38813.805930970164;39020.414693780185;39022.804885976526;32664;34166.81657372445;34325.485117722754;34801.47797782985;35006.299874002885;21957.780422195574;25470.74529254684;25663.615045774703;25751.96992120294;26212.868935655963 03:30:11 INFO - PROCESS | 1657 | |2;jquery.html;333.4647890136331;351.35701665951314;365.5430711610487;375.1296990980924;396.9305371559976;15132;15315;16028.67942641148;20440.97795110242;20895.268665596708;16222.675546489063;20298.492537686565;20892;20947;21182.94085295733;5724.112762521816;6033.125196846455;6047.334793172748;6050.636961782285;6057.606255593372;4175.060611362434;4388.86833394997;4391.824327026915;5938.168656388109;6009.369016253296;4291.206126866524;6360.586561873463;6661;6680.76617318394;6772.559783614074;5906.822795316148;6163.599366041193;6509.772157974448;6555.541112122153;6751.5273930824615;5699.487046165865;5702.971485142589;5707.1724599933195;5707.34365547959;5711.086226203787;26023.609645855326;26391.492808183193;26513.204603861723;26597.93608255687;26910.865445672647;2323.361075704178;2348.412896775806;2881.4525240204293;3099.767517436201;3181.0933883843227;15172.696546069128;15726.685466290724;15941.282642281125;16136.35454581827;16236.269367878474;1644.7861777968908;1843.5759775251634;1884.3404808317116;1905.8674127428314;1995.3614843250166;117364.41317793442;118186.81813181844;118228;118479;118941.40529297298;10418.60372114418;10766.94616526928;10891.183161262938;10987.285826421417;11105.222634415513;13353.933230333787;13403;13414.262215578041;13423.26172060546;13426.530071447452;8438.873416898628;8748.168923952215;8778.517181554947;8843.248323892412;8860.734177974671;7425.257474252531;8760.299176065899;8876.068012858686;8915.37592368528;9053.094690531027;6341.112244285804;6381.3937675920715;6476.190476190476;6476.287608363076;6631;1422.9146251224959;1573.8111426628877;1786.2676302716084;1848.8983105929303;1850.4541160357458;682.4301708073715;881.8192270584515;891.8350105230553;913.0869130869131;940.1820416237916;17110.743338849927;22161.548119656556;22347.888260558917;22379.77620223777;22415.103395863982;933.3793027636546;960.7598100474881;978.3877048281106;987.9012098790064;1003.117256813999;11081.667549973352;11528.538858445569;11852.585159519547;11868.940655296668;11919.761604767857;532630;643781;651539;662032;669091;70662.64668676624;73545;85676.14323856807;106476.46761766142;111767.32349014771;894.2622336572224;972.3096601412934;1009.6920439265947;1012.8379459286479;1013.8175128476797;18641.90679046596;19082.04589770534;19252.4224273272;19263.036848157255;19265.036748162256;51170.74414627903;52566.211506826665;55129.17306240329;56295.71852140713;59300.40699592949;77523.2247677516;79407.0296485185;79783;80726;83257.17199795957;7887.369010479262;7939.761807145795;8075.3135983439715;8169.836603268021;8265.297449716842;12067.879321206676;12576.937115314366;12700.301483418501;13032.609021729364;13136.211827290394;7598.8100297493;11032.503537340679;11072.391018493738;11182.66452006441;11195.384253866116;10961.232713710282;11008.064314533034;11116.777664446505;11406;11494.770104597694;11401.315921044765;11518.654440366467;11751.353675547927;11822.290662560274;11861.76276474483;7986.720464783704;7991.440599158235;8081.15147909461;8290.46112002718;8431.620577073923;8320.41757077023;10863.402512861869;11080.944595276973;11308.307052573418;11383.146264030065 03:30:11 INFO - PROCESS | 1657 | |3;mootools.html;1523.0633160606228;1530.0972426268502;1729.1613567419806;1832.3311991123244;1885.2270569066686;8648.654053837847;9223.631054757818;9232.953835230832;9237.953810230947;9243.214326782223;8057.637406316715;8279.875801862976;8283.83432331353;8434.367422443325;8971.05803890592;2174.1520806885287;2210.8341874359407;2351.7648235176516;2437.0373702387546;2441.9633705494343;2381.57131716291;2382.8570285782907;2384.1059602649007;2384.403899025244;2384.511175209078;2366.538524987628;2425.7938075263537;2427.5023620157913;2429.392651837041;2431.4772323950347;2411.2163546847255;2423.660687503751;2438.7683170098812;2441.0967941861445;2445.1808644104244;2396.029608008759;2408.590539608271;2421.0799896039393;2425.8301918865686;2427.4416884116754;9046.909530904739;9126.863097053549;9166;9173.678921237724;9178.770530736718;4648.442186937556;5328;5508.7521061552325;5515.641483303612;5579.46995035471;3458.291050334675;3553.200529880782;3607.2424790793966;3619.239959608485;3621.022323972539;1048.910842578374;1099.4008265495324;1107.4850194659523;1788.1863751992812;1830.00264855654;11972.401379931056;11977.101717371232;12075.879241207564;12091.516339346503;12115.878841211652;4529.139463501924;4666.95333046672;4753.6910100844025;4763.809447622057;4792.137415265216;9367.484788336571;9376.765580860532;9380.765480862896;9396.624135034659;9415.482148481899;5387.084195686664;5389.541888939484;5391.137418013099;5392.757325920343;5393.892122157535;4844.927326090112;4979.825706100269;5004.274380214849;5033.7734801934;5054;3644.453332000221;3767.4348847672522;3777.01797532638;3858.3826587745825;3989.8628890765995;1179.5930404010603;1179.728662407634;1190.1074194354235;1193.7970545007197;1199.7180662544295;757.8484303139394;887.5917078144126;908.3184679827635;915.7939463620633;925.564984457304;5980.73086711099;5999.1901093351835;6102.084687296852;6121.204243448323;6305.747770089237;883.4831623500324;885.1325700813239;892.7143314139413;904.2675432899241;919.9080091990747;3820.8853734388013;3989.4813674222746;4000.8399664013696;4131.277026520347;4140.4617399737845;10817.56729730802;11334.149938754626;11341.773164536664;11381.374024428736;11381.487833047533;11275.661730147945;11285.153613479022;11286.717832054264;11287.04060154896;11303.491342889589;8290.917090829134;8425.915740842636;8448.366372521963;8465.32277417805;8466.280366168821;5974.193483879794;5984.8803023940145;6088.51291896656;6140.109684095871;6284.497240220863;9983.351082179926;10218.540165692413;10410.219233557666;10452.32059916103;10452.372857628567;9956.303058786105;10302.845457317997;10528.631497897537;10589.205809564159;10653.147748180281;7713.2286771322415;7873.133955265031;7875;7880.645370958436;7899.881501777593;7729.149793522595;7995.000624921885;8001.959990200012;8331.50010999342;8533.914660853312;7592.506487078323;7608;7679.577623230776;7688.961555192188;7862.33170180541;7536.773896783106;7581.658825352983;7583.5070720403;7585;7623.809404764926;7029.19164296092;7034.155901291878;7094.9290507094265;7103.041089452858;7108.466864985044;5044.319016932667;5109.284700142058;5112.718800465861;5157.638965272395;5161.716105614228;4977.0792403405485;5001.449840517613;5130.230465430215;5165.586753059822;5267.183586544092 03:30:11 INFO - PROCESS | 1657 | |4;prototype.html;304.6831295452729;308.58957586410077;313.3029010451745;313.43737990307386;317.8760283489441;4850.320955066293;5288.576913846892;5300.284461597688;5317.813876514313;5347.572194224463;5213.715359323621;5236.554892834114;5245.396779370373;5262.526372626463;5278.630495865291;3386.7121294689982;3479.7042251408534;3838.4242363645467;3992.381180916948;4037.8586749463775;3201.375731732313;4002.5196976362877;4016.1365306459106;4110.917781644365;4119.3409054551275;3988.6210809973004;4002.859899903504;4013.571789067616;4027.758334499925;4043.1603620352817;3106.891258805931;3303.3723592517345;3750.587435382106;4031.7220770264707;4034.677225821927;3487.128217945514;3503.9649603503894;3507.877224297137;3511.4908338290807;3564.8395822188063;4599.83900563482;4997.550220480138;5160.722940932497;5203.427622961472;5206.552920127572;4507.481639611421;4656.3946686930485;4661.627069834405;4681.157391669498;4695.520910913051;4416.55834416559;4993.076280888047;5506.834794956158;5516.117421212627;5517.475839795213;3438.535797667308;3777.660010599032;3871.1483473636035;3890.3191941410423;3892.455056292093;5095.1847704367865;5569.32672317286;5625.380599175415;5856.2138547742925;5873.125305996013;3763.8682646107254;3915.451836742858;3948.309045916953;3956.3274243378696;3969.583193764613;3529.8235088245483;3997.8400863965117;4003.3394489908837;4009.9373665978537;4019.7588144711412;3865.845366185321;4298.828046878152;4617.607503362185;4646;4648.279516674921;4994.926090890403;5265.289185959923;5425.457454254622;5453.345598528202;5566.55467562594;1333.759923213831;1364.7512526038563;1368.8083668286447;1372.9519466818813;1375.938082786277;800.7077416742964;801.7412662120415;806.9832011665227;832.646125396704;860.2386887604515;4126.938095928564;4325.221460137205;4761.309610106585;5102.107131252016;5261.342332208474;4836.322914791932;5716;5743.10981797822;5773.90053062322;5776.104703770922;4862.246351815475;4898.436679781799;4931.852044438672;5225.790968361299;5228.398734145546;2580.8838602262945;2764.9861750691116;2950.778691598096;2967.5103607904884;3010.5850250382287;4685.531446855287;5156.550638446708;5497.367802702661;5848.90008295604;5879.559033072536;5247.501487358695;5408.78364865401;5542.505872357456;5661.66030038199;5810.128480727924;5389.033002953815;5795.478406943395;5844.26946631671;5859.677717725481;5875.676837773878;4743.83396581118;5565.99624135319;5689.2319536862;5752.539796816161;5778.36437991829;4569.040501494724;5278.841634750964;5554.97222513901;5606.934682410329;5783.315514433322;5689.630174038674;5708.143778433268;5841.415858414124;5852.970735146297;5889.587728858939;3306.5205545196295;3474.7046501047694;3914.2758589661003;3935.1736135411884;3980.3631418972827;4921.63087768426;5006.974965125151;5170.457102004386;5804.912926306193;5836;4953.702777833341;5155.252488389237;5620.285812827127;5632.32412110533;5658.773649053992;4588.439930423672;5353.2773075634295;5557;5632.633878797865;5681.4034526374135;5521.282233309644;5524.530414914617;5541.556675465872;5543.445655434424;5602.243697101002;4749.572538471554;5452.236686863922;5472.616916815785;5487.6158668892795;5557.499825015768;5464.371597266207;5475.890482190413;5496.780128794803;5497.835064948058;5504.972475137599 03:30:11 INFO - PROCESS | 1657 | |5;yui.html;696.8327601375668;698.3575110897973;726.2700985509562;741.9258074192578;753.9811504712383;15317.310721017553;15934.362625494996;15969.520914372559;15969.520914372573;15981.360745570179;14390.424383024667;14591.489297874576;14595.927020364883;14611.707765844703;14618.12291262525;674.0159367323713;694.9409300209488;698.2877464985711;698.4238003646986;824.0523398092212;688.8174633722068;692.0864458914235;829.5147338806805;852.526847599582;860.3805260212637;896.0501868019887;908.2461556907783;910.713125365511;912.1471424218344;915.7207051849183;900.9234215091725;901.7475106970059;903.3405613901889;903.3947255338938;904.868794024866;518.4582111693289;535.7026850098194;539.4335947255366;669.0599707411095;669.3473862983552;12358.382080895919;12403.627891163189;14140.505082322172;14659.04716193444;14675.486357977526;13835.377408016664;14366.640833979129;14448.060876043128;14523.419063237458;14577.271136443136;11314.717132071682;11670.299782013022;11683.474243659055;11799.233049851731;11930.940345298304;3726.5900750917376;3804.8668296609762;3817.6564109230026;3874.4769456123627;3898.2788184185733;100219.49890250502;101089.49455252677;102439.48780256126;102743;105213.94786052195;9950.303478756417;10110.797784044278;10168.28821982469;10220.540075696612;10220.824605170352;21337.25319613806;21382.572348553254;21496.78503214979;21513.462163445725;21713.78286217149;7771.844563108706;7820.882686759704;7829.882551761728;7831.373490120776;7913.406494512819;3704.68510176638;4294.699371044059;4452.1763473757455;4459.866204013885;4502.099580083996;2926.9853650732034;3434.227298857737;3437.5359326491102;3440.088376580208;3453.067671728619;685.7702669605738;686.6257889450262;686.989695154573;689.6344937183301;695.0963747128712;613.6379536073649;613.9754409823646;623.5728525959732;637.6078711592337;671.664167916042;8767.298616110696;9343.159115679622;9436.52817359143;9515.857262141073;9568;591.222542356808;614.4746241963146;625.433982246068;629.8425393651587;677.8508728079913;3535.3106144301614;4483.484399294123;4619.491855895849;4653.139169253699;4688.929666055012;135765;135838.32080839731;136448.7196152351;137869;139551;139828.30085849506;146584.26707866392;149203;152557.47442525433;153770;115705;123876.76123238832;125580.37209813892;126353;126552.36723816322;8781.91218087811;8829.205371516595;8871.733847984571;8906.688265910661;8922.152395522675;62633.68683156555;64326.35673643203;65403.67298163479;66137;67623.66188169028;83660;94055;94471;96137;102503;12646.620601381974;12786.041046921704;12825.486980521047;13621.25083120438;13727.313634318045;14526.85473145255;14624.34190461453;15744.60638484047;15761.369545218522;15877.2061396932;13039.348032598522;13369;13491.05562610608;14038.1577105374;14082.436702531784;11970.76058478808;13732.244726539737;13733.381997810322;14124.646883827576;14583.85416145825;12370.505179792708;12830.87169128334;13606.251656159006;13965;14287.64011283937;10792.952642758966;10946.945265273622;11237.71905702364;11535.110301397835;11929.224600400947;10879.673609791718;10910.563577456813;11533;11560.768784624091;11847.822282665595 03:30:11 INFO - PROCESS | 1657 | __end_tp_report 03:30:11 INFO - PROCESS | 1657 | __start_cc_report 03:30:11 INFO - PROCESS | 1657 | _x_x_mozilla_cycle_collect,1496 03:30:11 INFO - PROCESS | 1657 | __end_cc_report 03:30:11 INFO - PROCESS | 1657 | __startTimestamp1476873011325__endTimestamp 03:30:11 INFO - PROCESS | 1657 | 03:30:11 INFO - PROCESS | 1657 | ------- Summary: start ------- 03:30:11 INFO - PROCESS | 1657 | Number of tests: 6 03:30:11 INFO - PROCESS | 1657 | 03:30:11 INFO - PROCESS | 1657 | [#0] dojo.html Cycles:165 Average:5804.11 Median:6122.76 stddev:654.30 (10.7%) stddev-sans-first:627.71 03:30:11 INFO - PROCESS | 1657 | Values: 3365.2 3394.9 3408.1 3416.6 3461.1 5929.2 5960.1 5972.9 5981.0 6012.9 5473.5 5803.2 5864.9 5879.5 5897.0 4734.8 5236.3 5266.6 5276.8 5289.6 4401.0 5160.3 5240.0 5331.9 5348.9 4868.6 5318.7 5320.5 5328.0 5335.7 5314.9 5333.1 5381.2 5381.5 5389.2 5176.0 5247.9 5325.1 5335.9 5336.9 4786.8 4857.2 5769.9 5771.4 5774.6 6197.6 6208.3 6231.3 6255.9 6258.4 6168.2 6208.7 6229.2 6232.8 6234.7 5769.3 5841.7 5854.1 5895.2 5940.0 6205.0 6303.8 6312.7 6315.8 6318.3 6275.9 6290.2 6293.9 6293.9 6299.9 6140.9 6185.8 6260.9 6268.7 6290.0 6223.4 6253.8 6259.0 6296.0 6303.2 6222.7 6234.1 6239.1 6266.6 6270.6 4844.9 4911.1 4932.7 5002.8 5031.4 4463.2 4505.5 4545.2 4564.5 4609.2 6019.4 6021.2 6021.7 6022.8 6037.9 6243.1 6249.1 6255.4 6264.6 6283.4 5776.4 5807.1 5868.6 5871.6 5969.0 5492.6 5500.3 5501.9 5508.0 5508.0 6384.0 6388.8 6394.3 6398.3 6410.1 6141.5 6227.5 6234.0 6241.7 6262.7 6314.7 6327.3 6370.6 6406.2 6423.4 6261.7 6265.7 6271.4 6285.3 6295.7 6144.5 6156.3 6172.9 6199.7 6221.7 6120.2 6124.4 6143.5 6187.2 6258.6 5709.5 5805.9 6248.1 6256.8 6284.2 6053.2 6101.5 6113.8 6122.8 6133.9 6092.6 6139.8 6149.2 6156.2 6184.8 6153.3 6166.0 6167.4 6173.6 6189.8 03:30:11 INFO - PROCESS | 1657 | 03:30:11 INFO - PROCESS | 1657 | [#1] ext.html Cycles:180 Average:76349.44 Median:41170.79 stddev:178469.00 (433.5%) stddev-sans-first:178878.70 03:30:11 INFO - PROCESS | 1657 | Values: 465.6 472.5 525.9 534.0 553.5 29996.0 39939.6 41325.8 41340.0 43572.1 42044.0 42232.0 42370.6 42371.8 42457.9 9745.0 9942.1 9944.4 9948.5 9983.8 9746.3 9866.2 9868.6 9871.5 9897.2 9707.2 9793.1 9854.4 9862.2 9874.4 9792.0 9840.5 9843.6 9858.4 9864.6 9655.9 9745.7 9750.1 9750.8 9754.0 40845.0 41083.4 41168.6 41173.0 41240.4 3054.8 3406.0 3435.8 3450.1 3740.7 29301.9 30250.8 30701.0 31982.8 32074.0 3154.6 3182.8 3277.3 3336.6 3405.1 505137.0 514005.0 517821.4 518979.0 519531.0 33386.5 48959.5 58321.1 58538.7 58584.5 33807.5 35224.0 35240.5 35244.0 35299.0 14638.9 14740.9 14762.6 14775.1 14778.3 12827.2 12917.9 12931.7 12952.9 12964.9 7707.1 7748.4 7788.5 7845.1 7902.7 2870.7 3252.3 3272.2 3280.6 3307.4 944.7 957.6 962.7 994.9 1042.0 25399.9 29536.3 29800.7 30183.4 30581.2 884.9 923.6 1053.6 1069.8 1096.6 14954.3 15384.7 15428.7 15665.5 15682.2 669078.7 711342.0 712136.0 713998.0 715116.0 49305.0 56926.7 57489.0 57688.7 57724.6 1164.8 1265.3 1379.5 1404.9 1408.6 30066.5 31025.7 32008.2 32098.4 32447.8 56258.2 57140.1 57151.0 57261.4 57262.1 641794.0 649082.0 650647.0 863495.0 889904.0 41680.4 42205.9 42456.6 42553.0 42645.9 37336.8 45991.3 47398.1 47398.8 48107.0 38516.0 39117.8 39427.9 39772.8 40876.8 38448.8 38465.0 38600.4 39057.6 39803.2 33846.5 38127.8 38813.8 39020.4 39022.8 32664.0 34166.8 34325.5 34801.5 35006.3 21957.8 25470.7 25663.6 25752.0 26212.9 03:30:11 INFO - PROCESS | 1657 | 03:30:11 INFO - PROCESS | 1657 | [#2] jquery.html Cycles:180 Average:35169.06 Median:14896.16 stddev:104777.49 (703.4%) stddev-sans-first:105038.76 03:30:11 INFO - PROCESS | 1657 | Values: 333.5 351.4 365.5 375.1 396.9 15132.0 15315.0 16028.7 20441.0 20895.3 16222.7 20298.5 20892.0 20947.0 21182.9 5724.1 6033.1 6047.3 6050.6 6057.6 4175.1 4388.9 4391.8 5938.2 6009.4 4291.2 6360.6 6661.0 6680.8 6772.6 5906.8 6163.6 6509.8 6555.5 6751.5 5699.5 5703.0 5707.2 5707.3 5711.1 26023.6 26391.5 26513.2 26597.9 26910.9 2323.4 2348.4 2881.5 3099.8 3181.1 15172.7 15726.7 15941.3 16136.4 16236.3 1644.8 1843.6 1884.3 1905.9 1995.4 117364.4 118186.8 118228.0 118479.0 118941.4 10418.6 10766.9 10891.2 10987.3 11105.2 13353.9 13403.0 13414.3 13423.3 13426.5 8438.9 8748.2 8778.5 8843.2 8860.7 7425.3 8760.3 8876.1 8915.4 9053.1 6341.1 6381.4 6476.2 6476.3 6631.0 1422.9 1573.8 1786.3 1848.9 1850.5 682.4 881.8 891.8 913.1 940.2 17110.7 22161.5 22347.9 22379.8 22415.1 933.4 960.8 978.4 987.9 1003.1 11081.7 11528.5 11852.6 11868.9 11919.8 532630.0 643781.0 651539.0 662032.0 669091.0 70662.6 73545.0 85676.1 106476.5 111767.3 894.3 972.3 1009.7 1012.8 1013.8 18641.9 19082.0 19252.4 19263.0 19265.0 51170.7 52566.2 55129.2 56295.7 59300.4 77523.2 79407.0 79783.0 80726.0 83257.2 7887.4 7939.8 8075.3 8169.8 8265.3 12067.9 12576.9 12700.3 13032.6 13136.2 7598.8 11032.5 11072.4 11182.7 11195.4 10961.2 11008.1 11116.8 11406.0 11494.8 11401.3 11518.7 11751.4 11822.3 11861.8 7986.7 7991.4 8081.2 8290.5 8431.6 8320.4 10863.4 11080.9 11308.3 11383.1 03:30:11 INFO - PROCESS | 1657 | 03:30:11 INFO - PROCESS | 1657 | [#3] mootools.html Cycles:180 Average:5841.41 Median:5049.16 stddev:3288.22 (65.1%) stddev-sans-first:3281.43 03:30:11 INFO - PROCESS | 1657 | Values: 1523.1 1530.1 1729.2 1832.3 1885.2 8648.7 9223.6 9233.0 9238.0 9243.2 8057.6 8279.9 8283.8 8434.4 8971.1 2174.2 2210.8 2351.8 2437.0 2442.0 2381.6 2382.9 2384.1 2384.4 2384.5 2366.5 2425.8 2427.5 2429.4 2431.5 2411.2 2423.7 2438.8 2441.1 2445.2 2396.0 2408.6 2421.1 2425.8 2427.4 9046.9 9126.9 9166.0 9173.7 9178.8 4648.4 5328.0 5508.8 5515.6 5579.5 3458.3 3553.2 3607.2 3619.2 3621.0 1048.9 1099.4 1107.5 1788.2 1830.0 11972.4 11977.1 12075.9 12091.5 12115.9 4529.1 4667.0 4753.7 4763.8 4792.1 9367.5 9376.8 9380.8 9396.6 9415.5 5387.1 5389.5 5391.1 5392.8 5393.9 4844.9 4979.8 5004.3 5033.8 5054.0 3644.5 3767.4 3777.0 3858.4 3989.9 1179.6 1179.7 1190.1 1193.8 1199.7 757.8 887.6 908.3 915.8 925.6 5980.7 5999.2 6102.1 6121.2 6305.7 883.5 885.1 892.7 904.3 919.9 3820.9 3989.5 4000.8 4131.3 4140.5 10817.6 11334.1 11341.8 11381.4 11381.5 11275.7 11285.2 11286.7 11287.0 11303.5 8290.9 8425.9 8448.4 8465.3 8466.3 5974.2 5984.9 6088.5 6140.1 6284.5 9983.4 10218.5 10410.2 10452.3 10452.4 9956.3 10302.8 10528.6 10589.2 10653.1 7713.2 7873.1 7875.0 7880.6 7899.9 7729.1 7995.0 8002.0 8331.5 8533.9 7592.5 7608.0 7679.6 7689.0 7862.3 7536.8 7581.7 7583.5 7585.0 7623.8 7029.2 7034.2 7094.9 7103.0 7108.5 5044.3 5109.3 5112.7 5157.6 5161.7 4977.1 5001.4 5130.2 5165.6 5267.2 03:30:11 INFO - PROCESS | 1657 | 03:30:11 INFO - PROCESS | 1657 | [#4] prototype.html Cycles:180 Average:4481.75 Median:5051.08 stddev:1378.28 (27.3%) stddev-sans-first:1346.02 03:30:11 INFO - PROCESS | 1657 | Values: 304.7 308.6 313.3 313.4 317.9 4850.3 5288.6 5300.3 5317.8 5347.6 5213.7 5236.6 5245.4 5262.5 5278.6 3386.7 3479.7 3838.4 3992.4 4037.9 3201.4 4002.5 4016.1 4110.9 4119.3 3988.6 4002.9 4013.6 4027.8 4043.2 3106.9 3303.4 3750.6 4031.7 4034.7 3487.1 3504.0 3507.9 3511.5 3564.8 4599.8 4997.6 5160.7 5203.4 5206.6 4507.5 4656.4 4661.6 4681.2 4695.5 4416.6 4993.1 5506.8 5516.1 5517.5 3438.5 3777.7 3871.1 3890.3 3892.5 5095.2 5569.3 5625.4 5856.2 5873.1 3763.9 3915.5 3948.3 3956.3 3969.6 3529.8 3997.8 4003.3 4009.9 4019.8 3865.8 4298.8 4617.6 4646.0 4648.3 4994.9 5265.3 5425.5 5453.3 5566.6 1333.8 1364.8 1368.8 1373.0 1375.9 800.7 801.7 807.0 832.6 860.2 4126.9 4325.2 4761.3 5102.1 5261.3 4836.3 5716.0 5743.1 5773.9 5776.1 4862.2 4898.4 4931.9 5225.8 5228.4 2580.9 2765.0 2950.8 2967.5 3010.6 4685.5 5156.6 5497.4 5848.9 5879.6 5247.5 5408.8 5542.5 5661.7 5810.1 5389.0 5795.5 5844.3 5859.7 5875.7 4743.8 5566.0 5689.2 5752.5 5778.4 4569.0 5278.8 5555.0 5606.9 5783.3 5689.6 5708.1 5841.4 5853.0 5889.6 3306.5 3474.7 3914.3 3935.2 3980.4 4921.6 5007.0 5170.5 5804.9 5836.0 4953.7 5155.3 5620.3 5632.3 5658.8 4588.4 5353.3 5557.0 5632.6 5681.4 5521.3 5524.5 5541.6 5543.4 5602.2 4749.6 5452.2 5472.6 5487.6 5557.5 5464.4 5475.9 5496.8 5497.8 5505.0 03:30:11 INFO - PROCESS | 1657 | 03:30:11 INFO - PROCESS | 1657 | [#5] yui.html Cycles:180 Average:25351.89 Median:3180.61 stddev:40838.23 (1284.0%) stddev-sans-first:40910.84 03:30:11 INFO - PROCESS | 1657 | Values: 696.8 698.4 726.3 741.9 754.0 15317.3 15934.4 15969.5 15969.5 15981.4 14390.4 14591.5 14595.9 14611.7 14618.1 674.0 694.9 698.3 698.4 824.1 688.8 692.1 829.5 852.5 860.4 896.1 908.2 910.7 912.1 915.7 900.9 901.7 903.3 903.4 904.9 518.5 535.7 539.4 669.1 669.3 12358.4 12403.6 14140.5 14659.0 14675.5 13835.4 14366.6 14448.1 14523.4 14577.3 11314.7 11670.3 11683.5 11799.2 11930.9 3726.6 3804.9 3817.7 3874.5 3898.3 100219.5 101089.5 102439.5 102743.0 105213.9 9950.3 10110.8 10168.3 10220.5 10220.8 21337.3 21382.6 21496.8 21513.5 21713.8 7771.8 7820.9 7829.9 7831.4 7913.4 3704.7 4294.7 4452.2 4459.9 4502.1 2927.0 3434.2 3437.5 3440.1 3453.1 685.8 686.6 687.0 689.6 695.1 613.6 614.0 623.6 637.6 671.7 8767.3 9343.2 9436.5 9515.9 9568.0 591.2 614.5 625.4 629.8 677.9 3535.3 4483.5 4619.5 4653.1 4688.9 135765.0 135838.3 136448.7 137869.0 139551.0 139828.3 146584.3 149203.0 152557.5 153770.0 115705.0 123876.8 125580.4 126353.0 126552.4 8781.9 8829.2 8871.7 8906.7 8922.2 62633.7 64326.4 65403.7 66137.0 67623.7 83660.0 94055.0 94471.0 96137.0 102503.0 12646.6 12786.0 12825.5 13621.3 13727.3 14526.9 14624.3 15744.6 15761.4 15877.2 13039.3 13369.0 13491.1 14038.2 14082.4 11970.8 13732.2 13733.4 14124.6 14583.9 12370.5 12830.9 13606.3 13965.0 14287.6 10793.0 10946.9 11237.7 11535.1 11929.2 10879.7 10910.6 11533.0 11560.8 11847.8 03:30:11 INFO - PROCESS | 1657 | -------- Summary: end -------- 03:30:11 INFO - PROCESS | 1657 | 03:30:11 INFO - TEST-INFO | 1657: exit 0 03:30:11 INFO - TEST-OK | dromaeo_css | took 1117865ms 03:30:11 INFO - TEST-START | kraken 03:30:11 INFO - operating with platform_type : mac_ 03:30:11 INFO - Initialising browser for kraken test... 03:30:11 INFO - TEST-INFO | started process 1663 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/tmpqpOWww/profile http://localhost:49278/getInfo.html) 03:30:14 INFO - PROCESS | 1663 | __metrics Screen width/height:1600/1200 03:30:14 INFO - PROCESS | 1663 | colorDepth:24 03:30:14 INFO - PROCESS | 1663 | Browser inner width/height: 1024/689 03:30:14 INFO - PROCESS | 1663 | __metrics 03:30:14 INFO - PROCESS | 1663 | 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" 03:30:14 INFO - PROCESS | 1663 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 03:30:15 INFO - TEST-INFO | 1663: exit 0 03:30:15 INFO - Browser initialized. 03:30:15 INFO - Running cycle 1/1 for kraken test... 03:30:15 INFO - TEST-INFO | started process 1665 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/tmpqpOWww/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:30:27 INFO - PROCESS | 1665 | RSS: Main: 219250688 03:30:27 INFO - PROCESS | 1665 | 03:30:29 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49278/tests/kraken/driver.html?testName=audio-beat-detection) 03:30:30 INFO - PROCESS | 1665 | RSS: Main: 269443072 03:30:30 INFO - PROCESS | 1665 | 03:30:33 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49278/tests/kraken/driver.html?testName=audio-dft) 03:30:33 INFO - PROCESS | 1665 | RSS: Main: 279851008 03:30:33 INFO - PROCESS | 1665 | 03:30:36 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49278/tests/kraken/driver.html?testName=audio-fft) 03:30:37 INFO - PROCESS | 1665 | RSS: Main: 378322944 03:30:37 INFO - PROCESS | 1665 | 03:30:39 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49278/tests/kraken/driver.html?testName=audio-oscillator) 03:30:40 INFO - PROCESS | 1665 | RSS: Main: 279015424 03:30:40 INFO - PROCESS | 1665 | 03:30:42 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49278/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:30:42 INFO - PROCESS | 1665 | RSS: Main: 281026560 03:30:42 INFO - PROCESS | 1665 | 03:30:45 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49278/tests/kraken/driver.html?testName=imaging-darkroom) 03:30:46 INFO - PROCESS | 1665 | RSS: Main: 316198912 03:30:46 INFO - PROCESS | 1665 | 03:30:49 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49278/tests/kraken/driver.html?testName=imaging-desaturate) 03:30:49 INFO - PROCESS | 1665 | RSS: Main: 318214144 03:30:49 INFO - PROCESS | 1665 | 03:30:52 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49278/tests/kraken/driver.html?testName=json-parse-financial) 03:30:53 INFO - PROCESS | 1665 | RSS: Main: 316628992 03:30:53 INFO - PROCESS | 1665 | 03:30:54 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49278/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:30:55 INFO - PROCESS | 1665 | RSS: Main: 289914880 03:30:55 INFO - PROCESS | 1665 | 03:30:56 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:30:57 INFO - PROCESS | 1665 | RSS: Main: 293330944 03:30:57 INFO - PROCESS | 1665 | 03:30:59 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:31:00 INFO - PROCESS | 1665 | RSS: Main: 297422848 03:31:00 INFO - PROCESS | 1665 | 03:31:03 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:31:04 INFO - PROCESS | 1665 | RSS: Main: 308781056 03:31:04 INFO - PROCESS | 1665 | 03:31:06 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:31:07 INFO - PROCESS | 1665 | RSS: Main: 308912128 03:31:07 INFO - PROCESS | 1665 | 03:31:09 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49278/tests/kraken/driver.html?testName=ai-astar) 03:31:09 INFO - PROCESS | 1665 | RSS: Main: 352804864 03:31:09 INFO - PROCESS | 1665 | 03:31:09 INFO - PROCESS | 1665 | __start_tp_report 03:31:09 INFO - PROCESS | 1665 | _x_x_mozilla_page_load 03:31:09 INFO - PROCESS | 1665 | _x_x_mozilla_page_load_details 03:31:09 INFO - PROCESS | 1665 | |i|pagename|runs| 03:31:09 INFO - PROCESS | 1665 | |0;ai-astar;115;115;115;115;114;114;114;114;114;114 03:31:09 INFO - PROCESS | 1665 | |1;audio-beat-detection;149;133;136;142;110;109;109;108;138;110 03:31:09 INFO - PROCESS | 1665 | |2;audio-dft;185;185;183;185;183;179;182;184;185;183 03:31:09 INFO - PROCESS | 1665 | |3;audio-fft;80;59;60;89;61;61;59;58;82;57 03:31:09 INFO - PROCESS | 1665 | |4;audio-oscillator;85;70;93;68;67;68;92;69;67;88 03:31:09 INFO - PROCESS | 1665 | |5;imaging-gaussian-blur;118;130;88;85;88;84;88;84;87;85 03:31:09 INFO - PROCESS | 1665 | |6;imaging-darkroom;94;96;93;94;93;94;95;93;93;94 03:31:09 INFO - PROCESS | 1665 | |7;imaging-desaturate;85;86;86;87;85;86;86;84;87;88 03:31:09 INFO - PROCESS | 1665 | |8;json-parse-financial;56;54;53;54;55;58;57;56;57;57 03:31:09 INFO - PROCESS | 1665 | |9;json-stringify-tinderbox;64;71;68;73;71;67;68;68;69;69 03:31:09 INFO - PROCESS | 1665 | |10;stanford-crypto-aes;81;81;82;82;81;81;84;84;81;83 03:31:09 INFO - PROCESS | 1665 | |11;stanford-crypto-ccm;138;134;143;141;145;143;137;138;197;135 03:31:09 INFO - PROCESS | 1665 | |12;stanford-crypto-pbkdf2;163;179;162;163;167;162;160;165;161;161 03:31:09 INFO - PROCESS | 1665 | |13;stanford-crypto-sha256-iterative;67;66;68;67;67;76;85;84;84;83 03:31:09 INFO - PROCESS | 1665 | __end_tp_report 03:31:09 INFO - PROCESS | 1665 | __start_cc_report 03:31:09 INFO - PROCESS | 1665 | _x_x_mozilla_cycle_collect,1911 03:31:09 INFO - PROCESS | 1665 | __end_cc_report 03:31:09 INFO - PROCESS | 1665 | __startTimestamp1476873069539__endTimestamp 03:31:09 INFO - PROCESS | 1665 | 03:31:09 INFO - PROCESS | 1665 | ------- Summary: start ------- 03:31:09 INFO - PROCESS | 1665 | Number of tests: 14 03:31:09 INFO - PROCESS | 1665 | 03:31:09 INFO - PROCESS | 1665 | [#0] ai-astar Cycles:10 Average:114.40 Median:114.50 stddev:0.52 (0.5%) stddev-sans-first:0.50 03:31:09 INFO - PROCESS | 1665 | Values: 115.0 115.0 115.0 115.0 114.0 114.0 114.0 114.0 114.0 114.0 03:31:09 INFO - PROCESS | 1665 | 03:31:09 INFO - PROCESS | 1665 | [#1] audio-beat-detection Cycles:10 Average:124.40 Median:134.50 stddev:16.55 (12.3%) stddev-sans-first:14.97 03:31:09 INFO - PROCESS | 1665 | Values: 149.0 133.0 136.0 142.0 110.0 109.0 109.0 108.0 138.0 110.0 03:31:09 INFO - PROCESS | 1665 | 03:31:09 INFO - PROCESS | 1665 | [#2] audio-dft Cycles:10 Average:183.40 Median:184.50 stddev:1.90 (1.0%) stddev-sans-first:1.92 03:31:09 INFO - PROCESS | 1665 | Values: 185.0 185.0 183.0 185.0 183.0 179.0 182.0 184.0 185.0 183.0 03:31:09 INFO - PROCESS | 1665 | 03:31:09 INFO - PROCESS | 1665 | [#3] audio-fft Cycles:10 Average:66.60 Median:61.00 stddev:12.05 (19.8%) stddev-sans-first:11.76 03:31:09 INFO - PROCESS | 1665 | Values: 80.0 59.0 60.0 89.0 61.0 61.0 59.0 58.0 82.0 57.0 03:31:09 INFO - PROCESS | 1665 | 03:31:09 INFO - PROCESS | 1665 | [#4] audio-oscillator Cycles:10 Average:76.70 Median:77.50 stddev:11.26 (14.5%) stddev-sans-first:11.53 03:31:09 INFO - PROCESS | 1665 | Values: 85.0 70.0 93.0 68.0 67.0 68.0 92.0 69.0 67.0 88.0 03:31:09 INFO - PROCESS | 1665 | 03:31:09 INFO - PROCESS | 1665 | [#5] imaging-gaussian-blur Cycles:10 Average:93.70 Median:86.00 stddev:16.30 (18.9%) stddev-sans-first:14.72 03:31:09 INFO - PROCESS | 1665 | Values: 118.0 130.0 88.0 85.0 88.0 84.0 88.0 84.0 87.0 85.0 03:31:09 INFO - PROCESS | 1665 | 03:31:09 INFO - PROCESS | 1665 | [#6] imaging-darkroom Cycles:10 Average:93.90 Median:94.00 stddev:0.99 (1.1%) stddev-sans-first:1.05 03:31:09 INFO - PROCESS | 1665 | Values: 94.0 96.0 93.0 94.0 93.0 94.0 95.0 93.0 93.0 94.0 03:31:09 INFO - PROCESS | 1665 | 03:31:09 INFO - PROCESS | 1665 | [#7] imaging-desaturate Cycles:10 Average:86.00 Median:86.00 stddev:1.15 (1.3%) stddev-sans-first:1.17 03:31:09 INFO - PROCESS | 1665 | Values: 85.0 86.0 86.0 87.0 85.0 86.0 86.0 84.0 87.0 88.0 03:31:09 INFO - PROCESS | 1665 | 03:31:09 INFO - PROCESS | 1665 | [#8] json-parse-financial Cycles:10 Average:55.70 Median:56.50 stddev:1.64 (2.9%) stddev-sans-first:1.73 03:31:09 INFO - PROCESS | 1665 | Values: 56.0 54.0 53.0 54.0 55.0 58.0 57.0 56.0 57.0 57.0 03:31:09 INFO - PROCESS | 1665 | 03:31:09 INFO - PROCESS | 1665 | [#9] json-stringify-tinderbox Cycles:10 Average:68.80 Median:69.00 stddev:2.49 (3.6%) stddev-sans-first:1.94 03:31:09 INFO - PROCESS | 1665 | Values: 64.0 71.0 68.0 73.0 71.0 67.0 68.0 68.0 69.0 69.0 03:31:09 INFO - PROCESS | 1665 | 03:31:09 INFO - PROCESS | 1665 | [#10] stanford-crypto-aes Cycles:10 Average:82.00 Median:82.00 stddev:1.25 (1.5%) stddev-sans-first:1.27 03:31:09 INFO - PROCESS | 1665 | Values: 81.0 81.0 82.0 82.0 81.0 81.0 84.0 84.0 81.0 83.0 03:31:09 INFO - PROCESS | 1665 | 03:31:09 INFO - PROCESS | 1665 | [#11] stanford-crypto-ccm Cycles:10 Average:145.10 Median:142.00 stddev:18.59 (13.1%) stddev-sans-first:19.54 03:31:09 INFO - PROCESS | 1665 | Values: 138.0 134.0 143.0 141.0 145.0 143.0 137.0 138.0 197.0 135.0 03:31:09 INFO - PROCESS | 1665 | 03:31:09 INFO - PROCESS | 1665 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:164.30 Median:163.00 stddev:5.56 (3.4%) stddev-sans-first:5.88 03:31:09 INFO - PROCESS | 1665 | Values: 163.0 179.0 162.0 163.0 167.0 162.0 160.0 165.0 161.0 161.0 03:31:09 INFO - PROCESS | 1665 | 03:31:09 INFO - PROCESS | 1665 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:74.70 Median:79.50 stddev:8.49 (10.7%) stddev-sans-first:8.53 03:31:09 INFO - PROCESS | 1665 | Values: 67.0 66.0 68.0 67.0 67.0 76.0 85.0 84.0 84.0 83.0 03:31:09 INFO - PROCESS | 1665 | -------- Summary: end -------- 03:31:09 INFO - PROCESS | 1665 | 03:31:10 INFO - TEST-INFO | 1665: exit 0 03:31:10 INFO - TEST-OK | kraken | took 58462ms 03:31:10 INFO - SUITE-END | took 1176s 03:31:10 INFO - Completed test suite (00:19:36) 03:31:10 INFO - javascript benchmark 03:31:10 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3365.1923538350798, 3394.88117915873, 3408.096854333602, 3416.5900091988965, 3461.117415059161, 5929.169916211728, 5960.105984102376, 5972.910406343897, 5980.970095149529, 6012.939870601293, 5473.507384335399, 5803.158542011406, 5864.941350586493, 5879.52963762899, 5896.970515147418, 4734.834280800173, 5236.31927849379, 5266.631335806476, 5276.7889284428575, 5289.550388217006, 4400.97799511002, 5160.277561141444, 5240.03059434004, 5331.893362132755, 5348.946510534884, 4868.586170175539, 5318.734063296839, 5320.547753440962, 5328.0, 5335.679859208441, 5314.893702125955, 5333.093374126408, 5381.219723140122, 5381.461853814626, 5389.245505629215, 5176.042432150064, 5247.947520524822, 5325.147976323769, 5335.9466405336225, 5336.91994620081, 4786.808527658889, 4857.247126695368, 5769.942300576982, 5771.394003629601, 5774.566907481913, 6197.566170368076, 6208.324210274894, 6231.283402408736, 6255.937440625627, 6258.43674069336, 6168.228971378578, 6208.72060757267, 6229.159063526411, 6232.8130156095385, 6234.657093859836, 5769.336526299529, 5841.678707671119, 5854.092615644582, 5895.174675545427, 5940.0, 6205.0, 6303.779367722108, 6312.684365781693, 6315.842103947438, 6318.304986451487, 6275.874482510324, 6290.21372328459, 6293.905591416133, 6293.905591416133, 6299.937000629935, 6140.907886381708, 6185.8144255672405, 6260.906086408708, 6268.717907694165, 6290.0, 6223.37766223374, 6253.78111766086, 6259.0, 6296.024116261895, 6303.212098487689, 6222.719977601018, 6234.096056071935, 6239.126522286792, 6266.592671476339, 6270.623762574261, 4844.927326090041, 4911.140550403665, 4932.679375840559, 5002.849914502571, 5031.4213865405945, 4463.152001119777, 4505.549445055468, 4545.159145558082, 4564.543545645475, 4609.193391156534, 6019.398060193946, 6021.2473440819895, 6021.668808215502, 6022.759089636453, 6037.909431358533, 6243.094751261042, 6249.125122482856, 6255.43701066897, 6264.561480696308, 6283.434490895841, 5776.364599894008, 5807.070868660994, 5868.589198756132, 5871.647701137946, 5969.015112506388, 5492.642978206404, 5500.257465242221, 5501.862453438696, 5508.0, 5508.008558459435, 6384.042393640898, 6388.840278993062, 6394.296627371078, 6398.264199617103, 6410.0705397718, 6141.539384546088, 6227.501799856092, 6234.0337247726675, 6241.656708881055, 6262.68686565679, 6314.652694101868, 6327.335629758809, 6370.617762934239, 6406.23125224976, 6423.42189202974, 6261.718222680081, 6265.655388953652, 6271.404216599416, 6285.308616052322, 6295.653739044214, 6144.525313924715, 6156.29202641702, 6172.9074063889975, 6199.721012554536, 6221.720022598904, 6120.17287048654, 6124.3809352984035, 6143.481172719164, 6187.195664563758, 6258.593191442542, 5709.486146246858, 5805.854853628524, 6248.062790581449, 6256.7810126645345, 6284.183056202664, 6053.213082299273, 6101.450869421773, 6113.786017489367, 6122.755089796358, 6133.9079913802225, 6092.603980741238, 6139.815805525842, 6149.2313460817395, 6156.230471191101, 6184.845378865564, 6153.323134455296, 6166.0, 6167.352427995175, 6173.629582225081, 6189.81430557084], "value": 5762.131814016157, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [465.62517173675195, 472.51095116554376, 525.8737902903305, 534.0067474497434, 553.4797290546883, 29996.0, 39939.60060399395, 41325.79337103314, 41340.0, 43572.128557428834, 42044.0, 42232.0, 42370.57629423705, 42371.788141059325, 42457.93855153623, 9745.025497450251, 9942.10521053105, 9944.353617014907, 9948.452835094067, 9983.800323993515, 9746.31775775696, 9866.210703143766, 9868.60525578976, 9871.506424678773, 9897.208223342115, 9707.223422126213, 9793.118619324296, 9854.408735475894, 9862.161716254092, 9874.420092785156, 9792.0, 9840.507974601242, 9843.60625574976, 9858.359206651545, 9864.60541578336, 9655.90344096557, 9745.658901938468, 9750.073742994475, 9750.756231094208, 9754.0, 40845.0, 41083.38374924379, 41168.58831411677, 41173.0, 41240.38139427911, 3054.770892183073, 3406.0, 3435.8282085895607, 3450.1374656335915, 3740.682042026431, 29301.853490732625, 30250.84874575635, 30701.0, 31982.840085799653, 32074.0, 3154.5741324921073, 3182.7931184472936, 3277.3117645294515, 3336.566246387954, 3405.080628230389, 505137.0, 514005.0, 517821.4108929469, 518979.0, 519531.0, 33386.49920251198, 48959.51040489621, 58321.12518312228, 58538.7073064632, 58584.53538661567, 33807.478663460206, 35224.0, 35240.471392929125, 35244.0, 35299.0, 14638.926805365905, 14740.894432917574, 14762.63093422673, 14775.113493190443, 14778.334974926154, 12827.230366178059, 12917.870821291855, 12931.676708082374, 12952.935235323952, 12964.935175324063, 7707.11368192665, 7748.380129589619, 7788.493747906368, 7845.137034926153, 7902.723404680809, 2870.669872964594, 3252.349530093991, 3272.181954511372, 3280.5858759203893, 3307.355065762153, 944.6882528765491, 957.5978089202551, 962.6871266838166, 994.8955359687274, 1042.0257059649252, 25399.873000634878, 29536.261593459905, 29800.701992979793, 30183.396332073673, 30581.23546911345, 884.9469031858109, 923.607466826596, 1053.6364954090827, 1069.7967386196597, 1096.5778175402368, 14954.252287385587, 15384.692306153815, 15428.691426171414, 15665.530034098996, 15682.215889205494, 669078.6546067238, 711342.0, 712136.0, 713998.0, 715116.0, 49305.0, 56926.715366423734, 57488.99999999916, 57688.71155644195, 57724.55688607734, 1164.8369228308043, 1265.2661456355293, 1379.4895888521312, 1404.8665376789188, 1408.5985494134122, 30066.549001764553, 31025.68974310228, 32008.199795005312, 32098.358032838747, 32447.837760811046, 56258.156127658935, 57140.1428978574, 57151.0, 57261.42738572561, 57262.14106788485, 641794.0, 649082.0, 650647.0, 863495.0, 889904.0, 41680.37479437872, 42205.94485137773, 42456.575434245264, 42553.0, 42645.93385165271, 37336.81331593324, 45991.3101303474, 47398.05203895834, 47398.763006184745, 48107.0, 38516.0, 39117.80441097776, 39427.86007965051, 39772.80113599414, 40876.79561602292, 38448.80775596104, 38465.03837404087, 38600.42112808539, 39057.609423906535, 39803.2039359217, 33846.492302614985, 38127.80936095302, 38813.805930970164, 39020.414693780185, 39022.804885976526, 32664.0, 34166.81657372445, 34325.485117722754, 34801.47797782985, 35006.299874002885, 21957.780422195574, 25470.74529254684, 25663.615045774703, 25751.96992120294, 26212.868935655963], "value": 19143.29906544519, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [333.4647890136331, 351.35701665951314, 365.5430711610487, 375.1296990980924, 396.9305371559976, 15132.0, 15315.0, 16028.67942641148, 20440.97795110242, 20895.268665596708, 16222.675546489063, 20298.492537686565, 20892.0, 20947.0, 21182.94085295733, 5724.112762521816, 6033.125196846455, 6047.334793172748, 6050.636961782285, 6057.606255593372, 4175.060611362434, 4388.86833394997, 4391.824327026915, 5938.168656388109, 6009.369016253296, 4291.206126866524, 6360.586561873463, 6661.0, 6680.76617318394, 6772.559783614074, 5906.822795316148, 6163.599366041193, 6509.772157974448, 6555.541112122153, 6751.5273930824615, 5699.487046165865, 5702.971485142589, 5707.1724599933195, 5707.34365547959, 5711.086226203787, 26023.609645855326, 26391.492808183193, 26513.204603861723, 26597.93608255687, 26910.865445672647, 2323.361075704178, 2348.412896775806, 2881.4525240204293, 3099.767517436201, 3181.0933883843227, 15172.696546069128, 15726.685466290724, 15941.282642281125, 16136.35454581827, 16236.269367878474, 1644.7861777968908, 1843.5759775251634, 1884.3404808317116, 1905.8674127428314, 1995.3614843250166, 117364.41317793442, 118186.81813181844, 118228.0, 118479.0, 118941.40529297298, 10418.60372114418, 10766.94616526928, 10891.183161262938, 10987.285826421417, 11105.222634415513, 13353.933230333787, 13403.0, 13414.262215578041, 13423.26172060546, 13426.530071447452, 8438.873416898628, 8748.168923952215, 8778.517181554947, 8843.248323892412, 8860.734177974671, 7425.257474252531, 8760.299176065899, 8876.068012858686, 8915.37592368528, 9053.094690531027, 6341.112244285804, 6381.3937675920715, 6476.190476190476, 6476.287608363076, 6631.0, 1422.9146251224959, 1573.8111426628877, 1786.2676302716084, 1848.8983105929303, 1850.4541160357458, 682.4301708073715, 881.8192270584515, 891.8350105230553, 913.0869130869131, 940.1820416237916, 17110.743338849927, 22161.548119656556, 22347.888260558917, 22379.77620223777, 22415.103395863982, 933.3793027636546, 960.7598100474881, 978.3877048281106, 987.9012098790064, 1003.117256813999, 11081.667549973352, 11528.538858445569, 11852.585159519547, 11868.940655296668, 11919.761604767857, 532630.0, 643781.0, 651539.0, 662032.0, 669091.0, 70662.64668676624, 73545.0, 85676.14323856807, 106476.46761766142, 111767.32349014771, 894.2622336572224, 972.3096601412934, 1009.6920439265947, 1012.8379459286479, 1013.8175128476797, 18641.90679046596, 19082.04589770534, 19252.4224273272, 19263.036848157255, 19265.036748162256, 51170.74414627903, 52566.211506826665, 55129.17306240329, 56295.71852140713, 59300.40699592949, 77523.2247677516, 79407.0296485185, 79783.0, 80726.0, 83257.17199795957, 7887.369010479262, 7939.761807145795, 8075.3135983439715, 8169.836603268021, 8265.297449716842, 12067.879321206676, 12576.937115314366, 12700.301483418501, 13032.609021729364, 13136.211827290394, 7598.8100297493, 11032.503537340679, 11072.391018493738, 11182.66452006441, 11195.384253866116, 10961.232713710282, 11008.064314533034, 11116.777664446505, 11406.0, 11494.770104597694, 11401.315921044765, 11518.654440366467, 11751.353675547927, 11822.290662560274, 11861.76276474483, 7986.720464783704, 7991.440599158235, 8081.15147909461, 8290.46112002718, 8431.620577073923, 8320.41757077023, 10863.402512861869, 11080.944595276973, 11308.307052573418, 11383.146264030065], "value": 9675.216448584757, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1523.0633160606228, 1530.0972426268502, 1729.1613567419806, 1832.3311991123244, 1885.2270569066686, 8648.654053837847, 9223.631054757818, 9232.953835230832, 9237.953810230947, 9243.214326782223, 8057.637406316715, 8279.875801862976, 8283.83432331353, 8434.367422443325, 8971.05803890592, 2174.1520806885287, 2210.8341874359407, 2351.7648235176516, 2437.0373702387546, 2441.9633705494343, 2381.57131716291, 2382.8570285782907, 2384.1059602649007, 2384.403899025244, 2384.511175209078, 2366.538524987628, 2425.7938075263537, 2427.5023620157913, 2429.392651837041, 2431.4772323950347, 2411.2163546847255, 2423.660687503751, 2438.7683170098812, 2441.0967941861445, 2445.1808644104244, 2396.029608008759, 2408.590539608271, 2421.0799896039393, 2425.8301918865686, 2427.4416884116754, 9046.909530904739, 9126.863097053549, 9166.0, 9173.678921237724, 9178.770530736718, 4648.442186937556, 5328.0, 5508.7521061552325, 5515.641483303612, 5579.46995035471, 3458.291050334675, 3553.200529880782, 3607.2424790793966, 3619.239959608485, 3621.022323972539, 1048.910842578374, 1099.4008265495324, 1107.4850194659523, 1788.1863751992812, 1830.00264855654, 11972.401379931056, 11977.101717371232, 12075.879241207564, 12091.516339346503, 12115.878841211652, 4529.139463501924, 4666.95333046672, 4753.6910100844025, 4763.809447622057, 4792.137415265216, 9367.484788336571, 9376.765580860532, 9380.765480862896, 9396.624135034659, 9415.482148481899, 5387.084195686664, 5389.541888939484, 5391.137418013099, 5392.757325920343, 5393.892122157535, 4844.927326090112, 4979.825706100269, 5004.274380214849, 5033.7734801934, 5054.0, 3644.453332000221, 3767.4348847672522, 3777.01797532638, 3858.3826587745825, 3989.8628890765995, 1179.5930404010603, 1179.728662407634, 1190.1074194354235, 1193.7970545007197, 1199.7180662544295, 757.8484303139394, 887.5917078144126, 908.3184679827635, 915.7939463620633, 925.564984457304, 5980.73086711099, 5999.1901093351835, 6102.084687296852, 6121.204243448323, 6305.747770089237, 883.4831623500324, 885.1325700813239, 892.7143314139413, 904.2675432899241, 919.9080091990747, 3820.8853734388013, 3989.4813674222746, 4000.8399664013696, 4131.277026520347, 4140.4617399737845, 10817.56729730802, 11334.149938754626, 11341.773164536664, 11381.374024428736, 11381.487833047533, 11275.661730147945, 11285.153613479022, 11286.717832054264, 11287.04060154896, 11303.491342889589, 8290.917090829134, 8425.915740842636, 8448.366372521963, 8465.32277417805, 8466.280366168821, 5974.193483879794, 5984.8803023940145, 6088.51291896656, 6140.109684095871, 6284.497240220863, 9983.351082179926, 10218.540165692413, 10410.219233557666, 10452.32059916103, 10452.372857628567, 9956.303058786105, 10302.845457317997, 10528.631497897537, 10589.205809564159, 10653.147748180281, 7713.2286771322415, 7873.133955265031, 7875.0, 7880.645370958436, 7899.881501777593, 7729.149793522595, 7995.000624921885, 8001.959990200012, 8331.50010999342, 8533.914660853312, 7592.506487078323, 7608.0, 7679.577623230776, 7688.961555192188, 7862.33170180541, 7536.773896783106, 7581.658825352983, 7583.5070720403, 7585.0, 7623.809404764926, 7029.19164296092, 7034.155901291878, 7094.9290507094265, 7103.041089452858, 7108.466864985044, 5044.319016932667, 5109.284700142058, 5112.718800465861, 5157.638965272395, 5161.716105614228, 4977.0792403405485, 5001.449840517613, 5130.230465430215, 5165.586753059822, 5267.183586544092], "value": 4691.347490934482, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [304.6831295452729, 308.58957586410077, 313.3029010451745, 313.43737990307386, 317.8760283489441, 4850.320955066293, 5288.576913846892, 5300.284461597688, 5317.813876514313, 5347.572194224463, 5213.715359323621, 5236.554892834114, 5245.396779370373, 5262.526372626463, 5278.630495865291, 3386.7121294689982, 3479.7042251408534, 3838.4242363645467, 3992.381180916948, 4037.8586749463775, 3201.375731732313, 4002.5196976362877, 4016.1365306459106, 4110.917781644365, 4119.3409054551275, 3988.6210809973004, 4002.859899903504, 4013.571789067616, 4027.758334499925, 4043.1603620352817, 3106.891258805931, 3303.3723592517345, 3750.587435382106, 4031.7220770264707, 4034.677225821927, 3487.128217945514, 3503.9649603503894, 3507.877224297137, 3511.4908338290807, 3564.8395822188063, 4599.83900563482, 4997.550220480138, 5160.722940932497, 5203.427622961472, 5206.552920127572, 4507.481639611421, 4656.3946686930485, 4661.627069834405, 4681.157391669498, 4695.520910913051, 4416.55834416559, 4993.076280888047, 5506.834794956158, 5516.117421212627, 5517.475839795213, 3438.535797667308, 3777.660010599032, 3871.1483473636035, 3890.3191941410423, 3892.455056292093, 5095.1847704367865, 5569.32672317286, 5625.380599175415, 5856.2138547742925, 5873.125305996013, 3763.8682646107254, 3915.451836742858, 3948.309045916953, 3956.3274243378696, 3969.583193764613, 3529.8235088245483, 3997.8400863965117, 4003.3394489908837, 4009.9373665978537, 4019.7588144711412, 3865.845366185321, 4298.828046878152, 4617.607503362185, 4646.0, 4648.279516674921, 4994.926090890403, 5265.289185959923, 5425.457454254622, 5453.345598528202, 5566.55467562594, 1333.759923213831, 1364.7512526038563, 1368.8083668286447, 1372.9519466818813, 1375.938082786277, 800.7077416742964, 801.7412662120415, 806.9832011665227, 832.646125396704, 860.2386887604515, 4126.938095928564, 4325.221460137205, 4761.309610106585, 5102.107131252016, 5261.342332208474, 4836.322914791932, 5716.0, 5743.10981797822, 5773.90053062322, 5776.104703770922, 4862.246351815475, 4898.436679781799, 4931.852044438672, 5225.790968361299, 5228.398734145546, 2580.8838602262945, 2764.9861750691116, 2950.778691598096, 2967.5103607904884, 3010.5850250382287, 4685.531446855287, 5156.550638446708, 5497.367802702661, 5848.90008295604, 5879.559033072536, 5247.501487358695, 5408.78364865401, 5542.505872357456, 5661.66030038199, 5810.128480727924, 5389.033002953815, 5795.478406943395, 5844.26946631671, 5859.677717725481, 5875.676837773878, 4743.83396581118, 5565.99624135319, 5689.2319536862, 5752.539796816161, 5778.36437991829, 4569.040501494724, 5278.841634750964, 5554.97222513901, 5606.934682410329, 5783.315514433322, 5689.630174038674, 5708.143778433268, 5841.415858414124, 5852.970735146297, 5889.587728858939, 3306.5205545196295, 3474.7046501047694, 3914.2758589661003, 3935.1736135411884, 3980.3631418972827, 4921.63087768426, 5006.974965125151, 5170.457102004386, 5804.912926306193, 5836.0, 4953.702777833341, 5155.252488389237, 5620.285812827127, 5632.32412110533, 5658.773649053992, 4588.439930423672, 5353.2773075634295, 5557.0, 5632.633878797865, 5681.4034526374135, 5521.282233309644, 5524.530414914617, 5541.556675465872, 5543.445655434424, 5602.243697101002, 4749.572538471554, 5452.236686863922, 5472.616916815785, 5487.6158668892795, 5557.499825015768, 5464.371597266207, 5475.890482190413, 5496.780128794803, 5497.835064948058, 5504.972475137599], "value": 4042.856673478498, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [696.8327601375668, 698.3575110897973, 726.2700985509562, 741.9258074192578, 753.9811504712383, 15317.310721017553, 15934.362625494996, 15969.520914372559, 15969.520914372573, 15981.360745570179, 14390.424383024667, 14591.489297874576, 14595.927020364883, 14611.707765844703, 14618.12291262525, 674.0159367323713, 694.9409300209488, 698.2877464985711, 698.4238003646986, 824.0523398092212, 688.8174633722068, 692.0864458914235, 829.5147338806805, 852.526847599582, 860.3805260212637, 896.0501868019887, 908.2461556907783, 910.713125365511, 912.1471424218344, 915.7207051849183, 900.9234215091725, 901.7475106970059, 903.3405613901889, 903.3947255338938, 904.868794024866, 518.4582111693289, 535.7026850098194, 539.4335947255366, 669.0599707411095, 669.3473862983552, 12358.382080895919, 12403.627891163189, 14140.505082322172, 14659.04716193444, 14675.486357977526, 13835.377408016664, 14366.640833979129, 14448.060876043128, 14523.419063237458, 14577.271136443136, 11314.717132071682, 11670.299782013022, 11683.474243659055, 11799.233049851731, 11930.940345298304, 3726.5900750917376, 3804.8668296609762, 3817.6564109230026, 3874.4769456123627, 3898.2788184185733, 100219.49890250502, 101089.49455252677, 102439.48780256126, 102743.0, 105213.94786052195, 9950.303478756417, 10110.797784044278, 10168.28821982469, 10220.540075696612, 10220.824605170352, 21337.25319613806, 21382.572348553254, 21496.78503214979, 21513.462163445725, 21713.78286217149, 7771.844563108706, 7820.882686759704, 7829.882551761728, 7831.373490120776, 7913.406494512819, 3704.68510176638, 4294.699371044059, 4452.1763473757455, 4459.866204013885, 4502.099580083996, 2926.9853650732034, 3434.227298857737, 3437.5359326491102, 3440.088376580208, 3453.067671728619, 685.7702669605738, 686.6257889450262, 686.989695154573, 689.6344937183301, 695.0963747128712, 613.6379536073649, 613.9754409823646, 623.5728525959732, 637.6078711592337, 671.664167916042, 8767.298616110696, 9343.159115679622, 9436.52817359143, 9515.857262141073, 9568.0, 591.222542356808, 614.4746241963146, 625.433982246068, 629.8425393651587, 677.8508728079913, 3535.3106144301614, 4483.484399294123, 4619.491855895849, 4653.139169253699, 4688.929666055012, 135765.0, 135838.32080839731, 136448.7196152351, 137869.0, 139551.0, 139828.30085849506, 146584.26707866392, 149203.0, 152557.47442525433, 153770.0, 115705.0, 123876.76123238832, 125580.37209813892, 126353.0, 126552.36723816322, 8781.91218087811, 8829.205371516595, 8871.733847984571, 8906.688265910661, 8922.152395522675, 62633.68683156555, 64326.35673643203, 65403.67298163479, 66137.0, 67623.66188169028, 83660.0, 94055.0, 94471.0, 96137.0, 102503.0, 12646.620601381974, 12786.041046921704, 12825.486980521047, 13621.25083120438, 13727.313634318045, 14526.85473145255, 14624.34190461453, 15744.60638484047, 15761.369545218522, 15877.2061396932, 13039.348032598522, 13369.0, 13491.05562610608, 14038.1577105374, 14082.436702531784, 11970.76058478808, 13732.244726539737, 13733.381997810322, 14124.646883827576, 14583.85416145825, 12370.505179792708, 12830.87169128334, 13606.251656159006, 13965.0, 14287.64011283937, 10792.952642758966, 10946.945265273622, 11237.71905702364, 11535.110301397835, 11929.224600400947, 10879.673609791718, 10910.563577456813, 11533.0, 11560.768784624091, 11847.822282665595], "value": 7737.995504344079, "unit": "score"}], "name": "dromaeo_css", "value": 7342.092834262622, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 115.0, 115.0, 115.0, 114.0, 114.0, 114.0, 114.0, 114.0, 114.0], "value": 114.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 133.0, 136.0, 142.0, 110.0, 109.0, 109.0, 108.0, 138.0, 110.0], "value": 124.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [185.0, 185.0, 183.0, 185.0, 183.0, 179.0, 182.0, 184.0, 185.0, 183.0], "value": 183.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 59.0, 60.0, 89.0, 61.0, 61.0, 59.0, 58.0, 82.0, 57.0], "value": 66.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 70.0, 93.0, 68.0, 67.0, 68.0, 92.0, 69.0, 67.0, 88.0], "value": 76.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 130.0, 88.0, 85.0, 88.0, 84.0, 88.0, 84.0, 87.0, 85.0], "value": 93.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 96.0, 93.0, 94.0, 93.0, 94.0, 95.0, 93.0, 93.0, 94.0], "value": 93.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 86.0, 86.0, 87.0, 85.0, 86.0, 86.0, 84.0, 87.0, 88.0], "value": 86.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 54.0, 53.0, 54.0, 55.0, 58.0, 57.0, 56.0, 57.0, 57.0], "value": 55.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 71.0, 68.0, 73.0, 71.0, 67.0, 68.0, 68.0, 69.0, 69.0], "value": 68.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 81.0, 82.0, 82.0, 81.0, 81.0, 84.0, 84.0, 81.0, 83.0], "value": 82.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [138.0, 134.0, 143.0, 141.0, 145.0, 143.0, 137.0, 138.0, 197.0, 135.0], "value": 145.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 179.0, 162.0, 163.0, 167.0, 162.0, 160.0, 165.0, 161.0, 161.0], "value": 164.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 66.0, 68.0, 67.0, 67.0, 76.0, 85.0, 84.0, 84.0, 83.0], "value": 74.7, "unit": "score"}], "name": "kraken", "value": 1429.7, "alertThreshold": 2.0}]} 03:31:10 INFO - Return code: 0 03:31:10 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 03:31:10 INFO - # TBPL SUCCESS # 03:31:10 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 03:31:10 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 03:31:10 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 03:31:10 INFO - 2016-10-19 03:31:10.837 screenresolution[1669:10313] starting screenresolution argv=screenresolution get 03:31:10 INFO - 2016-10-19 03:31:10.839 screenresolution[1669:10313] Display 0: 1600x1200x32@60 03:31:10 INFO - 2016-10-19 03:31:10.845 screenresolution[1670:10316] starting screenresolution argv=screenresolution list 03:31:10 INFO - Available Modes on Display 0 03:31:10 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 03:31:10 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 03:31:10 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 03:31:10 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 03:31:11 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 03:31:11 INFO - Intel Iris: 03:31:11 INFO - Chipset Model: Intel Iris 03:31:11 INFO - Type: GPU 03:31:11 INFO - Bus: Built-In 03:31:11 INFO - VRAM (Dynamic, Max): 1536 MB 03:31:11 INFO - Vendor: Intel (0x8086) 03:31:11 INFO - Device ID: 0x0a2e 03:31:11 INFO - Revision ID: 0x0009 03:31:11 INFO - Displays: 03:31:11 INFO - Display: 03:31:11 INFO - Resolution: 1600 x 1200 @ 60 Hz 03:31:11 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 03:31:11 INFO - Display Serial Number: 1600x1200 60 03:31:11 INFO - Main Display: Yes 03:31:11 INFO - Mirror: Off 03:31:11 INFO - Online: Yes 03:31:11 INFO - Rotation: Supported 03:31:11 INFO - Return code: 0 03:31:11 INFO - Running post-action listener: _resource_record_post_action 03:31:11 INFO - [mozharness: 2016-10-19 10:31:11.078842Z] Finished run-tests step (success) 03:31:11 INFO - Running post-run listener: _resource_record_post_run 03:31:11 INFO - Total resource usage - Wall time: 1209s; CPU: 53.0%; Read bytes: 33164288; Write bytes: 663262720; Read time: 308; Write time: 1927 03:31:11 INFO - TinderboxPrint: CPU usage
53.3% 03:31:11 INFO - TinderboxPrint: I/O read bytes / time
33,164,288 / 308 03:31:11 INFO - TinderboxPrint: I/O write bytes / time
663,262,720 / 1,927 03:31:11 INFO - TinderboxPrint: CPU idle
2,257.6 (46.7%) 03:31:11 INFO - TinderboxPrint: CPU system
966.0 (20.0%) 03:31:11 INFO - TinderboxPrint: CPU user
1,614.0 (33.4%) 03:31:11 INFO - TinderboxPrint: Swap in / out
392,364,032 / 0 03:31:11 INFO - install - Wall time: 33s; CPU: 55.0%; Read bytes: 356479488; Write bytes: 355866112; Read time: 27498; Write time: 702 03:31:11 INFO - run-tests - Wall time: 1178s; CPU: 53.0%; Read bytes: 32226304; Write bytes: 297209856; Read time: 295; Write time: 1119 03:31:11 INFO - Running post-run listener: _upload_blobber_files 03:31:11 INFO - Blob upload gear active. 03:31:11 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:31:11 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 03:31:11 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'] 03:31:11 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 03:31:11 INFO - (blobuploader) - INFO - Open directory for files ... 03:31:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 03:31:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:31:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:31:13 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 03:31:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:31:13 INFO - (blobuploader) - INFO - Done attempting. 03:31:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 03:31:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:31:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:31:14 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 03:31:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:31:14 INFO - (blobuploader) - INFO - Done attempting. 03:31:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 03:31:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:31:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:31:16 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 03:31:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:31:16 INFO - (blobuploader) - INFO - Done attempting. 03:31:16 INFO - (blobuploader) - INFO - Iteration through files over. 03:31:16 INFO - Return code: 0 03:31:16 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:31:16 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:31:16 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/95d8008364b5e453141beb1ce34317145ce75f0de3f998bf2fbad6048cf602d70f6b12412b4a71cc272dc02fc1b187eebd9d5a79109353d060d6efcfa7fdecb1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/85f82b1b2fcc7e2ca1d65077d1dad27ae4ed35f139e8f50700cedb5cd0e58fde84c0ac29d55e254af72dbae74dae808f45f7be9885d4a5a2ee37eb95084e4ffd", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6e84df46067e2c4afd964ce4d9d28a14963d1903be6d012ba00cdabc99d2a810e8d20cf2918de2b2665419b90366f2b2a532741fd74b078ff0725ef2cfecc620"} 03:31:16 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:31:16 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:31:16 INFO - Contents: 03:31:16 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/95d8008364b5e453141beb1ce34317145ce75f0de3f998bf2fbad6048cf602d70f6b12412b4a71cc272dc02fc1b187eebd9d5a79109353d060d6efcfa7fdecb1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/85f82b1b2fcc7e2ca1d65077d1dad27ae4ed35f139e8f50700cedb5cd0e58fde84c0ac29d55e254af72dbae74dae808f45f7be9885d4a5a2ee37eb95084e4ffd", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6e84df46067e2c4afd964ce4d9d28a14963d1903be6d012ba00cdabc99d2a810e8d20cf2918de2b2665419b90366f2b2a532741fd74b078ff0725ef2cfecc620"} 03:31:16 INFO - Running post-run listener: copy_logs_to_upload_dir 03:31:16 INFO - Copying logs to upload dir... 03:31:16 INFO - mkdir: /builds/slave/test/build/upload/logs 03:31:16 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1270.863048 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 10 secs) (at 2016-10-19 03:31:17.027892) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-19 03:31:17.031609) ========= 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.Dnf5CSMSh0/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.CFiLXJkVrI/Listeners TMPDIR=/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/95d8008364b5e453141beb1ce34317145ce75f0de3f998bf2fbad6048cf602d70f6b12412b4a71cc272dc02fc1b187eebd9d5a79109353d060d6efcfa7fdecb1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/85f82b1b2fcc7e2ca1d65077d1dad27ae4ed35f139e8f50700cedb5cd0e58fde84c0ac29d55e254af72dbae74dae808f45f7be9885d4a5a2ee37eb95084e4ffd", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6e84df46067e2c4afd964ce4d9d28a14963d1903be6d012ba00cdabc99d2a810e8d20cf2918de2b2665419b90366f2b2a532741fd74b078ff0725ef2cfecc620"} build_url:https://queue.taskcluster.net/v1/task/XK_g9cCZST-PfQDbKLFBxA/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010814 build_url: 'https://queue.taskcluster.net/v1/task/XK_g9cCZST-PfQDbKLFBxA/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/95d8008364b5e453141beb1ce34317145ce75f0de3f998bf2fbad6048cf602d70f6b12412b4a71cc272dc02fc1b187eebd9d5a79109353d060d6efcfa7fdecb1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/85f82b1b2fcc7e2ca1d65077d1dad27ae4ed35f139e8f50700cedb5cd0e58fde84c0ac29d55e254af72dbae74dae808f45f7be9885d4a5a2ee37eb95084e4ffd", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6e84df46067e2c4afd964ce4d9d28a14963d1903be6d012ba00cdabc99d2a810e8d20cf2918de2b2665419b90366f2b2a532741fd74b078ff0725ef2cfecc620"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-19 03:31:17.063447) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-19 03:31:17.063768) ========= 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.Dnf5CSMSh0/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.CFiLXJkVrI/Listeners TMPDIR=/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False program finished with exit code 0 elapsedTime=0.005038 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-19 03:31:17.111855) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-19 03:31:17.112187) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-19 03:31:17.112531) ========= ========= Total master_lag: 0.17 =========