builder: autoland_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0169 starttime: 1474523764.91 results: success (0) buildid: 20160921205400 builduid: 9d14e38a37f64c829acdecf3c8032209 revision: 86a6a947fd9bead62ba068bb8faa4790d57f806b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-09-21 22:56:04.908198) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-09-21 22:56:04.909065) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-21 22:56:04.909349) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-21 22:56:04.945564) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-21 22:56:04.946075) ========= 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.09ArzxQ1TO/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.LdqRs4GF48/Listeners TMPDIR=/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-09-21 22:56: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: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 9.61M=0.001s 2016-09-21 22:56:05 (9.61 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.111505 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-21 22:56:05.083151) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-21 22:56:05.083495) ========= 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.09ArzxQ1TO/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.LdqRs4GF48/Listeners TMPDIR=/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/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.027045 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-21 22:56:05.135169) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-09-21 22:56:05.135623) ========= bash -c 'python archiver_client.py mozharness --repo integration/autoland --rev 86a6a947fd9bead62ba068bb8faa4790d57f806b --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/autoland --rev 86a6a947fd9bead62ba068bb8faa4790d57f806b --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.09ArzxQ1TO/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.LdqRs4GF48/Listeners TMPDIR=/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-09-21 22:56:05,225 truncating revision to first 12 chars 2016-09-21 22:56:05,226 Setting DEBUG logging. 2016-09-21 22:56:05,226 attempt 1/10 2016-09-21 22:56:05,226 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/86a6a947fd9b?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-09-21 22:56:06,565 unpacking tar archive at: autoland-86a6a947fd9b/testing/mozharness/ program finished with exit code 0 elapsedTime=1.584798 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-09-21 22:56:06.748511) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-21 22:56:06.748925) ========= script_repo_revision: 86a6a947fd9bead62ba068bb8faa4790d57f806b ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-21 22:56:06.749465) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-21 22:56:06.749848) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-21 22:56:06.773303) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 21 secs) (at 2016-09-21 22:56:06.773779) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Autoland --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Autoland', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Autoland'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.09ArzxQ1TO/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.LdqRs4GF48/Listeners TMPDIR=/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 22:56:06 INFO - MultiFileLogger online at 20160921 22:56:06 in /builds/slave/test 22:56:06 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Autoland --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland 22:56:06 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 22:56:06 INFO - {'append_to_log': False, 22:56:06 INFO - 'base_work_dir': '/builds/slave/test', 22:56:06 INFO - 'blob_upload_branch': 'Autoland', 22:56:06 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 22:56:06 INFO - 'branch': 'Autoland', 22:56:06 INFO - 'buildbot_json_path': 'buildprops.json', 22:56:06 INFO - 'config_files': ('talos/mac_config.py',), 22:56:06 INFO - 'default_actions': ('clobber', 22:56:06 INFO - 'read-buildbot-config', 22:56:06 INFO - 'download-and-extract', 22:56:06 INFO - 'populate-webroot', 22:56:06 INFO - 'create-virtualenv', 22:56:06 INFO - 'install', 22:56:06 INFO - 'run-tests'), 22:56:06 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 22:56:06 INFO - 'download_minidump_stackwalk': True, 22:56:06 INFO - 'download_symbols': 'ondemand', 22:56:06 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 22:56:06 INFO - 'tooltool.py': '/tools/tooltool.py', 22:56:06 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 22:56:06 INFO - '/tools/misc-python/virtualenv.py')}, 22:56:06 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 22:56:06 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 22:56:06 INFO - 'installer_path': 'installer.exe', 22:56:06 INFO - 'log_level': 'info', 22:56:06 INFO - 'log_name': 'talos', 22:56:06 INFO - 'log_to_console': True, 22:56:06 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 22:56:06 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 22:56:06 INFO - 'opt_config_files': (), 22:56:06 INFO - 'pip_index': False, 22:56:06 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 22:56:06 INFO - 'cmd': ('bash', 22:56:06 INFO - '-c', 22:56:06 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 22:56:06 INFO - 'enabled': True, 22:56:06 INFO - 'halt_on_failure': False, 22:56:06 INFO - 'name': 'check_screen_resolution'},), 22:56:06 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 22:56:06 INFO - 'cmd': ('bash', 22:56:06 INFO - '-c', 22:56:06 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 22:56:06 INFO - 'enabled': True, 22:56:06 INFO - 'halt_on_failure': False, 22:56:06 INFO - 'name': 'check_screen_resolution'},), 22:56:06 INFO - 'run_cmd_checks_enabled': True, 22:56:06 INFO - 'sps_profile': False, 22:56:06 INFO - 'sps_profile_interval': 0, 22:56:06 INFO - 'suite': 'dromaeojs', 22:56:06 INFO - 'system_bits': '32', 22:56:06 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 22:56:06 INFO - 'title': 't-yosemite-r7-0169', 22:56:06 INFO - 'tooltool_cache': '/builds/tooltool_cache', 22:56:06 INFO - 'use_talos_json': True, 22:56:06 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 22:56:06 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 22:56:06 INFO - 'work_dir': 'build'} 22:56:06 INFO - [mozharness: 2016-09-22 05:56:06.990335Z] Running clobber step. 22:56:06 INFO - Running pre-action listener: _resource_record_pre_action 22:56:06 INFO - Running main action method: clobber 22:56:06 INFO - rmtree: /builds/slave/test/build 22:56:06 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 22:56:09 INFO - Running post-action listener: _resource_record_post_action 22:56:09 INFO - [mozharness: 2016-09-22 05:56:09.013276Z] Finished clobber step (success) 22:56:09 INFO - [mozharness: 2016-09-22 05:56:09.013473Z] Running read-buildbot-config step. 22:56:09 INFO - Running pre-action listener: _resource_record_pre_action 22:56:09 INFO - Running main action method: read_buildbot_config 22:56:09 INFO - Using buildbot properties: 22:56:09 INFO - { 22:56:09 INFO - "project": "", 22:56:09 INFO - "product": "firefox", 22:56:09 INFO - "script_repo_revision": "production", 22:56:09 INFO - "builddir": "autoland_yosemite_r7_test-dromaeojs", 22:56:09 INFO - "repository": "", 22:56:09 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 autoland talos dromaeojs", 22:56:09 INFO - "buildid": "20160921205400", 22:56:09 INFO - "pgo_build": "False", 22:56:09 INFO - "basedir": "/builds/slave/test", 22:56:09 INFO - "buildnumber": 269, 22:56:09 INFO - "slavename": "t-yosemite-r7-0169", 22:56:09 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 22:56:09 INFO - "platform": "yosemite_r7", 22:56:09 INFO - "scheduler": "tests-autoland-macosx64-talos", 22:56:09 INFO - "branch": "autoland", 22:56:09 INFO - "repo_path": "integration/autoland", 22:56:09 INFO - "revision": "86a6a947fd9bead62ba068bb8faa4790d57f806b", 22:56:09 INFO - "stage_platform": "macosx64", 22:56:09 INFO - "builduid": "9d14e38a37f64c829acdecf3c8032209", 22:56:09 INFO - "slavebuilddir": "test" 22:56:09 INFO - } 22:56:09 INFO - Found installer url https://queue.taskcluster.net/v1/task/IGAcqI8aQ9CpppxwgGmqAA/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg. 22:56:09 INFO - Running post-action listener: _resource_record_post_action 22:56:09 INFO - [mozharness: 2016-09-22 05:56:09.020328Z] Finished read-buildbot-config step (success) 22:56:09 INFO - [mozharness: 2016-09-22 05:56:09.020519Z] Running download-and-extract step. 22:56:09 INFO - Running pre-action listener: _resource_record_pre_action 22:56:09 INFO - Running main action method: download_and_extract 22:56:09 INFO - mkdir: /builds/slave/test/build/tests 22:56:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:56:09 INFO - trying https://queue.taskcluster.net/v1/task/IGAcqI8aQ9CpppxwgGmqAA/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json 22:56:09 INFO - Downloading https://queue.taskcluster.net/v1/task/IGAcqI8aQ9CpppxwgGmqAA/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json 22:56:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/IGAcqI8aQ9CpppxwgGmqAA/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json'}, attempt #1 22:56:10 INFO - Downloaded 1199 bytes. 22:56:10 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json 22:56:10 INFO - Using the following test package requirements: 22:56:10 INFO - {u'common': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 22:56:10 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 22:56:10 INFO - u'firefox-52.0a1.en-US.mac.cppunittest.tests.zip'], 22:56:10 INFO - u'gtest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 22:56:10 INFO - u'firefox-52.0a1.en-US.mac.gtest.tests.zip'], 22:56:10 INFO - u'jittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 22:56:10 INFO - u'jsshell-mac.zip'], 22:56:10 INFO - u'mochitest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 22:56:10 INFO - u'firefox-52.0a1.en-US.mac.mochitest.tests.zip'], 22:56:10 INFO - u'mozbase': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 22:56:10 INFO - u'reftest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 22:56:10 INFO - u'firefox-52.0a1.en-US.mac.reftest.tests.zip'], 22:56:10 INFO - u'talos': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 22:56:10 INFO - u'firefox-52.0a1.en-US.mac.talos.tests.zip'], 22:56:10 INFO - u'web-platform': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 22:56:10 INFO - u'firefox-52.0a1.en-US.mac.web-platform.tests.zip'], 22:56:10 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 22:56:10 INFO - u'firefox-52.0a1.en-US.mac.xpcshell.tests.zip']} 22:56:10 INFO - Downloading packages: [u'firefox-52.0a1.en-US.mac.common.tests.zip'] for test suite category: common 22:56:10 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/IGAcqI8aQ9CpppxwgGmqAA/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 22:56:10 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/IGAcqI8aQ9CpppxwgGmqAA/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 22:56:10 INFO - Fetch https://queue.taskcluster.net/v1/task/IGAcqI8aQ9CpppxwgGmqAA/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 22:56:10 INFO - Expected file size: 16434736 22:56:18 INFO - Downloading packages: [u'firefox-52.0a1.en-US.mac.common.tests.zip', u'firefox-52.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 22:56:18 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/IGAcqI8aQ9CpppxwgGmqAA/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 22:56:18 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/IGAcqI8aQ9CpppxwgGmqAA/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 22:56:18 INFO - Fetch https://queue.taskcluster.net/v1/task/IGAcqI8aQ9CpppxwgGmqAA/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 22:56:19 INFO - Expected file size: 16434736 22:56:25 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/IGAcqI8aQ9CpppxwgGmqAA/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip 22:56:25 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/IGAcqI8aQ9CpppxwgGmqAA/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip'}, attempt #1 22:56:25 INFO - Fetch https://queue.taskcluster.net/v1/task/IGAcqI8aQ9CpppxwgGmqAA/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip into memory 22:56:26 INFO - Expected file size: 14414059 22:56:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:56:27 INFO - trying https://queue.taskcluster.net/v1/task/IGAcqI8aQ9CpppxwgGmqAA/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 22:56:27 INFO - Downloading https://queue.taskcluster.net/v1/task/IGAcqI8aQ9CpppxwgGmqAA/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg 22:56:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/IGAcqI8aQ9CpppxwgGmqAA/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg'}, attempt #1 22:56:30 INFO - Downloaded 111329868 bytes. 22:56:30 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/IGAcqI8aQ9CpppxwgGmqAA/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 22:56:30 INFO - mkdir: /builds/slave/test/properties 22:56:30 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 22:56:30 INFO - Writing to file /builds/slave/test/properties/build_url 22:56:30 INFO - Contents: 22:56:30 INFO - build_url:https://queue.taskcluster.net/v1/task/IGAcqI8aQ9CpppxwgGmqAA/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 22:56:31 INFO - Running post-action listener: _resource_record_post_action 22:56:31 INFO - Running post-action listener: set_extra_try_arguments 22:56:31 INFO - [mozharness: 2016-09-22 05:56:31.148599Z] Finished download-and-extract step (success) 22:56:31 INFO - [mozharness: 2016-09-22 05:56:31.148708Z] Running populate-webroot step. 22:56:31 INFO - Running pre-action listener: _resource_record_pre_action 22:56:31 INFO - Running main action method: populate_webroot 22:56:31 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 22:56:31 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 22:56:31 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 22:56:31 INFO - '--tppagecycles', 22:56:31 INFO - '7'], 22:56:31 INFO - 'tests': ['tsvgm']}}, 22:56:31 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 22:56:31 INFO - 'tests': ['tresize', 'tcanvasmark']}, 22:56:31 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 22:56:31 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 22:56:31 INFO - 'tests': ['dromaeo_css', 'kraken']}, 22:56:31 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 22:56:31 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:56:31 INFO - 'talos_options': ['--disable-e10s'], 22:56:31 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:56:31 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:56:31 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:56:31 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:56:31 INFO - 'talos_options': ['--disable-e10s'], 22:56:31 INFO - 'tests': ['damp', 'tps']}, 22:56:31 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:56:31 INFO - 'tests': ['damp', 'tps']}, 22:56:31 INFO - 'g3': {'talos_options': ['--disable-e10s'], 22:56:31 INFO - 'tests': ['dromaeo_dom']}, 22:56:31 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 22:56:31 INFO - 'g4': {'talos_options': ['--disable-e10s'], 22:56:31 INFO - 'tests': ['basic_compositor_video']}, 22:56:31 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 22:56:31 INFO - 'other': {'talos_options': ['--disable-e10s'], 22:56:31 INFO - 'tests': ['a11yr', 22:56:31 INFO - 'ts_paint', 22:56:31 INFO - 'tpaint', 22:56:31 INFO - 'sessionrestore', 22:56:31 INFO - 'sessionrestore_no_auto_restore', 22:56:31 INFO - 'tabpaint']}, 22:56:31 INFO - 'other-e10s': {'tests': ['a11yr', 22:56:31 INFO - 'ts_paint', 22:56:31 INFO - 'tpaint', 22:56:31 INFO - 'sessionrestore', 22:56:31 INFO - 'sessionrestore_no_auto_restore', 22:56:31 INFO - 'tabpaint']}, 22:56:31 INFO - 'other-e10s_l64': {'tests': ['a11yr', 22:56:31 INFO - 'ts_paint', 22:56:31 INFO - 'tpaint', 22:56:31 INFO - 'sessionrestore', 22:56:31 INFO - 'sessionrestore_no_auto_restore', 22:56:31 INFO - 'tabpaint']}, 22:56:31 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 22:56:31 INFO - 'ts_paint', 22:56:31 INFO - 'tpaint', 22:56:31 INFO - 'sessionrestore', 22:56:31 INFO - 'sessionrestore_no_auto_restore', 22:56:31 INFO - 'tabpaint']}, 22:56:31 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 22:56:31 INFO - 'tests': ['a11yr', 22:56:31 INFO - 'ts_paint', 22:56:31 INFO - 'tpaint', 22:56:31 INFO - 'sessionrestore', 22:56:31 INFO - 'sessionrestore_no_auto_restore', 22:56:31 INFO - 'tabpaint']}, 22:56:31 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 22:56:31 INFO - 'tests': ['a11yr', 22:56:31 INFO - 'ts_paint', 22:56:31 INFO - 'tpaint', 22:56:31 INFO - 'sessionrestore', 22:56:31 INFO - 'sessionrestore_no_auto_restore', 22:56:31 INFO - 'tabpaint']}, 22:56:31 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 22:56:31 INFO - 'tests': ['tsvgx', 22:56:31 INFO - 'tsvgr_opacity', 22:56:31 INFO - 'tart', 22:56:31 INFO - 'tscrollx', 22:56:31 INFO - 'cart']}, 22:56:31 INFO - 'svgr-e10s': {'tests': ['tsvgx', 22:56:31 INFO - 'tsvgr_opacity', 22:56:31 INFO - 'tart', 22:56:31 INFO - 'tscrollx', 22:56:31 INFO - 'cart']}, 22:56:31 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:56:31 INFO - 'talos_options': ['--disable-e10s'], 22:56:31 INFO - 'tests': ['tp5o']}, 22:56:31 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:56:31 INFO - 'tests': ['tp5o']}, 22:56:31 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:56:31 INFO - 'talos_options': ['--disable-e10s', 22:56:31 INFO - '--xperf_path', 22:56:31 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:56:31 INFO - 'tests': ['tp5n']}, 22:56:31 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:56:31 INFO - 'talos_options': ['--xperf_path', 22:56:31 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:56:31 INFO - 'tests': ['tp5n']}}, 22:56:31 INFO - 'talos.zip': {'path': '', 22:56:31 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 22:56:31 INFO - Running post-action listener: _resource_record_post_action 22:56:31 INFO - [mozharness: 2016-09-22 05:56:31.167459Z] Finished populate-webroot step (success) 22:56:31 INFO - [mozharness: 2016-09-22 05:56:31.167562Z] Running create-virtualenv step. 22:56:31 INFO - Running pre-action listener: _resource_record_pre_action 22:56:31 INFO - Running main action method: create_virtualenv 22:56:31 INFO - Creating virtualenv /builds/slave/test/build/venv 22:56:31 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 22:56:31 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 22:56:31 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 22:56:31 INFO - Using real prefix '/tools/python27' 22:56:31 INFO - New python executable in /builds/slave/test/build/venv/bin/python 22:56:32 INFO - Installing distribute.............................................................................................................................................................................................done. 22:56:34 INFO - Installing pip.................done. 22:56:34 INFO - Return code: 0 22:56:34 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 22:56:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:56:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:56:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:56:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:56:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:56:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:56:34 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 0x1079b9490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10792f570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa969594420>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1077cdd30>, '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 0x1075f3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1077c5b20>, '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.09ArzxQ1TO/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.LdqRs4GF48/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 22:56:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 22:56:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 22:56:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.09ArzxQ1TO/Render', 22:56:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:56:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:56:34 INFO - 'HOME': '/Users/cltbld', 22:56:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:56:34 INFO - 'LOGNAME': 'cltbld', 22:56:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:56:34 INFO - 'MOZ_NO_REMOTE': '1', 22:56:34 INFO - 'NO_EM_RESTART': '1', 22:56:34 INFO - 'PAGER': '/bin/cat', 22:56:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:56:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:56:34 INFO - 'PWD': '/builds/slave/test', 22:56:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:56:34 INFO - 'SHELL': '/bin/bash', 22:56:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.LdqRs4GF48/Listeners', 22:56:34 INFO - 'TMPDIR': '/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/', 22:56:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:56:34 INFO - 'USER': 'cltbld', 22:56:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:56:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:56:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:56:34 INFO - 'XPC_FLAGS': '0x0', 22:56:34 INFO - 'XPC_SERVICE_NAME': '0', 22:56:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 22:56:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:56:35 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 22:56:35 INFO - Cleaning up... 22:56:35 INFO - Return code: 0 22:56:35 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 22:56:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:56:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:56:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:56:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:56:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:56:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:56:35 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1079b9490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10792f570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa969594420>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1077cdd30>, '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 0x1075f3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1077c5b20>, '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.09ArzxQ1TO/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.LdqRs4GF48/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 22:56:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 22:56:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 22:56:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.09ArzxQ1TO/Render', 22:56:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:56:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:56:35 INFO - 'HOME': '/Users/cltbld', 22:56:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:56:35 INFO - 'LOGNAME': 'cltbld', 22:56:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:56:35 INFO - 'MOZ_NO_REMOTE': '1', 22:56:35 INFO - 'NO_EM_RESTART': '1', 22:56:35 INFO - 'PAGER': '/bin/cat', 22:56:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:56:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:56:35 INFO - 'PWD': '/builds/slave/test', 22:56:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:56:35 INFO - 'SHELL': '/bin/bash', 22:56:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.LdqRs4GF48/Listeners', 22:56:35 INFO - 'TMPDIR': '/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/', 22:56:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:56:35 INFO - 'USER': 'cltbld', 22:56:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:56:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:56:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:56:35 INFO - 'XPC_FLAGS': '0x0', 22:56:35 INFO - 'XPC_SERVICE_NAME': '0', 22:56:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 22:56:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:56:35 INFO - Downloading/unpacking psutil>=3.1.1 22:56:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:56:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:56:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:56:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:56:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:56:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:56:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 22:56:38 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:56:38 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:56:38 INFO - Installing collected packages: psutil 22:56:38 INFO - Running setup.py install for psutil 22:56:38 INFO - building 'psutil._psutil_osx' extension 22:56:38 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 22:56:39 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 22:56:39 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 22:56:39 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 22:56:39 INFO - building 'psutil._psutil_posix' extension 22:56:39 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 22:56:39 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 22:56:39 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 22:56:39 INFO - ^ 22:56:39 INFO - 1 warning generated. 22:56:39 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 22:56:39 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:56:39 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:56:39 INFO - Successfully installed psutil 22:56:39 INFO - Cleaning up... 22:56:39 INFO - Return code: 0 22:56:39 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 22:56:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:56:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:56:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:56:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:56:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:56:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:56:40 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 0x1079b9490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10792f570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa969594420>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1077cdd30>, '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 0x1075f3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1077c5b20>, '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.09ArzxQ1TO/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.LdqRs4GF48/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 22:56:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 22:56:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 22:56:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.09ArzxQ1TO/Render', 22:56:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:56:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:56:40 INFO - 'HOME': '/Users/cltbld', 22:56:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:56:40 INFO - 'LOGNAME': 'cltbld', 22:56:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:56:40 INFO - 'MOZ_NO_REMOTE': '1', 22:56:40 INFO - 'NO_EM_RESTART': '1', 22:56:40 INFO - 'PAGER': '/bin/cat', 22:56:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:56:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:56:40 INFO - 'PWD': '/builds/slave/test', 22:56:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:56:40 INFO - 'SHELL': '/bin/bash', 22:56:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.LdqRs4GF48/Listeners', 22:56:40 INFO - 'TMPDIR': '/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/', 22:56:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:56:40 INFO - 'USER': 'cltbld', 22:56:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:56:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:56:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:56:40 INFO - 'XPC_FLAGS': '0x0', 22:56:40 INFO - 'XPC_SERVICE_NAME': '0', 22:56:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 22:56:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:56:40 INFO - Downloading/unpacking mozsystemmonitor==0.3 22:56:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:56:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:56:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:56:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:56:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:56:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:56:42 INFO - Downloading mozsystemmonitor-0.3.tar.gz 22:56:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 22:56:42 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 22:56:42 INFO - Installing collected packages: mozsystemmonitor 22:56:42 INFO - Running setup.py install for mozsystemmonitor 22:56:42 INFO - Successfully installed mozsystemmonitor 22:56:42 INFO - Cleaning up... 22:56:43 INFO - Return code: 0 22:56:43 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 22:56:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:56:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:56:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:56:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:56:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:56:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:56:43 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 0x1079b9490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10792f570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa969594420>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1077cdd30>, '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 0x1075f3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1077c5b20>, '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.09ArzxQ1TO/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.LdqRs4GF48/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 22:56:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 22:56:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 22:56:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.09ArzxQ1TO/Render', 22:56:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:56:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:56:43 INFO - 'HOME': '/Users/cltbld', 22:56:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:56:43 INFO - 'LOGNAME': 'cltbld', 22:56:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:56:43 INFO - 'MOZ_NO_REMOTE': '1', 22:56:43 INFO - 'NO_EM_RESTART': '1', 22:56:43 INFO - 'PAGER': '/bin/cat', 22:56:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:56:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:56:43 INFO - 'PWD': '/builds/slave/test', 22:56:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:56:43 INFO - 'SHELL': '/bin/bash', 22:56:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.LdqRs4GF48/Listeners', 22:56:43 INFO - 'TMPDIR': '/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/', 22:56:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:56:43 INFO - 'USER': 'cltbld', 22:56:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:56:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:56:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:56:43 INFO - 'XPC_FLAGS': '0x0', 22:56:43 INFO - 'XPC_SERVICE_NAME': '0', 22:56:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 22:56:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:56:43 INFO - Downloading/unpacking jsonschema==2.5.1 22:56:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:56:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:56:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:56:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:56:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:56:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:56:45 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 22:56:45 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 22:56:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:56:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:56:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:56:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:56:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:56:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:56:46 INFO - Downloading functools32-3.2.3-2.tar.gz 22:56:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 22:56:46 INFO - warning: no files found matching '*.txt' 22:56:46 INFO - no previously-included directories found matching 'build' 22:56:46 INFO - no previously-included directories found matching 'dist' 22:56:46 INFO - no previously-included directories found matching '.git*' 22:56:46 INFO - Installing collected packages: jsonschema, functools32 22:56:46 INFO - Running setup.py install for functools32 22:56:46 INFO - warning: no files found matching '*.txt' 22:56:46 INFO - no previously-included directories found matching 'build' 22:56:46 INFO - no previously-included directories found matching 'dist' 22:56:46 INFO - no previously-included directories found matching '.git*' 22:56:46 INFO - Successfully installed jsonschema functools32 22:56:46 INFO - Cleaning up... 22:56:46 INFO - Return code: 0 22:56:46 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 22:56:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:56:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:56:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:56:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:56:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:56:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:56:46 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1079b9490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10792f570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa969594420>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1077cdd30>, '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 0x1075f3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1077c5b20>, '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.09ArzxQ1TO/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.LdqRs4GF48/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 22:56:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 22:56:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 22:56:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.09ArzxQ1TO/Render', 22:56:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:56:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:56:46 INFO - 'HOME': '/Users/cltbld', 22:56:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:56:46 INFO - 'LOGNAME': 'cltbld', 22:56:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:56:46 INFO - 'MOZ_NO_REMOTE': '1', 22:56:46 INFO - 'NO_EM_RESTART': '1', 22:56:46 INFO - 'PAGER': '/bin/cat', 22:56:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:56:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:56:46 INFO - 'PWD': '/builds/slave/test', 22:56:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:56:46 INFO - 'SHELL': '/bin/bash', 22:56:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.LdqRs4GF48/Listeners', 22:56:46 INFO - 'TMPDIR': '/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/', 22:56:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:56:46 INFO - 'USER': 'cltbld', 22:56:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:56:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:56:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:56:46 INFO - 'XPC_FLAGS': '0x0', 22:56:46 INFO - 'XPC_SERVICE_NAME': '0', 22:56:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 22:56:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:56:47 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 22:56:47 INFO - Cleaning up... 22:56:47 INFO - Return code: 0 22:56:47 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 22:56:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:56:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:56:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:56:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:56:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:56:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:56:47 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 0x1079b9490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10792f570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa969594420>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1077cdd30>, '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 0x1075f3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1077c5b20>, '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.09ArzxQ1TO/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.LdqRs4GF48/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 22:56:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 22:56:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 22:56:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.09ArzxQ1TO/Render', 22:56:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:56:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:56:47 INFO - 'HOME': '/Users/cltbld', 22:56:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:56:47 INFO - 'LOGNAME': 'cltbld', 22:56:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:56:47 INFO - 'MOZ_NO_REMOTE': '1', 22:56:47 INFO - 'NO_EM_RESTART': '1', 22:56:47 INFO - 'PAGER': '/bin/cat', 22:56:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:56:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:56:47 INFO - 'PWD': '/builds/slave/test', 22:56:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:56:47 INFO - 'SHELL': '/bin/bash', 22:56:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.LdqRs4GF48/Listeners', 22:56:47 INFO - 'TMPDIR': '/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/', 22:56:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:56:47 INFO - 'USER': 'cltbld', 22:56:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:56:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:56:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:56:47 INFO - 'XPC_FLAGS': '0x0', 22:56:47 INFO - 'XPC_SERVICE_NAME': '0', 22:56:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 22:56:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:56:47 INFO - Downloading/unpacking blobuploader==1.2.4 22:56:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:56:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:56:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:56:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:56:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:56:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:56:50 INFO - Downloading blobuploader-1.2.4.tar.gz 22:56:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 22:56:50 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 22:56:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:56:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:56:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:56:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:56:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:56:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:56:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 22:56:50 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 22:56:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:56:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:56:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:56:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:56:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:56:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:56:51 INFO - Downloading docopt-0.6.1.tar.gz 22:56:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 22:56:51 INFO - Installing collected packages: blobuploader, requests, docopt 22:56:51 INFO - Running setup.py install for blobuploader 22:56:51 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 22:56:51 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 22:56:51 INFO - Running setup.py install for requests 22:56:52 INFO - Running setup.py install for docopt 22:56:52 INFO - Successfully installed blobuploader requests docopt 22:56:52 INFO - Cleaning up... 22:56:52 INFO - Return code: 0 22:56:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:56:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:56:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:56:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:56:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:56:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:56:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:56:52 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 0x1079b9490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10792f570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa969594420>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1077cdd30>, '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 0x1075f3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1077c5b20>, '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.09ArzxQ1TO/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.LdqRs4GF48/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 22:56:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 22:56:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 22:56:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.09ArzxQ1TO/Render', 22:56:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:56:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:56:52 INFO - 'HOME': '/Users/cltbld', 22:56:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:56:52 INFO - 'LOGNAME': 'cltbld', 22:56:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:56:52 INFO - 'MOZ_NO_REMOTE': '1', 22:56:52 INFO - 'NO_EM_RESTART': '1', 22:56:52 INFO - 'PAGER': '/bin/cat', 22:56:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:56:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:56:52 INFO - 'PWD': '/builds/slave/test', 22:56:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:56:52 INFO - 'SHELL': '/bin/bash', 22:56:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.LdqRs4GF48/Listeners', 22:56:52 INFO - 'TMPDIR': '/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/', 22:56:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:56:52 INFO - 'USER': 'cltbld', 22:56:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:56:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:56:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:56:52 INFO - 'XPC_FLAGS': '0x0', 22:56:52 INFO - 'XPC_SERVICE_NAME': '0', 22:56:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 22:56:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:56:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:56:52 INFO - Running setup.py (path:/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/pip-mlMgd8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:56:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:56:52 INFO - Running setup.py (path:/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/pip-8QSyCF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:56:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:56:52 INFO - Running setup.py (path:/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/pip-1dx1Ay-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:56:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:56:52 INFO - Running setup.py (path:/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/pip-rJ_2Uv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:56:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:56:52 INFO - Running setup.py (path:/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/pip-f5Q6La-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:56:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:56:53 INFO - Running setup.py (path:/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/pip-zkmUCn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:56:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:56:53 INFO - Running setup.py (path:/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/pip-AsGrEz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:56:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:56:53 INFO - Running setup.py (path:/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/pip-q3gbM_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:56:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:56:53 INFO - Running setup.py (path:/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/pip-Zoz_2i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:56:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:56:53 INFO - Running setup.py (path:/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/pip-eNzvja-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:56:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:56:53 INFO - Running setup.py (path:/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/pip-fJaLX3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:56:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:56:53 INFO - Running setup.py (path:/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/pip-9mbJPu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:56:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:56:53 INFO - Running setup.py (path:/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/pip-ltGp5h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:56:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:56:53 INFO - Running setup.py (path:/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/pip-_bPJ7B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:56:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:56:54 INFO - Running setup.py (path:/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/pip-8pVxzV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:56:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:56:54 INFO - Running setup.py (path:/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/pip-tyRexq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:56:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:56:54 INFO - Running setup.py (path:/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/pip-EJYlYQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:56:54 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 22:56:54 INFO - Running setup.py install for manifestparser 22:56:54 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 22:56:54 INFO - Running setup.py install for mozcrash 22:56:54 INFO - Running setup.py install for mozdebug 22:56:54 INFO - Running setup.py install for mozdevice 22:56:54 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 22:56:54 INFO - Installing dm script to /builds/slave/test/build/venv/bin 22:56:54 INFO - Running setup.py install for mozfile 22:56:55 INFO - Running setup.py install for mozhttpd 22:56:55 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 22:56:55 INFO - Running setup.py install for mozinfo 22:56:55 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 22:56:55 INFO - Running setup.py install for mozInstall 22:56:55 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 22:56:55 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 22:56:55 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 22:56:55 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 22:56:55 INFO - Running setup.py install for mozleak 22:56:55 INFO - Running setup.py install for mozlog 22:56:55 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 22:56:55 INFO - Running setup.py install for moznetwork 22:56:56 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 22:56:56 INFO - Running setup.py install for mozprocess 22:56:56 INFO - Running setup.py install for mozprofile 22:56:56 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 22:56:56 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 22:56:56 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 22:56:56 INFO - Running setup.py install for mozrunner 22:56:56 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 22:56:56 INFO - Running setup.py install for mozscreenshot 22:56:56 INFO - Running setup.py install for moztest 22:56:56 INFO - Running setup.py install for mozversion 22:56:56 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 22:56:56 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 22:56:56 INFO - Cleaning up... 22:56:56 INFO - Return code: 0 22:56:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:56:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:56:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:56:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:56:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:56:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:56:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:56:56 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 0x1079b9490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10792f570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa969594420>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1077cdd30>, '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 0x1075f3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1077c5b20>, '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.09ArzxQ1TO/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.LdqRs4GF48/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 22:56:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 22:56:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 22:56:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.09ArzxQ1TO/Render', 22:56:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:56:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:56:56 INFO - 'HOME': '/Users/cltbld', 22:56:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:56:56 INFO - 'LOGNAME': 'cltbld', 22:56:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:56:56 INFO - 'MOZ_NO_REMOTE': '1', 22:56:56 INFO - 'NO_EM_RESTART': '1', 22:56:56 INFO - 'PAGER': '/bin/cat', 22:56:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:56:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:56:56 INFO - 'PWD': '/builds/slave/test', 22:56:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:56:56 INFO - 'SHELL': '/bin/bash', 22:56:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.LdqRs4GF48/Listeners', 22:56:56 INFO - 'TMPDIR': '/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/', 22:56:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:56:56 INFO - 'USER': 'cltbld', 22:56:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:56:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:56:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:56:56 INFO - 'XPC_FLAGS': '0x0', 22:56:56 INFO - 'XPC_SERVICE_NAME': '0', 22:56:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 22:56:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:56:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:56:57 INFO - Running setup.py (path:/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/pip-ZwYCeF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:56:57 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 22:56:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:56:57 INFO - Running setup.py (path:/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/pip-td9Y0g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:56:57 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)) 22:56:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:56:57 INFO - Running setup.py (path:/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/pip-Qi4YEu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:56:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 22:56:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:56:57 INFO - Running setup.py (path:/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/pip-cqDnEj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:56:57 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)) 22:56:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:56:57 INFO - Running setup.py (path:/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/pip-tnEznn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:56:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 22:56:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:56:57 INFO - Running setup.py (path:/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/pip-lfxeiE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:56:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 22:56:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:56:57 INFO - Running setup.py (path:/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/pip-dphsEj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:56:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 22:56:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:56:57 INFO - Running setup.py (path:/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/pip-BnORY8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:56:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 22:56:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:56:58 INFO - Running setup.py (path:/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/pip-WXTaSK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:56:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 22:56:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:56:58 INFO - Running setup.py (path:/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/pip-hjTP_4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:56:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 22:56:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:56:58 INFO - Running setup.py (path:/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/pip-xiRXVR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:56:58 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 22:56:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:56:58 INFO - Running setup.py (path:/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/pip-Wz0JxL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:56:58 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)) 22:56:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:56:58 INFO - Running setup.py (path:/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/pip-pBhHmJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:56:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 22:56:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:56:58 INFO - Running setup.py (path:/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/pip-LJaaKr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:56:58 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)) 22:56:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:56:58 INFO - Running setup.py (path:/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/pip-ROt4cs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:56:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 22:56:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:56:58 INFO - Running setup.py (path:/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/pip-3XCoP1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:56:58 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)) 22:56:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:56:58 INFO - Running setup.py (path:/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/pip-pNr3QZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:56:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 22:56:59 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)) 22:56:59 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)) 22:56:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 22:56:59 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)) 22:56:59 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)) 22:56:59 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 22:56:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:56:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:56:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:56:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:56:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:56:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:57:01 INFO - Downloading blessings-1.6.tar.gz 22:57:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 22:57:01 INFO - Installing collected packages: blessings 22:57:01 INFO - Running setup.py install for blessings 22:57:01 INFO - Successfully installed blessings 22:57:01 INFO - Cleaning up... 22:57:01 INFO - Return code: 0 22:57:01 INFO - Done creating virtualenv /builds/slave/test/build/venv. 22:57:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:57:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:57:02 INFO - Reading from file tmpfile_stdout 22:57:02 INFO - Current package versions: 22:57:02 INFO - blessings == 1.6 22:57:02 INFO - blobuploader == 1.2.4 22:57:02 INFO - docopt == 0.6.1 22:57:02 INFO - functools32 == 3.2.3-2 22:57:02 INFO - jsonschema == 2.5.1 22:57:02 INFO - manifestparser == 1.1 22:57:02 INFO - mozInstall == 1.12 22:57:02 INFO - mozcrash == 0.17 22:57:02 INFO - mozdebug == 0.1 22:57:02 INFO - mozdevice == 0.48 22:57:02 INFO - mozfile == 1.2 22:57:02 INFO - mozhttpd == 0.7 22:57:02 INFO - mozinfo == 0.9 22:57:02 INFO - mozleak == 0.1 22:57:02 INFO - mozlog == 3.4 22:57:02 INFO - moznetwork == 0.27 22:57:02 INFO - mozprocess == 0.23 22:57:02 INFO - mozprofile == 0.28 22:57:02 INFO - mozrunner == 6.12 22:57:02 INFO - mozscreenshot == 0.1 22:57:02 INFO - mozsystemmonitor == 0.3 22:57:02 INFO - moztest == 0.7 22:57:02 INFO - mozversion == 1.4 22:57:02 INFO - psutil == 3.1.1 22:57:02 INFO - requests == 1.2.3 22:57:02 INFO - wsgiref == 0.1.2 22:57:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:57:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:57:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:57:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:57:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:57:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:57:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:57:02 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 0x1079b9490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10792f570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa969594420>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1077cdd30>, '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 0x1075f3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1077c5b20>, '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.09ArzxQ1TO/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.LdqRs4GF48/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 22:57:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 22:57:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 22:57:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.09ArzxQ1TO/Render', 22:57:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:57:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:57:02 INFO - 'HOME': '/Users/cltbld', 22:57:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:57:02 INFO - 'LOGNAME': 'cltbld', 22:57:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:57:02 INFO - 'MOZ_NO_REMOTE': '1', 22:57:02 INFO - 'NO_EM_RESTART': '1', 22:57:02 INFO - 'PAGER': '/bin/cat', 22:57:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:57:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:57:02 INFO - 'PWD': '/builds/slave/test', 22:57:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:57:02 INFO - 'SHELL': '/bin/bash', 22:57:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.LdqRs4GF48/Listeners', 22:57:02 INFO - 'TMPDIR': '/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/', 22:57:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:57:02 INFO - 'USER': 'cltbld', 22:57:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:57:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:57:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:57:02 INFO - 'XPC_FLAGS': '0x0', 22:57:02 INFO - 'XPC_SERVICE_NAME': '0', 22:57:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 22:57:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:57:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 22:57:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 22:57:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 22:57:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 22:57:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 22:57:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 22:57:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 22:57:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 22:57:02 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 22:57:02 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 22:57:02 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 22:57:02 INFO - Cleaning up... 22:57:02 INFO - Return code: 0 22:57:02 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 22:57:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:57:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:57:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:57:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:57:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:57:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:57:02 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 0x1079b9490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10792f570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa969594420>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1077cdd30>, '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 0x1075f3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1077c5b20>, '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.09ArzxQ1TO/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.LdqRs4GF48/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 22:57:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 22:57:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 22:57:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.09ArzxQ1TO/Render', 22:57:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:57:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:57:02 INFO - 'HOME': '/Users/cltbld', 22:57:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:57:02 INFO - 'LOGNAME': 'cltbld', 22:57:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:57:02 INFO - 'MOZ_NO_REMOTE': '1', 22:57:02 INFO - 'NO_EM_RESTART': '1', 22:57:02 INFO - 'PAGER': '/bin/cat', 22:57:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:57:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:57:02 INFO - 'PWD': '/builds/slave/test', 22:57:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:57:02 INFO - 'SHELL': '/bin/bash', 22:57:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.LdqRs4GF48/Listeners', 22:57:02 INFO - 'TMPDIR': '/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/', 22:57:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:57:02 INFO - 'USER': 'cltbld', 22:57:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:57:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:57:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:57:02 INFO - 'XPC_FLAGS': '0x0', 22:57:02 INFO - 'XPC_SERVICE_NAME': '0', 22:57:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 22:57:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:57:02 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 22:57:02 INFO - Cleaning up... 22:57:02 INFO - Return code: 0 22:57:02 INFO - Running post-action listener: _resource_record_post_action 22:57:02 INFO - Running post-action listener: _start_resource_monitoring 22:57:02 INFO - Starting resource monitoring. 22:57:02 INFO - [mozharness: 2016-09-22 05:57:02.666468Z] Finished create-virtualenv step (success) 22:57:02 INFO - [mozharness: 2016-09-22 05:57:02.667439Z] Running install step. 22:57:02 INFO - Running pre-action listener: _resource_record_pre_action 22:57:02 INFO - Running main action method: install 22:57:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:57:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:57:02 INFO - Reading from file tmpfile_stdout 22:57:02 INFO - Detecting whether we're running mozinstall >=1.0... 22:57:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 22:57:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 22:57:03 INFO - Reading from file tmpfile_stdout 22:57:03 INFO - Output received: 22:57:03 INFO - Usage: mozinstall [options] installer 22:57:03 INFO - Options: 22:57:03 INFO - -h, --help show this help message and exit 22:57:03 INFO - -d DEST, --destination=DEST 22:57:03 INFO - Directory to install application into. [default: 22:57:03 INFO - "/builds/slave/test"] 22:57:03 INFO - --app=APP Application being installed. [default: firefox] 22:57:03 INFO - mkdir: /builds/slave/test/build/application 22:57:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 22:57:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 22:57:36 INFO - Reading from file tmpfile_stdout 22:57:36 INFO - Output received: 22:57:36 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 22:57:36 INFO - Running post-action listener: _resource_record_post_action 22:57:36 INFO - [mozharness: 2016-09-22 05:57:36.969828Z] Finished install step (success) 22:57:36 INFO - [mozharness: 2016-09-22 05:57:36.970031Z] Running run-tests step. 22:57:36 INFO - Running pre-action listener: _resource_record_pre_action 22:57:36 INFO - Running main action method: run_tests 22:57:36 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 22:57:36 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 22:57:36 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 22:57:36 INFO - 2016-09-21 22:57:36.984 screenresolution[1646:7497] starting screenresolution argv=screenresolution get 22:57:36 INFO - 2016-09-21 22:57:36.987 screenresolution[1646:7497] Display 0: 1600x1200x32@60 22:57:36 INFO - 2016-09-21 22:57:36.992 screenresolution[1647:7499] starting screenresolution argv=screenresolution list 22:57:36 INFO - Available Modes on Display 0 22:57:36 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 22:57:36 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 22:57:36 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 22:57:36 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 22:57:37 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 22:57:37 INFO - Intel Iris: 22:57:37 INFO - Chipset Model: Intel Iris 22:57:37 INFO - Type: GPU 22:57:37 INFO - Bus: Built-In 22:57:37 INFO - VRAM (Dynamic, Max): 1536 MB 22:57:37 INFO - Vendor: Intel (0x8086) 22:57:37 INFO - Device ID: 0x0a2e 22:57:37 INFO - Revision ID: 0x0009 22:57:37 INFO - Displays: 22:57:37 INFO - Display: 22:57:37 INFO - Resolution: 1600 x 1200 @ 60 Hz 22:57:37 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 22:57:37 INFO - Display Serial Number: 1600x1200 60 22:57:37 INFO - Main Display: Yes 22:57:37 INFO - Mirror: Off 22:57:37 INFO - Online: Yes 22:57:37 INFO - Rotation: Supported 22:57:37 INFO - Return code: 0 22:57:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 22:57:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 22:57:37 INFO - Python 2.7.3 22:57:37 INFO - Return code: 0 22:57:37 INFO - grabbing minidump binary from tooltool 22:57:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:57:37 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 0x1077cdd30>, '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 0x1075f3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1077c5b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 22:57:37 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 22:57:37 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 22:57:37 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 22:57:37 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 22:57:37 INFO - Return code: 0 22:57:37 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 22:57:37 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 22:57:37 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 22:57:37 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 22:57:37 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 22:57:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/IGAcqI8aQ9CpppxwgGmqAA/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0169', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 22:57:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Autoland --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/IGAcqI8aQ9CpppxwgGmqAA/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0169 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 22:57:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.09ArzxQ1TO/Render', 22:57:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:57:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:57:37 INFO - 'HOME': '/Users/cltbld', 22:57:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:57:37 INFO - 'LOGNAME': 'cltbld', 22:57:37 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 22:57:37 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 22:57:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:57:37 INFO - 'MOZ_NO_REMOTE': '1', 22:57:37 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 22:57:37 INFO - 'NO_EM_RESTART': '1', 22:57:37 INFO - 'PAGER': '/bin/cat', 22:57:37 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:57:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:57:37 INFO - 'PWD': '/builds/slave/test', 22:57:37 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 22:57:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:57:37 INFO - 'SHELL': '/bin/bash', 22:57:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.LdqRs4GF48/Listeners', 22:57:37 INFO - 'TMPDIR': '/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/', 22:57:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:57:37 INFO - 'USER': 'cltbld', 22:57:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:57:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:57:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:57:37 INFO - 'XPC_FLAGS': '0x0', 22:57:37 INFO - 'XPC_SERVICE_NAME': '0', 22:57:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 22:57:37 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/IGAcqI8aQ9CpppxwgGmqAA/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0169', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 22:57:37 INFO - mozversion application_buildid: 20160921205400 22:57:37 INFO - mozversion application_changeset: 86a6a947fd9bead62ba068bb8faa4790d57f806b 22:57:37 INFO - mozversion application_display_name: Nightly 22:57:37 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 22:57:37 INFO - mozversion application_name: Firefox 22:57:37 INFO - mozversion application_remotingname: firefox 22:57:37 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 22:57:37 INFO - mozversion application_vendor: Mozilla 22:57:37 INFO - mozversion application_version: 52.0a1 22:57:37 INFO - mozversion platform_buildid: 20160921205400 22:57:37 INFO - mozversion platform_changeset: 86a6a947fd9bead62ba068bb8faa4790d57f806b 22:57:37 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 22:57:37 INFO - mozversion platform_version: 52.0a1 22:57:37 INFO - using testdate: 1474523857 22:57:37 INFO - actual date: 1474523857 22:57:37 INFO - starting webserver on 'localhost:49273' 22:57:37 INFO - SUITE-START | Running 2 tests 22:57:37 INFO - TEST-START | dromaeo_css 22:57:37 INFO - operating with platform_type : mac_ 22:57:37 INFO - Initialising browser for dromaeo_css test... 22:57:37 INFO - TEST-INFO | started process 1657 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/tmpw56cvT/profile http://localhost:49273/getInfo.html) 22:57:40 INFO - PROCESS | 1657 | __metrics Screen width/height:1600/1200 22:57:40 INFO - PROCESS | 1657 | colorDepth:24 22:57:40 INFO - PROCESS | 1657 | Browser inner width/height: 1024/689 22:57:40 INFO - PROCESS | 1657 | __metrics 22:57:40 INFO - PROCESS | 1657 | 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" 22:57:40 INFO - PROCESS | 1657 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 22:57:40 INFO - TEST-INFO | 1657: exit 0 22:57:40 INFO - Browser initialized. 22:57:40 INFO - Running cycle 1/1 for dromaeo_css test... 22:57:40 INFO - TEST-INFO | started process 1659 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/tmpw56cvT/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:57:52 INFO - PROCESS | 1659 | RSS: Main: 235307008 22:57:52 INFO - PROCESS | 1659 | 22:58:44 INFO - PROCESS | 1659 | 1474523924678 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] 23:00:55 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49273/tests/dromaeo/cssquery-ext.html) 23:00:57 INFO - PROCESS | 1659 | RSS: Main: 378281984 23:00:57 INFO - PROCESS | 1659 | 23:04:00 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-ext.html (next: http://localhost:49273/tests/dromaeo/cssquery-jquery.html) 23:04:00 INFO - PROCESS | 1659 | RSS: Main: 372088832 23:04:00 INFO - PROCESS | 1659 | 23:07:03 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49273/tests/dromaeo/cssquery-mootools.html) 23:07:03 INFO - PROCESS | 1659 | RSS: Main: 361127936 23:07:03 INFO - PROCESS | 1659 | 23:10:05 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49273/tests/dromaeo/cssquery-prototype.html) 23:10:06 INFO - PROCESS | 1659 | RSS: Main: 333590528 23:10:06 INFO - PROCESS | 1659 | 23:13:09 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49273/tests/dromaeo/cssquery-yui.html) 23:13:10 INFO - PROCESS | 1659 | RSS: Main: 326901760 23:13:10 INFO - PROCESS | 1659 | 23:16:13 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-yui.html (next: http://localhost:49273/tests/dromaeo/cssquery-dojo.html) 23:16:13 INFO - PROCESS | 1659 | RSS: Main: 650784768 23:16:13 INFO - PROCESS | 1659 | 23:16:13 INFO - PROCESS | 1659 | __start_tp_report 23:16:13 INFO - PROCESS | 1659 | _x_x_mozilla_page_load 23:16:13 INFO - PROCESS | 1659 | _x_x_mozilla_page_load_details 23:16:13 INFO - PROCESS | 1659 | |i|pagename|runs| 23:16:13 INFO - PROCESS | 1659 | |0;dojo.html;3307.6692330766928;3326.966730332697;3333.683300086491;3370.3090866372395;3403.251284717361;5602.1596760485945;5607.467290607386;5696.886062278762;5710.828675139747;5717.3139223293265;5652.604317697763;5681;5694.715264236782;5729.856753581163;5762.164486149516;5125.615578831603;5129.692218466904;5132.948670513303;5191.740412979355;5230.921536176941;5313.73431328434;5315.627906046579;5330.706811125387;5341.4658534146665;5351.143816989283;5124.846254612367;5283.86790330241;5286.709230992294;5293.735313234342;5390.811321603745;5167.48325167484;5193.039287731782;5238.921416178722;5248.370195576517;5255;5171.482851714836;5225.634205605609;5228.92156617651;5229.503197196298;5297.735113244323;5719.113537401709;5722.998475266853;5742.224799652077;5760;5765.106408506688;6096.362824393382;6123.479504242145;6132.233136608343;6140.385961403868;6149.262088549358;6167;6235.469985051276;6243.032329988859;6261.342559031327;6267.59260648061;5676.886462270814;5731.037082597544;5753.309602847643;5757.510611598061;5799.304083509964;6185.474234690012;6193.628382297076;6255.374462553799;6261.624302541771;6284.780032698834;6119.502553941512;6142.928535732134;6209.844753881189;6218;6221.968890155611;6247.031710084944;6258.15514905491;6270.561060725797;6275.090111933835;6277.591956522811;6090.878182436415;6143.1706719592285;6192.133101365813;6248.656323902229;6251.343608921089;6142.468080853438;6164.47601953839;6196.256449226122;6205.03821907605;6211.751529938842;4890.877728056756;4910.607151427948;4913.140200464904;4959.008198360342;5019.447860735316;4390.363397307437;4412.801423935931;4437.64498840092;4438.045820148684;4461.08547747711;5619.129034999582;5757.596968212269;5787.942120578825;5799.5070419014855;5829.854253643608;6144.003198960356;6195.659238741822;6198;6217.533684973645;6241.594296370721;5775;5792.333881603669;5801.564882633735;5808.651480911159;5808.941910580925;5408.567314614821;5424.267723857229;5426.050441172779;5432.728363581805;5434.945650543523;6195.938040619536;6217.875642487125;6245.5628106032145;6258.374162583706;6275;6285.402886725754;6287.685615719287;6289;6299.401556852092;6309.747610095545;6220.595661282002;6253.843653908689;6264.467520260829;6271.529635277281;6288.402601752826;6024.7288872001745;6075.969620151871;6094.229520225711;6115.2278529517625;6126.700892189639;6277.089821975879;6287.874242515216;6298.9921612541775;6310.400511951358;6310.52671049664;6148.292946311231;6163.599366041193;6166.784162554289;6170.722317495633;6177.752889884354;5095.464976177448;5676.290463692038;6083.178770865877;6107.480864126599;6154.599951003171;6026.849328766816;6036.215292012011;6050.515958723379;6077.845209410198;6115.327313995546;6114.2357205349335;6170.074488826533;6170.50635949132;6179.134921110958;6183.443490085914;4620.445546534303;5850.034744267318;5896.941030589811;5957.778655375551;6025.337212906665 23:16:13 INFO - PROCESS | 1659 | |1;ext.html;469.39448111935604;475.43660761997035;497.94932692019853;543.6629289840299;554.9926882707888;30814;31049;32628.67371326289;40230.396544051866;41342.55301064463;43318.35022474665;43626.563734362644;43633.7818310908;43703.78148109263;43877.12245755083;9761.7559561011;9931.751706207366;9957.203423726085;9976.650817221398;9981.600735970553;8807.119288071206;8980.416272942239;9840.950795246014;12023.579174728886;12231.143819932608;11934.582289619864;12144;12287.815682764765;12330.691732706664;12372.010239180843;12061.155719099666;12112.81830772539;12122.212056216318;12128.939355303255;12145.089118316073;8796.384253102286;9008.549572521413;11676.883231167665;11980.28118312904;11981.940090299493;40803.38794918079;41248.38127428091;41296.79351603223;41309.380359294635;41325;3262.2822978944596;3531.3820081485637;3564.41187204111;3746.250749850041;4077.4291599175845;30668.079957601083;30935.535966960513;31671.683283167105;31723;31862;3276.3774882772195;3303.8513266903046;3357.983210083934;3360.1263671445354;3392.3893699134146;501213;502088;502261;502902;503363;57466.13800792991;57755;57783.42216577865;57787.13319300214;57967;62755;62792.686036569525;62831.6858415705;62960;63003.684981575716;16326.836731632531;16536.83463165377;16572.254248558846;16585.50243492697;16622.50132496027;9343.439393636403;11621.76756464883;12892.742145157044;12906.741865162645;12960.80558791619;14652.853471465149;15093.849061509245;15094.24528773557;15108.017978831342;15112.697746045018;4927.630427717864;6079.848003799941;6229.719662615194;6233.875322493615;6351.936480635227;851.6210286422606;890.5636238243214;902.634433054614;919.8068405634758;1047.1831971062584;24024.51950960971;26470;29487;29801.701982980325;32220.19449513734;1021.9080282774586;1132.3375825142218;1136.2387200575633;1138.886111388871;1178.6780043314657;15105.169215693022;15575.610609734847;15694.450694225647;15729;16076.517704468884;665650;667787;669109;669446;669449;50292;50336.99326013459;50502.747486262335;57661.8467630645;58027.4197258022;1368.261138984937;1383.3843939447052;1412.315027211822;1416.3201663201926;1419.049237011205;27440.41327358526;29374.55938160972;30545.389092218476;31855;32358.35283294274;51440.97118057543;51878.96242075062;51988.74005630099;52004.219936700225;52024.479755201966;609150;623453;626742;634753;866455;25298.11456599084;25529;25545.912653975276;25891.09381171725;25894;33616.49575256324;45947.77026114848;46063.309050364944;46649.766751167386;46876;38565.4215186778;38640;38660.033499162746;39507;40049.399259010555;37396.00831933384;37678.434823478216;37838.24323513459;39129.608703913735;39227.215455691294;31557.211069723442;37230.8138459306;38308.80845595754;38346.42480362853;38469;30792.076237712903;31673.5248971261;31740.523892142097;34197;34295;19431;25126.371840704127;25340.11309604155;25511.65065990447;25632 23:16:13 INFO - PROCESS | 1659 | |2;jquery.html;350.85965613754496;355.75808450253817;376.6722951032602;381.711807585273;403.53996444053786;15361.53915382539;15618;16626.25181866816;19419.44644428446;20915.37253882382;18506.814931850677;20155.093020814063;20981.68527472089;20990.580188396223;21205.893970530127;4969.2049272116465;5928.140419639139;6192.659403732793;6210.65841378724;6214.5649804513705;6090.33006369299;6137.355577664348;6210.1616281801835;6211.751529938797;6214;5970.761169553212;6063.787767428141;6067.575269731121;6158.107074474198;6161.199044124258;6044.214252147215;6115.785947491817;6116.296625888035;6120.44915957566;6122.908156377658;5148.227765835118;5288.101022826128;5442.510174084312;5492.780288788444;5537.923278770461;12858.742825143445;13151;13155.342232888317;22058.4485387865;24638.753612463825;2157.1802714968367;2167.371462275938;2263.581237471073;2265.150568536799;2266.3654176830514;9774.218062554979;9776.413415195111;9831.950840245825;10299.897001029969;10327.535260913277;1771.8139595342432;1779.87540872139;1792.2830867652913;1843.5620216231362;1865.3657756362766;108540.4572977138;117178.41410792891;120755;121219.18171227438;122018;8966.251580941655;9050.954745226363;9098.909010909938;9553.901301350434;11209.831852522218;14504.34730437133;14531.709365812836;14534.982551221314;14539.200343981183;14544.854551454562;8343.374246931384;8507.106753790888;8511.398131063646;8533.615987280464;8650.610722517502;8505.65977360911;8510.531920744419;8528.957355213184;8673.436226645248;8734.694285700098;4469.575390337913;4484.461864576207;4488.775561221926;4494.303382975644;4573.702709323883;1723.3106757297182;1823.5349985753548;1886.1135266424758;1892.6593213221477;1894.4316704988723;722.2524686948983;733.6955163607043;826.9421140520226;876.8114855306139;981.032377059401;19817.900910495642;21801.67297490539;21804.45488862791;21935.903204839695;22009;951.4006176109007;953.9856902146473;963.7783309838636;968.1093394077466;983.6409710455632;9421.717348479557;10495.897930717165;11084.722881928017;11448.255863368855;11466.656000320003;577891;580565;585893;586876;595140;75973;76785.61607191928;94449.0555094454;132151;137381.31309343388;902.7246689759555;955.2310390135868;974.3228456222857;974.5078735238659;978.2467500024941;19601.70597441011;19898.801011989694;19973.400797976083;19995.500112497302;20007.099680514122;53386.4661353397;54128;55064.44935550753;55566;56208.43791562032;80993;81735.18264817276;86205.56897215724;86550;86951.34816236925;5960.791372301948;8027.83944321122;8070.273675369245;8209.83580328402;8251.504909705436;9694;12725.236485810881;12973.286469244282;13300.534481293109;13332.133411328232;11235.88776090821;11591.826122608;11647.941760291144;11696.06431485496;11739.765204696028;10662.520186591777;10675.199360047873;10832.67501974942;11424.828627570427;11702.648920532398;11092.500837462496;11426.314421134759;11568.652940411801;11607.941960290145;11752.177347585586;7897.959082504299;7951.920480795118;8098.473599216032;8243.917560824555;8295.834083318421;10121.342112762646;10872.08694483302;11306.530151080307;11452.82820757706;11500.94249528747 23:16:13 INFO - PROCESS | 1659 | |3;mootools.html;1530.6862093270881;1555.7121932442499;1694.5594145522161;1797.8022417534069;1863.3571417860833;7248.855022899539;8441.704540341088;8964.148405901436;8976.281897448205;9179.357444978854;7846.215378462165;8057.95971020144;8101.635426405811;8501.78745531362;8761.56192190391;2363.0665886974593;2403.0748161957686;2403.879806009701;2404.326788499223;2409.518096380722;2375.2043065573052;2378.1438682074527;2388.6297623868327;2406.2179791567723;2414.0947144820693;2047.5188330742264;2334.8092472838803;2382.916597919073;2390.3904504351453;2391.868447235401;2353.7646235376324;2372.0511795281855;2379.5716770981217;2380.6429035644705;2381.9642705359433;2331.895064722092;2341.1220792202926;2343.086196383395;2346.601077816775;2350.847194932324;8784.780380490474;8810.735677929672;8864.468131912041;8870.37907346486;8885.289176865836;5236.581073514109;5406.324209473816;5411.242426060355;5412.9458705412835;5417.349918009864;3436.896893093211;3508.7543871928974;3625.2024554597947;3659.3413185626578;3666.8533258669886;1090.0571006079683;1093.7858976536038;1102.979743737048;1124.6738445850694;1125.0718157519998;11829.585964491202;11883;11901.226420282741;11912.761744765055;11921.642350729491;4549.499555048942;4620.584147426748;4802.519748025239;4816.662833601615;4827.589654879304;9941.155001824782;9952.950235248778;9956;9959.103680668775;9969.55137018836;5374.516293533601;5381.219723140122;5382.03123437785;5382.515573598395;5385.353757549119;4397.648188144941;4514.616257618073;4852.272159176152;4909.582685471775;4923.532264434873;3795.35478968576;3872.4772155759174;3990.900227494336;3991.5210174779213;3997.8200980955344;1046.670298855858;1240.3674126195706;1240.9193402428814;1283.0697744135614;1301.9088663793443;761.1665226576889;861.5562985062697;864.8745931839974;905.8188362327561;942.2603256443659;5687.8862422752145;5747.39652336507;5878.588498805043;5897.823065308047;6074.876147912651;909.663424532927;945.6784693204344;953.9809203816023;966.8018056298442;1011.6661501704419;3940.7832569208967;3953.5453422856162;3957.109650328653;4029.81865816039;4064.918701625951;10828.187885908588;11026.779464410667;11042.723931901606;11047.83428248577;11077.446127693584;10253.436061016566;10946.835797463045;10952.233343665866;10971.561137554569;10975.50610222542;7880.921190788134;8216.671333146607;8216.712415065444;8224.218699223564;8230.547319897343;5823.213866128019;5832.533397328289;5902.911456328073;6062.818115456544;6189.845253868509;9903.752406189902;10052.69841904744;10168.796624067329;10179.7455063624;10324.277300588887;10125.443100629536;10170.440625765654;10229;10382.117520010883;10392.532336044746;5685.800996965087;6994.755183568551;7200;7499.437542184467;7674.117476490275;8376.03675577292;8543.829123417372;8573.18554737299;8574.09971952961;8580.14198580137;6804.5710400814405;7276.563406195645;7465.029546159182;7580.317771400601;7711.6915323388685;7130.714771409085;7258.782236532912;7337.6698048589005;7379.963100184465;7470.514416562906;6888.896666549906;6904.171499420102;6976.093107895941;6988.161420629353;6992.195897471653;4979.576735977483;5016.570277470903;5025.974870125626;5056.721880296619;5118.232265160255;4860.513948605111;4960.8759781005765;5017.949820501748;5102.69383836971;5179.741012949413 23:16:13 INFO - PROCESS | 1659 | |4;prototype.html;267.2996748518881;305.3404645964715;313.42486537204223;316.7070459824663;322.75309388317953;4388.319810429381;5157.277981082651;5317.378199649115;5446.509814116734;5477.425609963316;4687.742174180418;4694.554017368353;4935.79173537201;4987.800487980477;5245.763940622672;3364.693192713331;4070.8778736637946;4090.468239128924;4095.9795201023953;4103.528094269167;3206.022163240211;3530.7642325186107;3694.538182727159;4091.243120022805;4094.529129150141;3491.982540087296;3544.5746510418785;4004.9599504004877;4030.415589739486;4034.616711412411;3441.397755392809;3487.7558570900046;3815.9046023849346;4040.515138183422;4056.492938382702;3366.4613661814237;3515.806630635314;3524.259905419865;3539;3542.9114272143147;4217.768022758747;4858.327919644217;5189.2875351134035;5252.212168174766;5271.947280527184;4579.763463864771;4601.608863246594;4605.927332700265;4611.631069514465;4628.320485214263;4507.639388848917;5337.784819299985;5561.888762224773;5592.5246354059955;5607.663540187561;3560.2910602910747;3772.320982223199;3809.8476060957805;3815.5802861685193;3829.9042523936846;4835.734034628129;5879.1475236090955;5951.2858456985;5977.6114552553945;5981.760729570812;3436.261203841186;3899.557163849394;3900.4398240703945;3914.0448961034235;3920.882373528799;3839.138018061238;3969.166475040274;3985.4021896715726;3985.501812273466;4000;4571.794269257892;4599.586037256596;4604.493505714368;4607.378003969421;4644.930326045112;4708.505606911293;4934.963657631937;5683.602147849693;5726.341470730919;5729.28383952006;1214.5445457953267;1227.711487800384;1236.70146346336;1266.7656483550572;1352.2765320553654;683.54885775388;683.596677960006;798.7523867600946;800.8427821797563;828.3207769628967;4444.222311075531;4465.397171381886;4468.597826195658;4483.686141970031;4505.4544182536765;4154.216674827872;4216.873493795191;4791.209450440708;4880.438749543777;4956.951474843017;4458.818413120525;4885.975570122127;5360.901015291855;5370.865728356823;5404.756785944642;3030.5151175811766;3065.7853950223716;3069.6469905960653;3071.6467606225124;3071.66211716711;5768.826935191867;6018.074216250758;6096.329403765582;6124.234470691164;6159.722812473449;4825.252085926687;5065.493450654979;5365.892682146336;5957.79147729836;6081.6351018939;4974.950250497449;5483.437220392169;6059.7273122709585;6075.635461872302;6095.2685677718955;5550.888982220414;5779.739911703899;5843.152742852348;5872.504185721137;5887.3523912370465;4842.806287748451;5768.625039372428;5788.176724331822;5790.420957904176;5820.738066787089;5054.620903432184;5083.694978301313;5733.846384488598;6078.422549857756;6093.512518998381;3806.4480650306105;3834.0606551395085;3886.0090676877217;3887.3002859485564;3900.278448487039;5007.899842003212;5055.848324550269;5166.295122609605;5855.707214639337;5862.648241105548;5321.627486075938;5620.718964051699;5687.203791469115;5709.942900570941;5724.627899186539;4709.576138147583;5691.516221121251;5755.8561035974435;5759.452851979056;5765.827025189251;4412.977935110304;4996.750162491933;5541.778328866801;5575.832725018256;5654.971725141348;5185.42960274377;5358.624066837867;5423.701696406735;5483.588730845123;5617.382087970402;5578.414266501959;5637.548996080386;5654.935948378894;5662.886742265214;5662.971685141548 23:16:13 INFO - PROCESS | 1659 | |5;yui.html;725.2276325713115;727.2364017781332;765.4450523370557;797.4298376660687;810.3679130278385;15492.845071549282;16363.918180409097;16366.590835229124;16376.344946202138;16389.91805040973;14688.412463501474;14844.777328340084;14870.33083511242;14873.330700118493;14888.553343399688;681.8806708825961;700.1493185779277;702.6451641920848;834.6661335465817;845.6490556419079;854.1885209051395;870.195069560657;878.8813510176141;879.3097418526459;881.7531091294416;930.50683137937;934.0985948559638;935.6304259817368;936.0405584276103;936.4802534593298;717.1179449277417;731.6085894046713;733.6258508160823;927.5918595817852;927.8561822917425;552.6822077305566;554.8446434998207;664.7673314339991;683.3235097253732;684.3293572299175;14940.402383904739;14971.251437428085;14973.251337433085;14981.775273370908;14997.17515536645;11407.600733974272;13967.65080872976;14148.717025659429;14175.362108705132;14493.057951233137;12383.938080309541;12621.684457888534;12786.296753678544;12964.416601252871;13112.180881110511;4031.8387264509383;4040.151568170688;4068.105016896278;4131.834726610962;4181.226473102486;111137;113908.86091139066;114355.42822285919;114522;115125;10906.890931090587;11203.271787333797;11313.321200727984;11325.433728313552;11347.489362978686;22378.32865014052;22431;22731.88634056819;22752.976116074817;22962.19632312861;7870.370370370357;7969.043714754266;7974.322182614543;7999.240072193133;8158.184181581913;4316.5467625899455;4374.496932852762;4409.14021765759;4464.508904020555;4485.798139083749;3379.2934568043474;3479.6520347965507;3486.0413386318965;3487.877924272638;3489.4242449995972;628.2868943748787;633.2622494793605;638.6391688695873;655.6426747422666;658.0688326018726;527.9704576076666;578.8292453726161;596.8507873031742;598.3986093975527;630.5775130662375;7501.887471687929;7590.607707263594;8381.95809020951;8992.775180620405;9346.205572526276;525.1823964430878;592.318833341652;616.9357857695439;623.5385814497279;640.7565125252468;4116.794160291974;4233.449651545279;4240.533541310453;4324.8486302979245;4424.292113261863;158615;162517;167050;169208;170739.80382550438;87121;102246;103349.48325258326;105588.47205763921;112653;96290.51854740681;99148.51277230847;100638;105140;106222.46888765506;9268.453492902321;9706.1828693898;9818.860840389816;9819.754506137404;9838.85830988026;58315.83368332694;58956.70521647536;59024.40975590189;61502.69248653728;61565.384346157756;87825.58267425194;90347;90517.54741226252;91476.54261728915;93243.06756932344;10118.848217276895;12795;13023.609291721263;13119;13190.538331158747;14598.5765018206;14852.7772083421;14952.318771763148;14981.700365992838;15081.849181508045;13269.901870134549;13375.398107085399;13563.321833908463;13594.796078059035;13741.14359844319;13270.867291326964;13545.039558763638;13581.3545467231;13772.793408099087;13975.720485590435;13547.932260338635;13699.109557878706;13715.862841371458;13775.931120344734;13864.168149911038;10921.344719316867;11385.316880987168;11419.257748246337;11437.42812859337;11808.76382472363;8146.877796832934;8485.363597730071;9044.728658140266;10418.218633602359;11436.599719009795 23:16:13 INFO - PROCESS | 1659 | __end_tp_report 23:16:13 INFO - PROCESS | 1659 | __start_cc_report 23:16:13 INFO - PROCESS | 1659 | _x_x_mozilla_cycle_collect,1284 23:16:13 INFO - PROCESS | 1659 | __end_cc_report 23:16:13 INFO - PROCESS | 1659 | __startTimestamp1474524973703__endTimestamp 23:16:13 INFO - PROCESS | 1659 | 23:16:13 INFO - PROCESS | 1659 | ------- Summary: start ------- 23:16:13 INFO - PROCESS | 1659 | Number of tests: 6 23:16:13 INFO - PROCESS | 1659 | 23:16:13 INFO - PROCESS | 1659 | [#0] dojo.html Cycles:165 Average:5740.90 Median:6025.34 stddev:638.58 (10.6%) stddev-sans-first:611.34 23:16:13 INFO - PROCESS | 1659 | Values: 3307.7 3327.0 3333.7 3370.3 3403.3 5602.2 5607.5 5696.9 5710.8 5717.3 5652.6 5681.0 5694.7 5729.9 5762.2 5125.6 5129.7 5132.9 5191.7 5230.9 5313.7 5315.6 5330.7 5341.5 5351.1 5124.8 5283.9 5286.7 5293.7 5390.8 5167.5 5193.0 5238.9 5248.4 5255.0 5171.5 5225.6 5228.9 5229.5 5297.7 5719.1 5723.0 5742.2 5760.0 5765.1 6096.4 6123.5 6132.2 6140.4 6149.3 6167.0 6235.5 6243.0 6261.3 6267.6 5676.9 5731.0 5753.3 5757.5 5799.3 6185.5 6193.6 6255.4 6261.6 6284.8 6119.5 6142.9 6209.8 6218.0 6222.0 6247.0 6258.2 6270.6 6275.1 6277.6 6090.9 6143.2 6192.1 6248.7 6251.3 6142.5 6164.5 6196.3 6205.0 6211.8 4890.9 4910.6 4913.1 4959.0 5019.4 4390.4 4412.8 4437.6 4438.0 4461.1 5619.1 5757.6 5787.9 5799.5 5829.9 6144.0 6195.7 6198.0 6217.5 6241.6 5775.0 5792.3 5801.6 5808.7 5808.9 5408.6 5424.3 5426.1 5432.7 5434.9 6195.9 6217.9 6245.6 6258.4 6275.0 6285.4 6287.7 6289.0 6299.4 6309.7 6220.6 6253.8 6264.5 6271.5 6288.4 6024.7 6076.0 6094.2 6115.2 6126.7 6277.1 6287.9 6299.0 6310.4 6310.5 6148.3 6163.6 6166.8 6170.7 6177.8 5095.5 5676.3 6083.2 6107.5 6154.6 6026.8 6036.2 6050.5 6077.8 6115.3 6114.2 6170.1 6170.5 6179.1 6183.4 4620.4 5850.0 5896.9 5957.8 6025.3 23:16:13 INFO - PROCESS | 1659 | 23:16:13 INFO - PROCESS | 1659 | [#1] ext.html Cycles:180 Average:73622.35 Median:20712.34 stddev:166772.02 (805.2%) stddev-sans-first:167149.42 23:16:13 INFO - PROCESS | 1659 | Values: 469.4 475.4 497.9 543.7 555.0 30814.0 31049.0 32628.7 40230.4 41342.6 43318.4 43626.6 43633.8 43703.8 43877.1 9761.8 9931.8 9957.2 9976.7 9981.6 8807.1 8980.4 9841.0 12023.6 12231.1 11934.6 12144.0 12287.8 12330.7 12372.0 12061.2 12112.8 12122.2 12128.9 12145.1 8796.4 9008.5 11676.9 11980.3 11981.9 40803.4 41248.4 41296.8 41309.4 41325.0 3262.3 3531.4 3564.4 3746.3 4077.4 30668.1 30935.5 31671.7 31723.0 31862.0 3276.4 3303.9 3358.0 3360.1 3392.4 501213.0 502088.0 502261.0 502902.0 503363.0 57466.1 57755.0 57783.4 57787.1 57967.0 62755.0 62792.7 62831.7 62960.0 63003.7 16326.8 16536.8 16572.3 16585.5 16622.5 9343.4 11621.8 12892.7 12906.7 12960.8 14652.9 15093.8 15094.2 15108.0 15112.7 4927.6 6079.8 6229.7 6233.9 6351.9 851.6 890.6 902.6 919.8 1047.2 24024.5 26470.0 29487.0 29801.7 32220.2 1021.9 1132.3 1136.2 1138.9 1178.7 15105.2 15575.6 15694.5 15729.0 16076.5 665650.0 667787.0 669109.0 669446.0 669449.0 50292.0 50337.0 50502.7 57661.8 58027.4 1368.3 1383.4 1412.3 1416.3 1419.0 27440.4 29374.6 30545.4 31855.0 32358.4 51441.0 51879.0 51988.7 52004.2 52024.5 609150.0 623453.0 626742.0 634753.0 866455.0 25298.1 25529.0 25545.9 25891.1 25894.0 33616.5 45947.8 46063.3 46649.8 46876.0 38565.4 38640.0 38660.0 39507.0 40049.4 37396.0 37678.4 37838.2 39129.6 39227.2 31557.2 37230.8 38308.8 38346.4 38469.0 30792.1 31673.5 31740.5 34197.0 34295.0 19431.0 25126.4 25340.1 25511.7 25632.0 23:16:13 INFO - PROCESS | 1659 | 23:16:13 INFO - PROCESS | 1659 | [#2] jquery.html Cycles:180 Average:33915.26 Median:4491.54 stddev:97486.15 (2170.4%) stddev-sans-first:97727.05 23:16:13 INFO - PROCESS | 1659 | Values: 350.9 355.8 376.7 381.7 403.5 15361.5 15618.0 16626.3 19419.4 20915.4 18506.8 20155.1 20981.7 20990.6 21205.9 4969.2 5928.1 6192.7 6210.7 6214.6 6090.3 6137.4 6210.2 6211.8 6214.0 5970.8 6063.8 6067.6 6158.1 6161.2 6044.2 6115.8 6116.3 6120.4 6122.9 5148.2 5288.1 5442.5 5492.8 5537.9 12858.7 13151.0 13155.3 22058.4 24638.8 2157.2 2167.4 2263.6 2265.2 2266.4 9774.2 9776.4 9832.0 10299.9 10327.5 1771.8 1779.9 1792.3 1843.6 1865.4 108540.5 117178.4 120755.0 121219.2 122018.0 8966.3 9051.0 9098.9 9553.9 11209.8 14504.3 14531.7 14535.0 14539.2 14544.9 8343.4 8507.1 8511.4 8533.6 8650.6 8505.7 8510.5 8529.0 8673.4 8734.7 4469.6 4484.5 4488.8 4494.3 4573.7 1723.3 1823.5 1886.1 1892.7 1894.4 722.3 733.7 826.9 876.8 981.0 19817.9 21801.7 21804.5 21935.9 22009.0 951.4 954.0 963.8 968.1 983.6 9421.7 10495.9 11084.7 11448.3 11466.7 577891.0 580565.0 585893.0 586876.0 595140.0 75973.0 76785.6 94449.1 132151.0 137381.3 902.7 955.2 974.3 974.5 978.2 19601.7 19898.8 19973.4 19995.5 20007.1 53386.5 54128.0 55064.4 55566.0 56208.4 80993.0 81735.2 86205.6 86550.0 86951.3 5960.8 8027.8 8070.3 8209.8 8251.5 9694.0 12725.2 12973.3 13300.5 13332.1 11235.9 11591.8 11647.9 11696.1 11739.8 10662.5 10675.2 10832.7 11424.8 11702.6 11092.5 11426.3 11568.7 11607.9 11752.2 7898.0 7951.9 8098.5 8243.9 8295.8 10121.3 10872.1 11306.5 11452.8 11500.9 23:16:13 INFO - PROCESS | 1659 | 23:16:13 INFO - PROCESS | 1659 | [#3] mootools.html Cycles:180 Average:5730.07 Median:4942.20 stddev:3225.19 (65.3%) stddev-sans-first:3218.79 23:16:13 INFO - PROCESS | 1659 | Values: 1530.7 1555.7 1694.6 1797.8 1863.4 7248.9 8441.7 8964.1 8976.3 9179.4 7846.2 8058.0 8101.6 8501.8 8761.6 2363.1 2403.1 2403.9 2404.3 2409.5 2375.2 2378.1 2388.6 2406.2 2414.1 2047.5 2334.8 2382.9 2390.4 2391.9 2353.8 2372.1 2379.6 2380.6 2382.0 2331.9 2341.1 2343.1 2346.6 2350.8 8784.8 8810.7 8864.5 8870.4 8885.3 5236.6 5406.3 5411.2 5412.9 5417.3 3436.9 3508.8 3625.2 3659.3 3666.9 1090.1 1093.8 1103.0 1124.7 1125.1 11829.6 11883.0 11901.2 11912.8 11921.6 4549.5 4620.6 4802.5 4816.7 4827.6 9941.2 9953.0 9956.0 9959.1 9969.6 5374.5 5381.2 5382.0 5382.5 5385.4 4397.6 4514.6 4852.3 4909.6 4923.5 3795.4 3872.5 3990.9 3991.5 3997.8 1046.7 1240.4 1240.9 1283.1 1301.9 761.2 861.6 864.9 905.8 942.3 5687.9 5747.4 5878.6 5897.8 6074.9 909.7 945.7 954.0 966.8 1011.7 3940.8 3953.5 3957.1 4029.8 4064.9 10828.2 11026.8 11042.7 11047.8 11077.4 10253.4 10946.8 10952.2 10971.6 10975.5 7880.9 8216.7 8216.7 8224.2 8230.5 5823.2 5832.5 5902.9 6062.8 6189.8 9903.8 10052.7 10168.8 10179.7 10324.3 10125.4 10170.4 10229.0 10382.1 10392.5 5685.8 6994.8 7200.0 7499.4 7674.1 8376.0 8543.8 8573.2 8574.1 8580.1 6804.6 7276.6 7465.0 7580.3 7711.7 7130.7 7258.8 7337.7 7380.0 7470.5 6888.9 6904.2 6976.1 6988.2 6992.2 4979.6 5016.6 5026.0 5056.7 5118.2 4860.5 4960.9 5017.9 5102.7 5179.7 23:16:13 INFO - PROCESS | 1659 | 23:16:13 INFO - PROCESS | 1659 | [#4] prototype.html Cycles:180 Average:4483.28 Median:4869.38 stddev:1404.08 (28.8%) stddev-sans-first:1371.90 23:16:13 INFO - PROCESS | 1659 | Values: 267.3 305.3 313.4 316.7 322.8 4388.3 5157.3 5317.4 5446.5 5477.4 4687.7 4694.6 4935.8 4987.8 5245.8 3364.7 4070.9 4090.5 4096.0 4103.5 3206.0 3530.8 3694.5 4091.2 4094.5 3492.0 3544.6 4005.0 4030.4 4034.6 3441.4 3487.8 3815.9 4040.5 4056.5 3366.5 3515.8 3524.3 3539.0 3542.9 4217.8 4858.3 5189.3 5252.2 5271.9 4579.8 4601.6 4605.9 4611.6 4628.3 4507.6 5337.8 5561.9 5592.5 5607.7 3560.3 3772.3 3809.8 3815.6 3829.9 4835.7 5879.1 5951.3 5977.6 5981.8 3436.3 3899.6 3900.4 3914.0 3920.9 3839.1 3969.2 3985.4 3985.5 4000.0 4571.8 4599.6 4604.5 4607.4 4644.9 4708.5 4935.0 5683.6 5726.3 5729.3 1214.5 1227.7 1236.7 1266.8 1352.3 683.5 683.6 798.8 800.8 828.3 4444.2 4465.4 4468.6 4483.7 4505.5 4154.2 4216.9 4791.2 4880.4 4957.0 4458.8 4886.0 5360.9 5370.9 5404.8 3030.5 3065.8 3069.6 3071.6 3071.7 5768.8 6018.1 6096.3 6124.2 6159.7 4825.3 5065.5 5365.9 5957.8 6081.6 4975.0 5483.4 6059.7 6075.6 6095.3 5550.9 5779.7 5843.2 5872.5 5887.4 4842.8 5768.6 5788.2 5790.4 5820.7 5054.6 5083.7 5733.8 6078.4 6093.5 3806.4 3834.1 3886.0 3887.3 3900.3 5007.9 5055.8 5166.3 5855.7 5862.6 5321.6 5620.7 5687.2 5709.9 5724.6 4709.6 5691.5 5755.9 5759.5 5765.8 4413.0 4996.8 5541.8 5575.8 5655.0 5185.4 5358.6 5423.7 5483.6 5617.4 5578.4 5637.5 5654.9 5662.9 5663.0 23:16:13 INFO - PROCESS | 1659 | 23:16:13 INFO - PROCESS | 1659 | [#5] yui.html Cycles:180 Average:24386.93 Median:4054.13 stddev:39120.46 (965.0%) stddev-sans-first:39189.86 23:16:13 INFO - PROCESS | 1659 | Values: 725.2 727.2 765.4 797.4 810.4 15492.8 16363.9 16366.6 16376.3 16389.9 14688.4 14844.8 14870.3 14873.3 14888.6 681.9 700.1 702.6 834.7 845.6 854.2 870.2 878.9 879.3 881.8 930.5 934.1 935.6 936.0 936.5 717.1 731.6 733.6 927.6 927.9 552.7 554.8 664.8 683.3 684.3 14940.4 14971.3 14973.3 14981.8 14997.2 11407.6 13967.7 14148.7 14175.4 14493.1 12383.9 12621.7 12786.3 12964.4 13112.2 4031.8 4040.2 4068.1 4131.8 4181.2 111137.0 113908.9 114355.4 114522.0 115125.0 10906.9 11203.3 11313.3 11325.4 11347.5 22378.3 22431.0 22731.9 22753.0 22962.2 7870.4 7969.0 7974.3 7999.2 8158.2 4316.5 4374.5 4409.1 4464.5 4485.8 3379.3 3479.7 3486.0 3487.9 3489.4 628.3 633.3 638.6 655.6 658.1 528.0 578.8 596.9 598.4 630.6 7501.9 7590.6 8382.0 8992.8 9346.2 525.2 592.3 616.9 623.5 640.8 4116.8 4233.4 4240.5 4324.8 4424.3 158615.0 162517.0 167050.0 169208.0 170739.8 87121.0 102246.0 103349.5 105588.5 112653.0 96290.5 99148.5 100638.0 105140.0 106222.5 9268.5 9706.2 9818.9 9819.8 9838.9 58315.8 58956.7 59024.4 61502.7 61565.4 87825.6 90347.0 90517.5 91476.5 93243.1 10118.8 12795.0 13023.6 13119.0 13190.5 14598.6 14852.8 14952.3 14981.7 15081.8 13269.9 13375.4 13563.3 13594.8 13741.1 13270.9 13545.0 13581.4 13772.8 13975.7 13547.9 13699.1 13715.9 13775.9 13864.2 10921.3 11385.3 11419.3 11437.4 11808.8 8146.9 8485.4 9044.7 10418.2 11436.6 23:16:13 INFO - PROCESS | 1659 | -------- Summary: end -------- 23:16:13 INFO - PROCESS | 1659 | 23:16:14 INFO - TEST-INFO | 1659: exit 0 23:16:14 INFO - TEST-OK | dromaeo_css | took 1116785ms 23:16:14 INFO - TEST-START | kraken 23:16:14 INFO - operating with platform_type : mac_ 23:16:14 INFO - Initialising browser for kraken test... 23:16:14 INFO - TEST-INFO | started process 1666 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/tmp7KP3GE/profile http://localhost:49273/getInfo.html) 23:16:16 INFO - PROCESS | 1666 | __metrics Screen width/height:1600/1200 23:16:16 INFO - PROCESS | 1666 | colorDepth:24 23:16:16 INFO - PROCESS | 1666 | Browser inner width/height: 1024/689 23:16:16 INFO - PROCESS | 1666 | __metrics 23:16:16 INFO - PROCESS | 1666 | 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" 23:16:16 INFO - PROCESS | 1666 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 23:16:17 INFO - TEST-INFO | 1666: exit 0 23:16:17 INFO - Browser initialized. 23:16:17 INFO - Running cycle 1/1 for kraken test... 23:16:17 INFO - TEST-INFO | started process 1667 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/tmp7KP3GE/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:16:29 INFO - PROCESS | 1667 | RSS: Main: 235655168 23:16:29 INFO - PROCESS | 1667 | 23:16:32 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49273/tests/kraken/driver.html?testName=audio-beat-detection) 23:16:33 INFO - PROCESS | 1667 | RSS: Main: 294690816 23:16:33 INFO - PROCESS | 1667 | 23:16:36 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49273/tests/kraken/driver.html?testName=audio-dft) 23:16:36 INFO - PROCESS | 1667 | RSS: Main: 292880384 23:16:36 INFO - PROCESS | 1667 | 23:16:40 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49273/tests/kraken/driver.html?testName=audio-fft) 23:16:40 INFO - PROCESS | 1667 | RSS: Main: 380342272 23:16:40 INFO - PROCESS | 1667 | 23:16:42 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49273/tests/kraken/driver.html?testName=audio-oscillator) 23:16:43 INFO - PROCESS | 1667 | RSS: Main: 284729344 23:16:43 INFO - PROCESS | 1667 | 23:16:45 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49273/tests/kraken/driver.html?testName=imaging-gaussian-blur) 23:16:46 INFO - PROCESS | 1667 | RSS: Main: 290942976 23:16:46 INFO - PROCESS | 1667 | 23:16:48 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49273/tests/kraken/driver.html?testName=imaging-darkroom) 23:16:49 INFO - PROCESS | 1667 | RSS: Main: 327737344 23:16:49 INFO - PROCESS | 1667 | 23:16:52 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49273/tests/kraken/driver.html?testName=imaging-desaturate) 23:16:52 INFO - PROCESS | 1667 | RSS: Main: 328822784 23:16:52 INFO - PROCESS | 1667 | 23:16:55 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49273/tests/kraken/driver.html?testName=json-parse-financial) 23:16:56 INFO - PROCESS | 1667 | RSS: Main: 326590464 23:16:56 INFO - PROCESS | 1667 | 23:16:57 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49273/tests/kraken/driver.html?testName=json-stringify-tinderbox) 23:16:58 INFO - PROCESS | 1667 | RSS: Main: 300605440 23:16:58 INFO - PROCESS | 1667 | 23:17:00 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-aes) 23:17:01 INFO - PROCESS | 1667 | RSS: Main: 305016832 23:17:01 INFO - PROCESS | 1667 | 23:17:03 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-ccm) 23:17:04 INFO - PROCESS | 1667 | RSS: Main: 311042048 23:17:04 INFO - PROCESS | 1667 | 23:17:06 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 23:17:07 INFO - PROCESS | 1667 | RSS: Main: 323592192 23:17:07 INFO - PROCESS | 1667 | 23:17:10 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 23:17:11 INFO - PROCESS | 1667 | RSS: Main: 319778816 23:17:11 INFO - PROCESS | 1667 | 23:17:12 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49273/tests/kraken/driver.html?testName=ai-astar) 23:17:13 INFO - PROCESS | 1667 | RSS: Main: 363184128 23:17:13 INFO - PROCESS | 1667 | 23:17:13 INFO - PROCESS | 1667 | __start_tp_report 23:17:13 INFO - PROCESS | 1667 | _x_x_mozilla_page_load 23:17:13 INFO - PROCESS | 1667 | _x_x_mozilla_page_load_details 23:17:13 INFO - PROCESS | 1667 | |i|pagename|runs| 23:17:13 INFO - PROCESS | 1667 | |0;ai-astar;112;113;112;111;112;112;110;118;164;154 23:17:13 INFO - PROCESS | 1667 | |1;audio-beat-detection;145;108;110;144;133;143;141;110;137;108 23:17:13 INFO - PROCESS | 1667 | |2;audio-dft;182;184;182;184;186;181;182;184;178;182 23:17:13 INFO - PROCESS | 1667 | |3;audio-fft;79;58;59;87;60;60;58;58;81;57 23:17:13 INFO - PROCESS | 1667 | |4;audio-oscillator;81;69;91;70;67;69;92;68;69;90 23:17:13 INFO - PROCESS | 1667 | |5;imaging-gaussian-blur;87;84;92;85;87;83;87;84;85;83 23:17:13 INFO - PROCESS | 1667 | |6;imaging-darkroom;169;125;95;96;95;96;96;97;95;95 23:17:13 INFO - PROCESS | 1667 | |7;imaging-desaturate;117;140;96;85;84;85;85;82;86;86 23:17:13 INFO - PROCESS | 1667 | |8;json-parse-financial;54;52;53;52;53;54;54;54;54;55 23:17:13 INFO - PROCESS | 1667 | |9;json-stringify-tinderbox;66;71;70;80;74;74;69;69;70;71 23:17:13 INFO - PROCESS | 1667 | |10;stanford-crypto-aes;87;82;89;85;83;89;87;88;100;87 23:17:13 INFO - PROCESS | 1667 | |11;stanford-crypto-ccm;140;142;149;151;142;145;131;150;198;126 23:17:13 INFO - PROCESS | 1667 | |12;stanford-crypto-pbkdf2;174;168;171;209;167;170;169;168;179;167 23:17:13 INFO - PROCESS | 1667 | |13;stanford-crypto-sha256-iterative;67;68;68;67;66;67;67;67;66;67 23:17:13 INFO - PROCESS | 1667 | __end_tp_report 23:17:13 INFO - PROCESS | 1667 | __start_cc_report 23:17:13 INFO - PROCESS | 1667 | _x_x_mozilla_cycle_collect,1956 23:17:13 INFO - PROCESS | 1667 | __end_cc_report 23:17:13 INFO - PROCESS | 1667 | __startTimestamp1474525033132__endTimestamp 23:17:13 INFO - PROCESS | 1667 | 23:17:13 INFO - PROCESS | 1667 | ------- Summary: start ------- 23:17:13 INFO - PROCESS | 1667 | Number of tests: 14 23:17:13 INFO - PROCESS | 1667 | 23:17:13 INFO - PROCESS | 1667 | [#0] ai-astar Cycles:10 Average:121.80 Median:112.50 stddev:19.86 (17.7%) stddev-sans-first:20.75 23:17:13 INFO - PROCESS | 1667 | Values: 112.0 113.0 112.0 111.0 112.0 112.0 110.0 118.0 164.0 154.0 23:17:13 INFO - PROCESS | 1667 | 23:17:13 INFO - PROCESS | 1667 | [#1] audio-beat-detection Cycles:10 Average:127.90 Median:139.00 stddev:16.64 (12.0%) stddev-sans-first:16.46 23:17:13 INFO - PROCESS | 1667 | Values: 145.0 108.0 110.0 144.0 133.0 143.0 141.0 110.0 137.0 108.0 23:17:13 INFO - PROCESS | 1667 | 23:17:13 INFO - PROCESS | 1667 | [#2] audio-dft Cycles:10 Average:182.50 Median:183.00 stddev:2.17 (1.2%) stddev-sans-first:2.30 23:17:13 INFO - PROCESS | 1667 | Values: 182.0 184.0 182.0 184.0 186.0 181.0 182.0 184.0 178.0 182.0 23:17:13 INFO - PROCESS | 1667 | 23:17:13 INFO - PROCESS | 1667 | [#3] audio-fft Cycles:10 Average:65.70 Median:60.00 stddev:11.68 (19.5%) stddev-sans-first:11.36 23:17:13 INFO - PROCESS | 1667 | Values: 79.0 58.0 59.0 87.0 60.0 60.0 58.0 58.0 81.0 57.0 23:17:13 INFO - PROCESS | 1667 | 23:17:13 INFO - PROCESS | 1667 | [#4] audio-oscillator Cycles:10 Average:76.60 Median:75.50 stddev:10.68 (14.1%) stddev-sans-first:11.21 23:17:13 INFO - PROCESS | 1667 | Values: 81.0 69.0 91.0 70.0 67.0 69.0 92.0 68.0 69.0 90.0 23:17:13 INFO - PROCESS | 1667 | 23:17:13 INFO - PROCESS | 1667 | [#5] imaging-gaussian-blur Cycles:10 Average:85.70 Median:86.00 stddev:2.71 (3.2%) stddev-sans-first:2.83 23:17:13 INFO - PROCESS | 1667 | Values: 87.0 84.0 92.0 85.0 87.0 83.0 87.0 84.0 85.0 83.0 23:17:13 INFO - PROCESS | 1667 | 23:17:13 INFO - PROCESS | 1667 | [#6] imaging-darkroom Cycles:10 Average:105.90 Median:95.50 stddev:24.03 (25.2%) stddev-sans-first:9.82 23:17:13 INFO - PROCESS | 1667 | Values: 169.0 125.0 95.0 96.0 95.0 96.0 96.0 97.0 95.0 95.0 23:17:13 INFO - PROCESS | 1667 | 23:17:13 INFO - PROCESS | 1667 | [#7] imaging-desaturate Cycles:10 Average:94.60 Median:85.00 stddev:19.03 (22.4%) stddev-sans-first:18.38 23:17:13 INFO - PROCESS | 1667 | Values: 117.0 140.0 96.0 85.0 84.0 85.0 85.0 82.0 86.0 86.0 23:17:13 INFO - PROCESS | 1667 | 23:17:13 INFO - PROCESS | 1667 | [#8] json-parse-financial Cycles:10 Average:53.50 Median:54.00 stddev:0.97 (1.8%) stddev-sans-first:1.01 23:17:13 INFO - PROCESS | 1667 | Values: 54.0 52.0 53.0 52.0 53.0 54.0 54.0 54.0 54.0 55.0 23:17:13 INFO - PROCESS | 1667 | 23:17:13 INFO - PROCESS | 1667 | [#9] json-stringify-tinderbox Cycles:10 Average:71.40 Median:71.00 stddev:3.84 (5.4%) stddev-sans-first:3.54 23:17:13 INFO - PROCESS | 1667 | Values: 66.0 71.0 70.0 80.0 74.0 74.0 69.0 69.0 70.0 71.0 23:17:13 INFO - PROCESS | 1667 | 23:17:13 INFO - PROCESS | 1667 | [#10] stanford-crypto-aes Cycles:10 Average:87.70 Median:87.00 stddev:4.92 (5.7%) stddev-sans-first:5.21 23:17:13 INFO - PROCESS | 1667 | Values: 87.0 82.0 89.0 85.0 83.0 89.0 87.0 88.0 100.0 87.0 23:17:13 INFO - PROCESS | 1667 | 23:17:13 INFO - PROCESS | 1667 | [#11] stanford-crypto-ccm Cycles:10 Average:147.40 Median:147.00 stddev:19.52 (13.3%) stddev-sans-first:20.52 23:17:13 INFO - PROCESS | 1667 | Values: 140.0 142.0 149.0 151.0 142.0 145.0 131.0 150.0 198.0 126.0 23:17:13 INFO - PROCESS | 1667 | 23:17:13 INFO - PROCESS | 1667 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:174.20 Median:170.50 stddev:12.78 (7.5%) stddev-sans-first:13.55 23:17:13 INFO - PROCESS | 1667 | Values: 174.0 168.0 171.0 209.0 167.0 170.0 169.0 168.0 179.0 167.0 23:17:13 INFO - PROCESS | 1667 | 23:17:13 INFO - PROCESS | 1667 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.00 Median:67.00 stddev:0.67 (1.0%) stddev-sans-first:0.71 23:17:13 INFO - PROCESS | 1667 | Values: 67.0 68.0 68.0 67.0 66.0 67.0 67.0 67.0 66.0 67.0 23:17:13 INFO - PROCESS | 1667 | -------- Summary: end -------- 23:17:13 INFO - PROCESS | 1667 | 23:17:13 INFO - TEST-INFO | 1667: exit 0 23:17:14 INFO - TEST-OK | kraken | took 59672ms 23:17:14 INFO - SUITE-END | took 1176s 23:17:14 INFO - Completed test suite (00:19:36) 23:17:14 INFO - javascript benchmark 23:17:14 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3307.6692330766928, 3326.966730332697, 3333.683300086491, 3370.3090866372395, 3403.251284717361, 5602.1596760485945, 5607.467290607386, 5696.886062278762, 5710.828675139747, 5717.3139223293265, 5652.604317697763, 5681.0, 5694.715264236782, 5729.856753581163, 5762.164486149516, 5125.615578831603, 5129.692218466904, 5132.948670513303, 5191.740412979355, 5230.921536176941, 5313.73431328434, 5315.627906046579, 5330.706811125387, 5341.4658534146665, 5351.143816989283, 5124.846254612367, 5283.86790330241, 5286.709230992294, 5293.735313234342, 5390.811321603745, 5167.48325167484, 5193.039287731782, 5238.921416178722, 5248.370195576517, 5255.0, 5171.482851714836, 5225.634205605609, 5228.92156617651, 5229.503197196298, 5297.735113244323, 5719.113537401709, 5722.998475266853, 5742.224799652077, 5760.0, 5765.106408506688, 6096.362824393382, 6123.479504242145, 6132.233136608343, 6140.385961403868, 6149.262088549358, 6167.0, 6235.469985051276, 6243.032329988859, 6261.342559031327, 6267.59260648061, 5676.886462270814, 5731.037082597544, 5753.309602847643, 5757.510611598061, 5799.304083509964, 6185.474234690012, 6193.628382297076, 6255.374462553799, 6261.624302541771, 6284.780032698834, 6119.502553941512, 6142.928535732134, 6209.844753881189, 6218.0, 6221.968890155611, 6247.031710084944, 6258.15514905491, 6270.561060725797, 6275.090111933835, 6277.591956522811, 6090.878182436415, 6143.1706719592285, 6192.133101365813, 6248.656323902229, 6251.343608921089, 6142.468080853438, 6164.47601953839, 6196.256449226122, 6205.03821907605, 6211.751529938842, 4890.877728056756, 4910.607151427948, 4913.140200464904, 4959.008198360342, 5019.447860735316, 4390.363397307437, 4412.801423935931, 4437.64498840092, 4438.045820148684, 4461.08547747711, 5619.129034999582, 5757.596968212269, 5787.942120578825, 5799.5070419014855, 5829.854253643608, 6144.003198960356, 6195.659238741822, 6198.0, 6217.533684973645, 6241.594296370721, 5775.0, 5792.333881603669, 5801.564882633735, 5808.651480911159, 5808.941910580925, 5408.567314614821, 5424.267723857229, 5426.050441172779, 5432.728363581805, 5434.945650543523, 6195.938040619536, 6217.875642487125, 6245.5628106032145, 6258.374162583706, 6275.0, 6285.402886725754, 6287.685615719287, 6289.0, 6299.401556852092, 6309.747610095545, 6220.595661282002, 6253.843653908689, 6264.467520260829, 6271.529635277281, 6288.402601752826, 6024.7288872001745, 6075.969620151871, 6094.229520225711, 6115.2278529517625, 6126.700892189639, 6277.089821975879, 6287.874242515216, 6298.9921612541775, 6310.400511951358, 6310.52671049664, 6148.292946311231, 6163.599366041193, 6166.784162554289, 6170.722317495633, 6177.752889884354, 5095.464976177448, 5676.290463692038, 6083.178770865877, 6107.480864126599, 6154.599951003171, 6026.849328766816, 6036.215292012011, 6050.515958723379, 6077.845209410198, 6115.327313995546, 6114.2357205349335, 6170.074488826533, 6170.50635949132, 6179.134921110958, 6183.443490085914, 4620.445546534303, 5850.034744267318, 5896.941030589811, 5957.778655375551, 6025.337212906665], "value": 5700.08004064535, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [469.39448111935604, 475.43660761997035, 497.94932692019853, 543.6629289840299, 554.9926882707888, 30814.0, 31049.0, 32628.67371326289, 40230.396544051866, 41342.55301064463, 43318.35022474665, 43626.563734362644, 43633.7818310908, 43703.78148109263, 43877.12245755083, 9761.7559561011, 9931.751706207366, 9957.203423726085, 9976.650817221398, 9981.600735970553, 8807.119288071206, 8980.416272942239, 9840.950795246014, 12023.579174728886, 12231.143819932608, 11934.582289619864, 12144.0, 12287.815682764765, 12330.691732706664, 12372.010239180843, 12061.155719099666, 12112.81830772539, 12122.212056216318, 12128.939355303255, 12145.089118316073, 8796.384253102286, 9008.549572521413, 11676.883231167665, 11980.28118312904, 11981.940090299493, 40803.38794918079, 41248.38127428091, 41296.79351603223, 41309.380359294635, 41325.0, 3262.2822978944596, 3531.3820081485637, 3564.41187204111, 3746.250749850041, 4077.4291599175845, 30668.079957601083, 30935.535966960513, 31671.683283167105, 31723.0, 31862.0, 3276.3774882772195, 3303.8513266903046, 3357.983210083934, 3360.1263671445354, 3392.3893699134146, 501213.0, 502088.0, 502261.0, 502902.0, 503363.0, 57466.13800792991, 57755.0, 57783.42216577865, 57787.13319300214, 57967.0, 62755.0, 62792.686036569525, 62831.6858415705, 62960.0, 63003.684981575716, 16326.836731632531, 16536.83463165377, 16572.254248558846, 16585.50243492697, 16622.50132496027, 9343.439393636403, 11621.76756464883, 12892.742145157044, 12906.741865162645, 12960.80558791619, 14652.853471465149, 15093.849061509245, 15094.24528773557, 15108.017978831342, 15112.697746045018, 4927.630427717864, 6079.848003799941, 6229.719662615194, 6233.875322493615, 6351.936480635227, 851.6210286422606, 890.5636238243214, 902.634433054614, 919.8068405634758, 1047.1831971062584, 24024.51950960971, 26470.0, 29487.0, 29801.701982980325, 32220.19449513734, 1021.9080282774586, 1132.3375825142218, 1136.2387200575633, 1138.886111388871, 1178.6780043314657, 15105.169215693022, 15575.610609734847, 15694.450694225647, 15729.0, 16076.517704468884, 665650.0, 667787.0, 669109.0, 669446.0, 669449.0, 50292.0, 50336.99326013459, 50502.747486262335, 57661.8467630645, 58027.4197258022, 1368.261138984937, 1383.3843939447052, 1412.315027211822, 1416.3201663201926, 1419.049237011205, 27440.41327358526, 29374.55938160972, 30545.389092218476, 31855.0, 32358.35283294274, 51440.97118057543, 51878.96242075062, 51988.74005630099, 52004.219936700225, 52024.479755201966, 609150.0, 623453.0, 626742.0, 634753.0, 866455.0, 25298.11456599084, 25529.0, 25545.912653975276, 25891.09381171725, 25894.0, 33616.49575256324, 45947.77026114848, 46063.309050364944, 46649.766751167386, 46876.0, 38565.4215186778, 38640.0, 38660.033499162746, 39507.0, 40049.399259010555, 37396.00831933384, 37678.434823478216, 37838.24323513459, 39129.608703913735, 39227.215455691294, 31557.211069723442, 37230.8138459306, 38308.80845595754, 38346.42480362853, 38469.0, 30792.076237712903, 31673.5248971261, 31740.523892142097, 34197.0, 34295.0, 19431.0, 25126.371840704127, 25340.11309604155, 25511.65065990447, 25632.0], "value": 20057.815563351847, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [350.85965613754496, 355.75808450253817, 376.6722951032602, 381.711807585273, 403.53996444053786, 15361.53915382539, 15618.0, 16626.25181866816, 19419.44644428446, 20915.37253882382, 18506.814931850677, 20155.093020814063, 20981.68527472089, 20990.580188396223, 21205.893970530127, 4969.2049272116465, 5928.140419639139, 6192.659403732793, 6210.65841378724, 6214.5649804513705, 6090.33006369299, 6137.355577664348, 6210.1616281801835, 6211.751529938797, 6214.0, 5970.761169553212, 6063.787767428141, 6067.575269731121, 6158.107074474198, 6161.199044124258, 6044.214252147215, 6115.785947491817, 6116.296625888035, 6120.44915957566, 6122.908156377658, 5148.227765835118, 5288.101022826128, 5442.510174084312, 5492.780288788444, 5537.923278770461, 12858.742825143445, 13151.0, 13155.342232888317, 22058.4485387865, 24638.753612463825, 2157.1802714968367, 2167.371462275938, 2263.581237471073, 2265.150568536799, 2266.3654176830514, 9774.218062554979, 9776.413415195111, 9831.950840245825, 10299.897001029969, 10327.535260913277, 1771.8139595342432, 1779.87540872139, 1792.2830867652913, 1843.5620216231362, 1865.3657756362766, 108540.4572977138, 117178.41410792891, 120755.0, 121219.18171227438, 122018.0, 8966.251580941655, 9050.954745226363, 9098.909010909938, 9553.901301350434, 11209.831852522218, 14504.34730437133, 14531.709365812836, 14534.982551221314, 14539.200343981183, 14544.854551454562, 8343.374246931384, 8507.106753790888, 8511.398131063646, 8533.615987280464, 8650.610722517502, 8505.65977360911, 8510.531920744419, 8528.957355213184, 8673.436226645248, 8734.694285700098, 4469.575390337913, 4484.461864576207, 4488.775561221926, 4494.303382975644, 4573.702709323883, 1723.3106757297182, 1823.5349985753548, 1886.1135266424758, 1892.6593213221477, 1894.4316704988723, 722.2524686948983, 733.6955163607043, 826.9421140520226, 876.8114855306139, 981.032377059401, 19817.900910495642, 21801.67297490539, 21804.45488862791, 21935.903204839695, 22009.0, 951.4006176109007, 953.9856902146473, 963.7783309838636, 968.1093394077466, 983.6409710455632, 9421.717348479557, 10495.897930717165, 11084.722881928017, 11448.255863368855, 11466.656000320003, 577891.0, 580565.0, 585893.0, 586876.0, 595140.0, 75973.0, 76785.61607191928, 94449.0555094454, 132151.0, 137381.31309343388, 902.7246689759555, 955.2310390135868, 974.3228456222857, 974.5078735238659, 978.2467500024941, 19601.70597441011, 19898.801011989694, 19973.400797976083, 19995.500112497302, 20007.099680514122, 53386.4661353397, 54128.0, 55064.44935550753, 55566.0, 56208.43791562032, 80993.0, 81735.18264817276, 86205.56897215724, 86550.0, 86951.34816236925, 5960.791372301948, 8027.83944321122, 8070.273675369245, 8209.83580328402, 8251.504909705436, 9694.0, 12725.236485810881, 12973.286469244282, 13300.534481293109, 13332.133411328232, 11235.88776090821, 11591.826122608, 11647.941760291144, 11696.06431485496, 11739.765204696028, 10662.520186591777, 10675.199360047873, 10832.67501974942, 11424.828627570427, 11702.648920532398, 11092.500837462496, 11426.314421134759, 11568.652940411801, 11607.941960290145, 11752.177347585586, 7897.959082504299, 7951.920480795118, 8098.473599216032, 8243.917560824555, 8295.834083318421, 10121.342112762646, 10872.08694483302, 11306.530151080307, 11452.82820757706, 11500.94249528747], "value": 9335.019891651278, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1530.6862093270881, 1555.7121932442499, 1694.5594145522161, 1797.8022417534069, 1863.3571417860833, 7248.855022899539, 8441.704540341088, 8964.148405901436, 8976.281897448205, 9179.357444978854, 7846.215378462165, 8057.95971020144, 8101.635426405811, 8501.78745531362, 8761.56192190391, 2363.0665886974593, 2403.0748161957686, 2403.879806009701, 2404.326788499223, 2409.518096380722, 2375.2043065573052, 2378.1438682074527, 2388.6297623868327, 2406.2179791567723, 2414.0947144820693, 2047.5188330742264, 2334.8092472838803, 2382.916597919073, 2390.3904504351453, 2391.868447235401, 2353.7646235376324, 2372.0511795281855, 2379.5716770981217, 2380.6429035644705, 2381.9642705359433, 2331.895064722092, 2341.1220792202926, 2343.086196383395, 2346.601077816775, 2350.847194932324, 8784.780380490474, 8810.735677929672, 8864.468131912041, 8870.37907346486, 8885.289176865836, 5236.581073514109, 5406.324209473816, 5411.242426060355, 5412.9458705412835, 5417.349918009864, 3436.896893093211, 3508.7543871928974, 3625.2024554597947, 3659.3413185626578, 3666.8533258669886, 1090.0571006079683, 1093.7858976536038, 1102.979743737048, 1124.6738445850694, 1125.0718157519998, 11829.585964491202, 11883.0, 11901.226420282741, 11912.761744765055, 11921.642350729491, 4549.499555048942, 4620.584147426748, 4802.519748025239, 4816.662833601615, 4827.589654879304, 9941.155001824782, 9952.950235248778, 9956.0, 9959.103680668775, 9969.55137018836, 5374.516293533601, 5381.219723140122, 5382.03123437785, 5382.515573598395, 5385.353757549119, 4397.648188144941, 4514.616257618073, 4852.272159176152, 4909.582685471775, 4923.532264434873, 3795.35478968576, 3872.4772155759174, 3990.900227494336, 3991.5210174779213, 3997.8200980955344, 1046.670298855858, 1240.3674126195706, 1240.9193402428814, 1283.0697744135614, 1301.9088663793443, 761.1665226576889, 861.5562985062697, 864.8745931839974, 905.8188362327561, 942.2603256443659, 5687.8862422752145, 5747.39652336507, 5878.588498805043, 5897.823065308047, 6074.876147912651, 909.663424532927, 945.6784693204344, 953.9809203816023, 966.8018056298442, 1011.6661501704419, 3940.7832569208967, 3953.5453422856162, 3957.109650328653, 4029.81865816039, 4064.918701625951, 10828.187885908588, 11026.779464410667, 11042.723931901606, 11047.83428248577, 11077.446127693584, 10253.436061016566, 10946.835797463045, 10952.233343665866, 10971.561137554569, 10975.50610222542, 7880.921190788134, 8216.671333146607, 8216.712415065444, 8224.218699223564, 8230.547319897343, 5823.213866128019, 5832.533397328289, 5902.911456328073, 6062.818115456544, 6189.845253868509, 9903.752406189902, 10052.69841904744, 10168.796624067329, 10179.7455063624, 10324.277300588887, 10125.443100629536, 10170.440625765654, 10229.0, 10382.117520010883, 10392.532336044746, 5685.800996965087, 6994.755183568551, 7200.0, 7499.437542184467, 7674.117476490275, 8376.03675577292, 8543.829123417372, 8573.18554737299, 8574.09971952961, 8580.14198580137, 6804.5710400814405, 7276.563406195645, 7465.029546159182, 7580.317771400601, 7711.6915323388685, 7130.714771409085, 7258.782236532912, 7337.6698048589005, 7379.963100184465, 7470.514416562906, 6888.896666549906, 6904.171499420102, 6976.093107895941, 6988.161420629353, 6992.195897471653, 4979.576735977483, 5016.570277470903, 5025.974870125626, 5056.721880296619, 5118.232265160255, 4860.513948605111, 4960.8759781005765, 5017.949820501748, 5102.69383836971, 5179.741012949413], "value": 4604.587884497604, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [267.2996748518881, 305.3404645964715, 313.42486537204223, 316.7070459824663, 322.75309388317953, 4388.319810429381, 5157.277981082651, 5317.378199649115, 5446.509814116734, 5477.425609963316, 4687.742174180418, 4694.554017368353, 4935.79173537201, 4987.800487980477, 5245.763940622672, 3364.693192713331, 4070.8778736637946, 4090.468239128924, 4095.9795201023953, 4103.528094269167, 3206.022163240211, 3530.7642325186107, 3694.538182727159, 4091.243120022805, 4094.529129150141, 3491.982540087296, 3544.5746510418785, 4004.9599504004877, 4030.415589739486, 4034.616711412411, 3441.397755392809, 3487.7558570900046, 3815.9046023849346, 4040.515138183422, 4056.492938382702, 3366.4613661814237, 3515.806630635314, 3524.259905419865, 3539.0, 3542.9114272143147, 4217.768022758747, 4858.327919644217, 5189.2875351134035, 5252.212168174766, 5271.947280527184, 4579.763463864771, 4601.608863246594, 4605.927332700265, 4611.631069514465, 4628.320485214263, 4507.639388848917, 5337.784819299985, 5561.888762224773, 5592.5246354059955, 5607.663540187561, 3560.2910602910747, 3772.320982223199, 3809.8476060957805, 3815.5802861685193, 3829.9042523936846, 4835.734034628129, 5879.1475236090955, 5951.2858456985, 5977.6114552553945, 5981.760729570812, 3436.261203841186, 3899.557163849394, 3900.4398240703945, 3914.0448961034235, 3920.882373528799, 3839.138018061238, 3969.166475040274, 3985.4021896715726, 3985.501812273466, 4000.0, 4571.794269257892, 4599.586037256596, 4604.493505714368, 4607.378003969421, 4644.930326045112, 4708.505606911293, 4934.963657631937, 5683.602147849693, 5726.341470730919, 5729.28383952006, 1214.5445457953267, 1227.711487800384, 1236.70146346336, 1266.7656483550572, 1352.2765320553654, 683.54885775388, 683.596677960006, 798.7523867600946, 800.8427821797563, 828.3207769628967, 4444.222311075531, 4465.397171381886, 4468.597826195658, 4483.686141970031, 4505.4544182536765, 4154.216674827872, 4216.873493795191, 4791.209450440708, 4880.438749543777, 4956.951474843017, 4458.818413120525, 4885.975570122127, 5360.901015291855, 5370.865728356823, 5404.756785944642, 3030.5151175811766, 3065.7853950223716, 3069.6469905960653, 3071.6467606225124, 3071.66211716711, 5768.826935191867, 6018.074216250758, 6096.329403765582, 6124.234470691164, 6159.722812473449, 4825.252085926687, 5065.493450654979, 5365.892682146336, 5957.79147729836, 6081.6351018939, 4974.950250497449, 5483.437220392169, 6059.7273122709585, 6075.635461872302, 6095.2685677718955, 5550.888982220414, 5779.739911703899, 5843.152742852348, 5872.504185721137, 5887.3523912370465, 4842.806287748451, 5768.625039372428, 5788.176724331822, 5790.420957904176, 5820.738066787089, 5054.620903432184, 5083.694978301313, 5733.846384488598, 6078.422549857756, 6093.512518998381, 3806.4480650306105, 3834.0606551395085, 3886.0090676877217, 3887.3002859485564, 3900.278448487039, 5007.899842003212, 5055.848324550269, 5166.295122609605, 5855.707214639337, 5862.648241105548, 5321.627486075938, 5620.718964051699, 5687.203791469115, 5709.942900570941, 5724.627899186539, 4709.576138147583, 5691.516221121251, 5755.8561035974435, 5759.452851979056, 5765.827025189251, 4412.977935110304, 4996.750162491933, 5541.778328866801, 5575.832725018256, 5654.971725141348, 5185.42960274377, 5358.624066837867, 5423.701696406735, 5483.588730845123, 5617.382087970402, 5578.414266501959, 5637.548996080386, 5654.935948378894, 5662.886742265214, 5662.971685141548], "value": 4028.367517060351, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [725.2276325713115, 727.2364017781332, 765.4450523370557, 797.4298376660687, 810.3679130278385, 15492.845071549282, 16363.918180409097, 16366.590835229124, 16376.344946202138, 16389.91805040973, 14688.412463501474, 14844.777328340084, 14870.33083511242, 14873.330700118493, 14888.553343399688, 681.8806708825961, 700.1493185779277, 702.6451641920848, 834.6661335465817, 845.6490556419079, 854.1885209051395, 870.195069560657, 878.8813510176141, 879.3097418526459, 881.7531091294416, 930.50683137937, 934.0985948559638, 935.6304259817368, 936.0405584276103, 936.4802534593298, 717.1179449277417, 731.6085894046713, 733.6258508160823, 927.5918595817852, 927.8561822917425, 552.6822077305566, 554.8446434998207, 664.7673314339991, 683.3235097253732, 684.3293572299175, 14940.402383904739, 14971.251437428085, 14973.251337433085, 14981.775273370908, 14997.17515536645, 11407.600733974272, 13967.65080872976, 14148.717025659429, 14175.362108705132, 14493.057951233137, 12383.938080309541, 12621.684457888534, 12786.296753678544, 12964.416601252871, 13112.180881110511, 4031.8387264509383, 4040.151568170688, 4068.105016896278, 4131.834726610962, 4181.226473102486, 111137.0, 113908.86091139066, 114355.42822285919, 114522.0, 115125.0, 10906.890931090587, 11203.271787333797, 11313.321200727984, 11325.433728313552, 11347.489362978686, 22378.32865014052, 22431.0, 22731.88634056819, 22752.976116074817, 22962.19632312861, 7870.370370370357, 7969.043714754266, 7974.322182614543, 7999.240072193133, 8158.184181581913, 4316.5467625899455, 4374.496932852762, 4409.14021765759, 4464.508904020555, 4485.798139083749, 3379.2934568043474, 3479.6520347965507, 3486.0413386318965, 3487.877924272638, 3489.4242449995972, 628.2868943748787, 633.2622494793605, 638.6391688695873, 655.6426747422666, 658.0688326018726, 527.9704576076666, 578.8292453726161, 596.8507873031742, 598.3986093975527, 630.5775130662375, 7501.887471687929, 7590.607707263594, 8381.95809020951, 8992.775180620405, 9346.205572526276, 525.1823964430878, 592.318833341652, 616.9357857695439, 623.5385814497279, 640.7565125252468, 4116.794160291974, 4233.449651545279, 4240.533541310453, 4324.8486302979245, 4424.292113261863, 158615.0, 162517.0, 167050.0, 169208.0, 170739.80382550438, 87121.0, 102246.0, 103349.48325258326, 105588.47205763921, 112653.0, 96290.51854740681, 99148.51277230847, 100638.0, 105140.0, 106222.46888765506, 9268.453492902321, 9706.1828693898, 9818.860840389816, 9819.754506137404, 9838.85830988026, 58315.83368332694, 58956.70521647536, 59024.40975590189, 61502.69248653728, 61565.384346157756, 87825.58267425194, 90347.0, 90517.54741226252, 91476.54261728915, 93243.06756932344, 10118.848217276895, 12795.0, 13023.609291721263, 13119.0, 13190.538331158747, 14598.5765018206, 14852.7772083421, 14952.318771763148, 14981.700365992838, 15081.849181508045, 13269.901870134549, 13375.398107085399, 13563.321833908463, 13594.796078059035, 13741.14359844319, 13270.867291326964, 13545.039558763638, 13581.3545467231, 13772.793408099087, 13975.720485590435, 13547.932260338635, 13699.109557878706, 13715.862841371458, 13775.931120344734, 13864.168149911038, 10921.344719316867, 11385.316880987168, 11419.257748246337, 11437.42812859337, 11808.76382472363, 8146.877796832934, 8485.363597730071, 9044.728658140266, 10418.218633602359, 11436.599719009795], "value": 7696.683049939486, "unit": "score"}], "name": "dromaeo_css", "value": 7308.444316848943, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 113.0, 112.0, 111.0, 112.0, 112.0, 110.0, 118.0, 164.0, 154.0], "value": 121.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 108.0, 110.0, 144.0, 133.0, 143.0, 141.0, 110.0, 137.0, 108.0], "value": 127.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [182.0, 184.0, 182.0, 184.0, 186.0, 181.0, 182.0, 184.0, 178.0, 182.0], "value": 182.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 58.0, 59.0, 87.0, 60.0, 60.0, 58.0, 58.0, 81.0, 57.0], "value": 65.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 69.0, 91.0, 70.0, 67.0, 69.0, 92.0, 68.0, 69.0, 90.0], "value": 76.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 84.0, 92.0, 85.0, 87.0, 83.0, 87.0, 84.0, 85.0, 83.0], "value": 85.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [169.0, 125.0, 95.0, 96.0, 95.0, 96.0, 96.0, 97.0, 95.0, 95.0], "value": 105.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 140.0, 96.0, 85.0, 84.0, 85.0, 85.0, 82.0, 86.0, 86.0], "value": 94.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 52.0, 53.0, 52.0, 53.0, 54.0, 54.0, 54.0, 54.0, 55.0], "value": 53.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 71.0, 70.0, 80.0, 74.0, 74.0, 69.0, 69.0, 70.0, 71.0], "value": 71.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 82.0, 89.0, 85.0, 83.0, 89.0, 87.0, 88.0, 100.0, 87.0], "value": 87.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 142.0, 149.0, 151.0, 142.0, 145.0, 131.0, 150.0, 198.0, 126.0], "value": 147.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [174.0, 168.0, 171.0, 209.0, 167.0, 170.0, 169.0, 168.0, 179.0, 167.0], "value": 174.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 68.0, 68.0, 67.0, 66.0, 67.0, 67.0, 67.0, 66.0, 67.0], "value": 67.0, "unit": "score"}], "name": "kraken", "value": 1461.9, "alertThreshold": 2.0}]} 23:17:14 INFO - Return code: 0 23:17:14 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 23:17:14 INFO - # TBPL SUCCESS # 23:17:14 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 23:17:14 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 23:17:14 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 23:17:14 INFO - 2016-09-21 23:17:14.461 screenresolution[1671:9830] starting screenresolution argv=screenresolution get 23:17:14 INFO - 2016-09-21 23:17:14.464 screenresolution[1671:9830] Display 0: 1600x1200x32@60 23:17:14 INFO - 2016-09-21 23:17:14.470 screenresolution[1672:9833] starting screenresolution argv=screenresolution list 23:17:14 INFO - Available Modes on Display 0 23:17:14 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 23:17:14 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 23:17:14 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 23:17:14 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 23:17:14 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 23:17:14 INFO - Intel Iris: 23:17:14 INFO - Chipset Model: Intel Iris 23:17:14 INFO - Type: GPU 23:17:14 INFO - Bus: Built-In 23:17:14 INFO - VRAM (Dynamic, Max): 1536 MB 23:17:14 INFO - Vendor: Intel (0x8086) 23:17:14 INFO - Device ID: 0x0a2e 23:17:14 INFO - Revision ID: 0x0009 23:17:14 INFO - Displays: 23:17:14 INFO - Display: 23:17:14 INFO - Resolution: 1600 x 1200 @ 60 Hz 23:17:14 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 23:17:14 INFO - Display Serial Number: 1600x1200 60 23:17:14 INFO - Main Display: Yes 23:17:14 INFO - Mirror: Off 23:17:14 INFO - Online: Yes 23:17:14 INFO - Rotation: Supported 23:17:14 INFO - Return code: 0 23:17:14 INFO - Running post-action listener: _resource_record_post_action 23:17:14 INFO - [mozharness: 2016-09-22 06:17:14.708209Z] Finished run-tests step (success) 23:17:14 INFO - Running post-run listener: _resource_record_post_run 23:17:14 INFO - Total resource usage - Wall time: 1211s; CPU: 53.0%; Read bytes: 38282240; Write bytes: 703912448; Read time: 430; Write time: 1868 23:17:14 INFO - TinderboxPrint: CPU usage
53.4% 23:17:14 INFO - TinderboxPrint: I/O read bytes / time
38,282,240 / 430 23:17:14 INFO - TinderboxPrint: I/O write bytes / time
703,912,448 / 1,868 23:17:14 INFO - TinderboxPrint: CPU idle
2,255.8 (46.6%) 23:17:14 INFO - TinderboxPrint: CPU system
964.1 (19.9%) 23:17:14 INFO - TinderboxPrint: CPU user
1,625.7 (33.5%) 23:17:14 INFO - TinderboxPrint: Swap in / out
443,617,280 / 0 23:17:14 INFO - install - Wall time: 34s; CPU: 54.0%; Read bytes: 407261696; Write bytes: 395585024; Read time: 30166; Write time: 724 23:17:14 INFO - run-tests - Wall time: 1178s; CPU: 53.0%; Read bytes: 30833664; Write bytes: 295515136; Read time: 341; Write time: 1108 23:17:15 INFO - Running post-run listener: _upload_blobber_files 23:17:15 INFO - Blob upload gear active. 23:17:15 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 23:17:15 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 23:17:15 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', 'Autoland', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 23:17:15 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 Autoland -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 23:17:15 INFO - (blobuploader) - INFO - Open directory for files ... 23:17:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 23:17:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:17:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:17:16 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 23:17:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:17:16 INFO - (blobuploader) - INFO - Done attempting. 23:17:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 23:17:16 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:17:16 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:17:17 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 23:17:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:17:17 INFO - (blobuploader) - INFO - Done attempting. 23:17:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 23:17:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:17:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:17:24 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 23:17:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:17:24 INFO - (blobuploader) - INFO - Done attempting. 23:17:24 INFO - (blobuploader) - INFO - Iteration through files over. 23:17:24 INFO - Return code: 0 23:17:24 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 23:17:24 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 23:17:24 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/b7b9f2a50ca2585a237bbb455fff2de7bc7c755f2c8780e8e43d8cb8f4441823b7fd866c42073113771f6ee6273e0bb41294ba0a9849f75203db2b9f841a486d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/17acc4daed3028326ab50e5a68c8f26459083e4e31ba7b8b16e64e5ec80d1c79ecae282dbc84ff56067e34acd7d4304b558b4841071dedcc76f18d15c5b56d64", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/19591f3d89f35c8b6278c200d10ad1c5ce89fbb1ef831cf509f86d469ed2ab853009488e7d34c20561919bd1cf71d73d30d83fd88c179335b1659c61c4437609"} 23:17:24 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 23:17:24 INFO - Writing to file /builds/slave/test/properties/blobber_files 23:17:24 INFO - Contents: 23:17:24 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/b7b9f2a50ca2585a237bbb455fff2de7bc7c755f2c8780e8e43d8cb8f4441823b7fd866c42073113771f6ee6273e0bb41294ba0a9849f75203db2b9f841a486d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/17acc4daed3028326ab50e5a68c8f26459083e4e31ba7b8b16e64e5ec80d1c79ecae282dbc84ff56067e34acd7d4304b558b4841071dedcc76f18d15c5b56d64", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/19591f3d89f35c8b6278c200d10ad1c5ce89fbb1ef831cf509f86d469ed2ab853009488e7d34c20561919bd1cf71d73d30d83fd88c179335b1659c61c4437609"} 23:17:24 INFO - Running post-run listener: copy_logs_to_upload_dir 23:17:24 INFO - Copying logs to upload dir... 23:17:24 INFO - mkdir: /builds/slave/test/build/upload/logs 23:17:24 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1277.563609 ========= master_lag: 3.44 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 21 secs) (at 2016-09-21 23:17:27.775028) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-21 23:17:27.778337) ========= 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.09ArzxQ1TO/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.LdqRs4GF48/Listeners TMPDIR=/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/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/Autoland/sha512/b7b9f2a50ca2585a237bbb455fff2de7bc7c755f2c8780e8e43d8cb8f4441823b7fd866c42073113771f6ee6273e0bb41294ba0a9849f75203db2b9f841a486d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/17acc4daed3028326ab50e5a68c8f26459083e4e31ba7b8b16e64e5ec80d1c79ecae282dbc84ff56067e34acd7d4304b558b4841071dedcc76f18d15c5b56d64", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/19591f3d89f35c8b6278c200d10ad1c5ce89fbb1ef831cf509f86d469ed2ab853009488e7d34c20561919bd1cf71d73d30d83fd88c179335b1659c61c4437609"} build_url:https://queue.taskcluster.net/v1/task/IGAcqI8aQ9CpppxwgGmqAA/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011142 build_url: 'https://queue.taskcluster.net/v1/task/IGAcqI8aQ9CpppxwgGmqAA/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/b7b9f2a50ca2585a237bbb455fff2de7bc7c755f2c8780e8e43d8cb8f4441823b7fd866c42073113771f6ee6273e0bb41294ba0a9849f75203db2b9f841a486d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/17acc4daed3028326ab50e5a68c8f26459083e4e31ba7b8b16e64e5ec80d1c79ecae282dbc84ff56067e34acd7d4304b558b4841071dedcc76f18d15c5b56d64", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/19591f3d89f35c8b6278c200d10ad1c5ce89fbb1ef831cf509f86d469ed2ab853009488e7d34c20561919bd1cf71d73d30d83fd88c179335b1659c61c4437609"}' ========= master_lag: 0.59 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-21 23:17:28.382725) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-21 23:17:28.383107) ========= 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.09ArzxQ1TO/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.LdqRs4GF48/Listeners TMPDIR=/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/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.004389 ========= master_lag: 0.02 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-21 23:17:28.410535) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-21 23:17:28.410938) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-21 23:17:28.411259) ========= ========= Total master_lag: 4.13 =========