builder: autoland_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0158 starttime: 1474945488.42 results: success (0) buildid: 20160926180050 builduid: cd5cd23f99e240e3862b0053706a6e37 revision: 0b7bf04ea3473df47cb569b5d9dc2b0aba05585e ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-09-26 20:04:48.423648) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-09-26 20:04:48.424110) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-26 20:04:48.424380) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-26 20:04:48.521068) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-26 20:04:48.521364) ========= 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.ElAHZnOdet/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.jsZHGJwj8v/Listeners TMPDIR=/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/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-26 20:04:48-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 9.84M=0.001s 2016-09-26 20:04:49 (9.84 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.528464 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-26 20:04:49.073768) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-26 20:04:49.074091) ========= 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.ElAHZnOdet/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.jsZHGJwj8v/Listeners TMPDIR=/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/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.028021 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-26 20:04:49.123153) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-09-26 20:04:49.123493) ========= bash -c 'python archiver_client.py mozharness --repo integration/autoland --rev 0b7bf04ea3473df47cb569b5d9dc2b0aba05585e --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 0b7bf04ea3473df47cb569b5d9dc2b0aba05585e --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.ElAHZnOdet/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.jsZHGJwj8v/Listeners TMPDIR=/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/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-26 20:04:49,204 truncating revision to first 12 chars 2016-09-26 20:04:49,204 Setting DEBUG logging. 2016-09-26 20:04:49,204 attempt 1/10 2016-09-26 20:04:49,204 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/0b7bf04ea347?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-09-26 20:04:50,018 unpacking tar archive at: autoland-0b7bf04ea347/testing/mozharness/ program finished with exit code 0 elapsedTime=1.899685 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-09-26 20:04:51.045560) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-26 20:04:51.045896) ========= script_repo_revision: 0b7bf04ea3473df47cb569b5d9dc2b0aba05585e ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-26 20:04:51.046290) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-26 20:04:51.046556) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-26 20:04:51.065661) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 21 secs) (at 2016-09-26 20:04:51.066071) ========= /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.ElAHZnOdet/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.jsZHGJwj8v/Listeners TMPDIR=/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/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 20:04:51 INFO - MultiFileLogger online at 20160926 20:04:51 in /builds/slave/test 20:04:51 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 20:04:51 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 20:04:51 INFO - {'append_to_log': False, 20:04:51 INFO - 'base_work_dir': '/builds/slave/test', 20:04:51 INFO - 'blob_upload_branch': 'Autoland', 20:04:51 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 20:04:51 INFO - 'branch': 'Autoland', 20:04:51 INFO - 'buildbot_json_path': 'buildprops.json', 20:04:51 INFO - 'config_files': ('talos/mac_config.py',), 20:04:51 INFO - 'default_actions': ('clobber', 20:04:51 INFO - 'read-buildbot-config', 20:04:51 INFO - 'download-and-extract', 20:04:51 INFO - 'populate-webroot', 20:04:51 INFO - 'create-virtualenv', 20:04:51 INFO - 'install', 20:04:51 INFO - 'run-tests'), 20:04:51 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 20:04:51 INFO - 'download_minidump_stackwalk': True, 20:04:51 INFO - 'download_symbols': 'ondemand', 20:04:51 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 20:04:51 INFO - 'tooltool.py': '/tools/tooltool.py', 20:04:51 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 20:04:51 INFO - '/tools/misc-python/virtualenv.py')}, 20:04:51 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 20:04:51 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 20:04:51 INFO - 'installer_path': 'installer.exe', 20:04:51 INFO - 'log_level': 'info', 20:04:51 INFO - 'log_name': 'talos', 20:04:51 INFO - 'log_to_console': True, 20:04:51 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 20:04:51 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 20:04:51 INFO - 'opt_config_files': (), 20:04:51 INFO - 'pip_index': False, 20:04:51 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 20:04:51 INFO - 'cmd': ('bash', 20:04:51 INFO - '-c', 20:04:51 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 20:04:51 INFO - 'enabled': True, 20:04:51 INFO - 'halt_on_failure': False, 20:04:51 INFO - 'name': 'check_screen_resolution'},), 20:04:51 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 20:04:51 INFO - 'cmd': ('bash', 20:04:51 INFO - '-c', 20:04:51 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 20:04:51 INFO - 'enabled': True, 20:04:51 INFO - 'halt_on_failure': False, 20:04:51 INFO - 'name': 'check_screen_resolution'},), 20:04:51 INFO - 'run_cmd_checks_enabled': True, 20:04:51 INFO - 'sps_profile': False, 20:04:51 INFO - 'sps_profile_interval': 0, 20:04:51 INFO - 'suite': 'dromaeojs', 20:04:51 INFO - 'system_bits': '32', 20:04:51 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 20:04:51 INFO - 'title': 't-yosemite-r7-0158', 20:04:51 INFO - 'tooltool_cache': '/builds/tooltool_cache', 20:04:51 INFO - 'use_talos_json': True, 20:04:51 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 20:04:51 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 20:04:51 INFO - 'work_dir': 'build'} 20:04:51 INFO - [mozharness: 2016-09-27 03:04:51.278967Z] Running clobber step. 20:04:51 INFO - Running pre-action listener: _resource_record_pre_action 20:04:51 INFO - Running main action method: clobber 20:04:51 INFO - rmtree: /builds/slave/test/build 20:04:51 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 20:04:53 INFO - Running post-action listener: _resource_record_post_action 20:04:53 INFO - [mozharness: 2016-09-27 03:04:53.380980Z] Finished clobber step (success) 20:04:53 INFO - [mozharness: 2016-09-27 03:04:53.381146Z] Running read-buildbot-config step. 20:04:53 INFO - Running pre-action listener: _resource_record_pre_action 20:04:53 INFO - Running main action method: read_buildbot_config 20:04:53 INFO - Using buildbot properties: 20:04:53 INFO - { 20:04:53 INFO - "project": "", 20:04:53 INFO - "product": "firefox", 20:04:53 INFO - "script_repo_revision": "production", 20:04:53 INFO - "builddir": "autoland_yosemite_r7_test-dromaeojs", 20:04:53 INFO - "repository": "", 20:04:53 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 autoland talos dromaeojs", 20:04:53 INFO - "buildid": "20160926180050", 20:04:53 INFO - "pgo_build": "False", 20:04:53 INFO - "basedir": "/builds/slave/test", 20:04:53 INFO - "buildnumber": 193, 20:04:53 INFO - "slavename": "t-yosemite-r7-0158", 20:04:53 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 20:04:53 INFO - "platform": "yosemite_r7", 20:04:53 INFO - "scheduler": "tests-autoland-macosx64-talos", 20:04:53 INFO - "branch": "autoland", 20:04:53 INFO - "repo_path": "integration/autoland", 20:04:53 INFO - "revision": "0b7bf04ea3473df47cb569b5d9dc2b0aba05585e", 20:04:53 INFO - "stage_platform": "macosx64", 20:04:53 INFO - "builduid": "cd5cd23f99e240e3862b0053706a6e37", 20:04:53 INFO - "slavebuilddir": "test" 20:04:53 INFO - } 20:04:53 INFO - Found installer url https://queue.taskcluster.net/v1/task/PIrAxiWaSum_14VKJH53CQ/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg. 20:04:53 INFO - Running post-action listener: _resource_record_post_action 20:04:53 INFO - [mozharness: 2016-09-27 03:04:53.384546Z] Finished read-buildbot-config step (success) 20:04:53 INFO - [mozharness: 2016-09-27 03:04:53.384662Z] Running download-and-extract step. 20:04:53 INFO - Running pre-action listener: _resource_record_pre_action 20:04:53 INFO - Running main action method: download_and_extract 20:04:53 INFO - mkdir: /builds/slave/test/build/tests 20:04:53 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')]} 20:04:53 INFO - trying https://queue.taskcluster.net/v1/task/PIrAxiWaSum_14VKJH53CQ/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json 20:04:53 INFO - Downloading https://queue.taskcluster.net/v1/task/PIrAxiWaSum_14VKJH53CQ/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 20:04:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/PIrAxiWaSum_14VKJH53CQ/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 20:04:54 INFO - Downloaded 1199 bytes. 20:04:54 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json 20:04:54 INFO - Using the following test package requirements: 20:04:54 INFO - {u'common': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 20:04:54 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 20:04:54 INFO - u'firefox-52.0a1.en-US.mac.cppunittest.tests.zip'], 20:04:54 INFO - u'gtest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 20:04:54 INFO - u'firefox-52.0a1.en-US.mac.gtest.tests.zip'], 20:04:54 INFO - u'jittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 20:04:54 INFO - u'jsshell-mac.zip'], 20:04:54 INFO - u'mochitest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 20:04:54 INFO - u'firefox-52.0a1.en-US.mac.mochitest.tests.zip'], 20:04:54 INFO - u'mozbase': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 20:04:54 INFO - u'reftest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 20:04:54 INFO - u'firefox-52.0a1.en-US.mac.reftest.tests.zip'], 20:04:54 INFO - u'talos': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 20:04:54 INFO - u'firefox-52.0a1.en-US.mac.talos.tests.zip'], 20:04:54 INFO - u'web-platform': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 20:04:54 INFO - u'firefox-52.0a1.en-US.mac.web-platform.tests.zip'], 20:04:54 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 20:04:54 INFO - u'firefox-52.0a1.en-US.mac.xpcshell.tests.zip']} 20:04:54 INFO - Downloading packages: [u'firefox-52.0a1.en-US.mac.common.tests.zip'] for test suite category: common 20:04:54 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/PIrAxiWaSum_14VKJH53CQ/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 20:04:54 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/PIrAxiWaSum_14VKJH53CQ/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 20:04:54 INFO - Fetch https://queue.taskcluster.net/v1/task/PIrAxiWaSum_14VKJH53CQ/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 20:04:54 INFO - Expected file size: 16468934 20:05:01 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 20:05:01 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/PIrAxiWaSum_14VKJH53CQ/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 20:05:01 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/PIrAxiWaSum_14VKJH53CQ/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 20:05:01 INFO - Fetch https://queue.taskcluster.net/v1/task/PIrAxiWaSum_14VKJH53CQ/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 20:05:02 INFO - Expected file size: 16468934 20:05:09 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/PIrAxiWaSum_14VKJH53CQ/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip 20:05:09 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/PIrAxiWaSum_14VKJH53CQ/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip'}, attempt #1 20:05:09 INFO - Fetch https://queue.taskcluster.net/v1/task/PIrAxiWaSum_14VKJH53CQ/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip into memory 20:05:10 INFO - Expected file size: 14414057 20:05:11 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')]} 20:05:11 INFO - trying https://queue.taskcluster.net/v1/task/PIrAxiWaSum_14VKJH53CQ/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 20:05:11 INFO - Downloading https://queue.taskcluster.net/v1/task/PIrAxiWaSum_14VKJH53CQ/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg 20:05:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/PIrAxiWaSum_14VKJH53CQ/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 20:05:19 INFO - Downloaded 111600007 bytes. 20:05:19 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/PIrAxiWaSum_14VKJH53CQ/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 20:05:19 INFO - mkdir: /builds/slave/test/properties 20:05:19 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 20:05:19 INFO - Writing to file /builds/slave/test/properties/build_url 20:05:19 INFO - Contents: 20:05:19 INFO - build_url:https://queue.taskcluster.net/v1/task/PIrAxiWaSum_14VKJH53CQ/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 20:05:20 INFO - Running post-action listener: _resource_record_post_action 20:05:20 INFO - Running post-action listener: set_extra_try_arguments 20:05:20 INFO - [mozharness: 2016-09-27 03:05:20.229269Z] Finished download-and-extract step (success) 20:05:20 INFO - [mozharness: 2016-09-27 03:05:20.229385Z] Running populate-webroot step. 20:05:20 INFO - Running pre-action listener: _resource_record_pre_action 20:05:20 INFO - Running main action method: populate_webroot 20:05:20 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 20:05:20 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 20:05:20 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 20:05:20 INFO - '--tppagecycles', 20:05:20 INFO - '7'], 20:05:20 INFO - 'tests': ['tsvgm']}}, 20:05:20 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 20:05:20 INFO - 'tests': ['tresize', 'tcanvasmark']}, 20:05:20 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 20:05:20 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 20:05:20 INFO - 'tests': ['dromaeo_css', 'kraken']}, 20:05:20 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 20:05:20 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:05:20 INFO - 'talos_options': ['--disable-e10s'], 20:05:20 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:05:20 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:05:20 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:05:20 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:05:20 INFO - 'talos_options': ['--disable-e10s'], 20:05:20 INFO - 'tests': ['damp', 'tps']}, 20:05:20 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:05:20 INFO - 'tests': ['damp', 'tps']}, 20:05:20 INFO - 'g3': {'talos_options': ['--disable-e10s'], 20:05:20 INFO - 'tests': ['dromaeo_dom']}, 20:05:20 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 20:05:20 INFO - 'g4': {'talos_options': ['--disable-e10s'], 20:05:20 INFO - 'tests': ['basic_compositor_video']}, 20:05:20 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 20:05:20 INFO - 'other': {'talos_options': ['--disable-e10s'], 20:05:20 INFO - 'tests': ['a11yr', 20:05:20 INFO - 'ts_paint', 20:05:20 INFO - 'tpaint', 20:05:20 INFO - 'sessionrestore', 20:05:20 INFO - 'sessionrestore_no_auto_restore', 20:05:20 INFO - 'tabpaint']}, 20:05:20 INFO - 'other-e10s': {'tests': ['a11yr', 20:05:20 INFO - 'ts_paint', 20:05:20 INFO - 'tpaint', 20:05:20 INFO - 'sessionrestore', 20:05:20 INFO - 'sessionrestore_no_auto_restore', 20:05:20 INFO - 'tabpaint']}, 20:05:20 INFO - 'other-e10s_l64': {'tests': ['a11yr', 20:05:20 INFO - 'ts_paint', 20:05:20 INFO - 'tpaint', 20:05:20 INFO - 'sessionrestore', 20:05:20 INFO - 'sessionrestore_no_auto_restore', 20:05:20 INFO - 'tabpaint']}, 20:05:20 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 20:05:20 INFO - 'ts_paint', 20:05:20 INFO - 'tpaint', 20:05:20 INFO - 'sessionrestore', 20:05:20 INFO - 'sessionrestore_no_auto_restore', 20:05:20 INFO - 'tabpaint']}, 20:05:20 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 20:05:20 INFO - 'tests': ['a11yr', 20:05:20 INFO - 'ts_paint', 20:05:20 INFO - 'tpaint', 20:05:20 INFO - 'sessionrestore', 20:05:20 INFO - 'sessionrestore_no_auto_restore', 20:05:20 INFO - 'tabpaint']}, 20:05:20 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 20:05:20 INFO - 'tests': ['a11yr', 20:05:20 INFO - 'ts_paint', 20:05:20 INFO - 'tpaint', 20:05:20 INFO - 'sessionrestore', 20:05:20 INFO - 'sessionrestore_no_auto_restore', 20:05:20 INFO - 'tabpaint']}, 20:05:20 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 20:05:20 INFO - 'tests': ['tsvgx', 20:05:20 INFO - 'tsvgr_opacity', 20:05:20 INFO - 'tart', 20:05:20 INFO - 'tscrollx', 20:05:20 INFO - 'cart']}, 20:05:20 INFO - 'svgr-e10s': {'tests': ['tsvgx', 20:05:20 INFO - 'tsvgr_opacity', 20:05:20 INFO - 'tart', 20:05:20 INFO - 'tscrollx', 20:05:20 INFO - 'cart']}, 20:05:20 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:05:20 INFO - 'talos_options': ['--disable-e10s'], 20:05:20 INFO - 'tests': ['tp5o']}, 20:05:20 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:05:20 INFO - 'tests': ['tp5o']}, 20:05:20 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:05:20 INFO - 'talos_options': ['--disable-e10s', 20:05:20 INFO - '--xperf_path', 20:05:20 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:05:20 INFO - 'tests': ['tp5n']}, 20:05:20 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:05:20 INFO - 'talos_options': ['--xperf_path', 20:05:20 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:05:20 INFO - 'tests': ['tp5n']}}, 20:05:20 INFO - 'talos.zip': {'path': '', 20:05:20 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 20:05:20 INFO - Running post-action listener: _resource_record_post_action 20:05:20 INFO - [mozharness: 2016-09-27 03:05:20.247963Z] Finished populate-webroot step (success) 20:05:20 INFO - [mozharness: 2016-09-27 03:05:20.248072Z] Running create-virtualenv step. 20:05:20 INFO - Running pre-action listener: _resource_record_pre_action 20:05:20 INFO - Running main action method: create_virtualenv 20:05:20 INFO - Creating virtualenv /builds/slave/test/build/venv 20:05:20 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 20:05:20 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 20:05:20 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 20:05:20 INFO - Using real prefix '/tools/python27' 20:05:20 INFO - New python executable in /builds/slave/test/build/venv/bin/python 20:05:21 INFO - Installing distribute.............................................................................................................................................................................................done. 20:05:23 INFO - Installing pip.................done. 20:05:23 INFO - Return code: 0 20:05:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 20:05:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 20:05:24 INFO - Reading from file tmpfile_stdout 20:05:24 INFO - Output received: 20:05:24 INFO - pip 1.5.5 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 20:05:24 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 20:05:24 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')]} 20:05:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:05:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:05:24 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')]} 20:05:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:05:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:05:24 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 0x109869490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1097df570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb4694569e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10967dd30>, '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 0x1094a3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109675b20>, '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.ElAHZnOdet/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.jsZHGJwj8v/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/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 20:05:24 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 20:05:24 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 20:05:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ElAHZnOdet/Render', 20:05:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:05:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:05:24 INFO - 'HOME': '/Users/cltbld', 20:05:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:05:24 INFO - 'LOGNAME': 'cltbld', 20:05:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:05:24 INFO - 'MOZ_NO_REMOTE': '1', 20:05:24 INFO - 'NO_EM_RESTART': '1', 20:05:24 INFO - 'PAGER': '/bin/cat', 20:05:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:05:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:05:24 INFO - 'PWD': '/builds/slave/test', 20:05:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:05:24 INFO - 'SHELL': '/bin/bash', 20:05:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jsZHGJwj8v/Listeners', 20:05:24 INFO - 'TMPDIR': '/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/', 20:05:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:05:24 INFO - 'USER': 'cltbld', 20:05:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:05:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:05:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:05:24 INFO - 'XPC_FLAGS': '0x0', 20:05:24 INFO - 'XPC_SERVICE_NAME': '0', 20:05:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:05:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:05:24 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 20:05:24 INFO - Cleaning up... 20:05:24 INFO - Return code: 0 20:05:24 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 20:05:24 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')]} 20:05:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:05:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:05:24 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')]} 20:05:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:05:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:05:24 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 0x109869490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1097df570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb4694569e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10967dd30>, '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 0x1094a3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109675b20>, '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.ElAHZnOdet/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.jsZHGJwj8v/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/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 20:05:24 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 20:05:24 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 20:05:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ElAHZnOdet/Render', 20:05:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:05:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:05:24 INFO - 'HOME': '/Users/cltbld', 20:05:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:05:24 INFO - 'LOGNAME': 'cltbld', 20:05:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:05:24 INFO - 'MOZ_NO_REMOTE': '1', 20:05:24 INFO - 'NO_EM_RESTART': '1', 20:05:24 INFO - 'PAGER': '/bin/cat', 20:05:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:05:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:05:24 INFO - 'PWD': '/builds/slave/test', 20:05:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:05:24 INFO - 'SHELL': '/bin/bash', 20:05:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jsZHGJwj8v/Listeners', 20:05:24 INFO - 'TMPDIR': '/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/', 20:05:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:05:24 INFO - 'USER': 'cltbld', 20:05:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:05:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:05:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:05:24 INFO - 'XPC_FLAGS': '0x0', 20:05:24 INFO - 'XPC_SERVICE_NAME': '0', 20:05:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:05:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:05:24 INFO - Downloading/unpacking psutil>=3.1.1 20:05:24 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 20:05:24 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 20:05:24 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 20:05:24 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 20:05:24 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 20:05:24 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 20:05:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 20:05:28 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:05:28 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:05:28 INFO - Installing collected packages: psutil 20:05:28 INFO - Running setup.py install for psutil 20:05:28 INFO - building 'psutil._psutil_osx' extension 20:05:28 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 20:05:29 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 20:05:29 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 20:05:29 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 20:05:29 INFO - building 'psutil._psutil_posix' extension 20:05:29 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 20:05:29 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 20:05:29 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 20:05:29 INFO - ^ 20:05:29 INFO - 1 warning generated. 20:05:29 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 20:05:29 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:05:29 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:05:29 INFO - Successfully installed psutil 20:05:29 INFO - Cleaning up... 20:05:29 INFO - Return code: 0 20:05:29 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 20:05:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:05:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:05:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:05:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:05:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:05:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:05:29 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x109869490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1097df570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb4694569e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10967dd30>, '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 0x1094a3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109675b20>, '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.ElAHZnOdet/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.jsZHGJwj8v/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/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 20:05:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 20:05:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 20:05:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ElAHZnOdet/Render', 20:05:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:05:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:05:29 INFO - 'HOME': '/Users/cltbld', 20:05:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:05:29 INFO - 'LOGNAME': 'cltbld', 20:05:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:05:29 INFO - 'MOZ_NO_REMOTE': '1', 20:05:29 INFO - 'NO_EM_RESTART': '1', 20:05:29 INFO - 'PAGER': '/bin/cat', 20:05:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:05:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:05:29 INFO - 'PWD': '/builds/slave/test', 20:05:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:05:29 INFO - 'SHELL': '/bin/bash', 20:05:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jsZHGJwj8v/Listeners', 20:05:29 INFO - 'TMPDIR': '/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/', 20:05:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:05:29 INFO - 'USER': 'cltbld', 20:05:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:05:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:05:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:05:29 INFO - 'XPC_FLAGS': '0x0', 20:05:29 INFO - 'XPC_SERVICE_NAME': '0', 20:05:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:05:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:05:29 INFO - Downloading/unpacking mozsystemmonitor==0.3 20:05:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:05:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:05:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:05:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:05:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:05:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:05:32 INFO - Downloading mozsystemmonitor-0.3.tar.gz 20:05:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 20:05:32 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 20:05:32 INFO - Installing collected packages: mozsystemmonitor 20:05:32 INFO - Running setup.py install for mozsystemmonitor 20:05:32 INFO - Successfully installed mozsystemmonitor 20:05:32 INFO - Cleaning up... 20:05:32 INFO - Return code: 0 20:05:32 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 20:05:32 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')]} 20:05:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:05:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:05:32 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')]} 20:05:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:05:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:05:32 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 0x109869490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1097df570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb4694569e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10967dd30>, '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 0x1094a3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109675b20>, '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.ElAHZnOdet/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.jsZHGJwj8v/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/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 20:05:32 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 20:05:32 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 20:05:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ElAHZnOdet/Render', 20:05:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:05:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:05:32 INFO - 'HOME': '/Users/cltbld', 20:05:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:05:32 INFO - 'LOGNAME': 'cltbld', 20:05:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:05:32 INFO - 'MOZ_NO_REMOTE': '1', 20:05:32 INFO - 'NO_EM_RESTART': '1', 20:05:32 INFO - 'PAGER': '/bin/cat', 20:05:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:05:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:05:32 INFO - 'PWD': '/builds/slave/test', 20:05:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:05:32 INFO - 'SHELL': '/bin/bash', 20:05:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jsZHGJwj8v/Listeners', 20:05:32 INFO - 'TMPDIR': '/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/', 20:05:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:05:32 INFO - 'USER': 'cltbld', 20:05:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:05:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:05:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:05:32 INFO - 'XPC_FLAGS': '0x0', 20:05:32 INFO - 'XPC_SERVICE_NAME': '0', 20:05:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:05:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:05:32 INFO - Downloading/unpacking jsonschema==2.5.1 20:05:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:05:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:05:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:05:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:05:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:05:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:05:35 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 20:05:35 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 20:05: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 20:05: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 20:05: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 20:05: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 20:05: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 20:05: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 20:05:35 INFO - Downloading functools32-3.2.3-2.tar.gz 20:05:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 20:05:35 INFO - warning: no files found matching '*.txt' 20:05:35 INFO - no previously-included directories found matching 'build' 20:05:35 INFO - no previously-included directories found matching 'dist' 20:05:35 INFO - no previously-included directories found matching '.git*' 20:05:35 INFO - Installing collected packages: jsonschema, functools32 20:05:35 INFO - Running setup.py install for functools32 20:05:36 INFO - warning: no files found matching '*.txt' 20:05:36 INFO - no previously-included directories found matching 'build' 20:05:36 INFO - no previously-included directories found matching 'dist' 20:05:36 INFO - no previously-included directories found matching '.git*' 20:05:36 INFO - Successfully installed jsonschema functools32 20:05:36 INFO - Cleaning up... 20:05:36 INFO - Return code: 0 20:05:36 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 20:05:36 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')]} 20:05:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:05:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:05:36 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')]} 20:05:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:05:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:05:36 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 0x109869490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1097df570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb4694569e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10967dd30>, '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 0x1094a3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109675b20>, '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.ElAHZnOdet/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.jsZHGJwj8v/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/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 20:05:36 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 20:05:36 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 20:05:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ElAHZnOdet/Render', 20:05:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:05:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:05:36 INFO - 'HOME': '/Users/cltbld', 20:05:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:05:36 INFO - 'LOGNAME': 'cltbld', 20:05:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:05:36 INFO - 'MOZ_NO_REMOTE': '1', 20:05:36 INFO - 'NO_EM_RESTART': '1', 20:05:36 INFO - 'PAGER': '/bin/cat', 20:05:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:05:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:05:36 INFO - 'PWD': '/builds/slave/test', 20:05:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:05:36 INFO - 'SHELL': '/bin/bash', 20:05:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jsZHGJwj8v/Listeners', 20:05:36 INFO - 'TMPDIR': '/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/', 20:05:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:05:36 INFO - 'USER': 'cltbld', 20:05:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:05:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:05:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:05:36 INFO - 'XPC_FLAGS': '0x0', 20:05:36 INFO - 'XPC_SERVICE_NAME': '0', 20:05:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:05:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:05:36 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 20:05:36 INFO - Cleaning up... 20:05:36 INFO - Return code: 0 20:05:36 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 20:05:36 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')]} 20:05:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:05:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:05:36 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')]} 20:05:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:05:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:05:36 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 0x109869490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1097df570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb4694569e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10967dd30>, '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 0x1094a3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109675b20>, '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.ElAHZnOdet/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.jsZHGJwj8v/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/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 20:05:36 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 20:05:36 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 20:05:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ElAHZnOdet/Render', 20:05:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:05:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:05:36 INFO - 'HOME': '/Users/cltbld', 20:05:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:05:36 INFO - 'LOGNAME': 'cltbld', 20:05:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:05:36 INFO - 'MOZ_NO_REMOTE': '1', 20:05:36 INFO - 'NO_EM_RESTART': '1', 20:05:36 INFO - 'PAGER': '/bin/cat', 20:05:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:05:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:05:36 INFO - 'PWD': '/builds/slave/test', 20:05:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:05:36 INFO - 'SHELL': '/bin/bash', 20:05:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jsZHGJwj8v/Listeners', 20:05:36 INFO - 'TMPDIR': '/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/', 20:05:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:05:36 INFO - 'USER': 'cltbld', 20:05:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:05:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:05:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:05:36 INFO - 'XPC_FLAGS': '0x0', 20:05:36 INFO - 'XPC_SERVICE_NAME': '0', 20:05:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:05:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:05:36 INFO - Downloading/unpacking blobuploader==1.2.4 20:05:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:05:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:05:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:05:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:05:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:05:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:05:39 INFO - Downloading blobuploader-1.2.4.tar.gz 20:05:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 20:05:39 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 20:05:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:05:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:05:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:05:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:05:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:05:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:05:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 20:05:39 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 20:05:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:05:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:05:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:05:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:05:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:05:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:05:40 INFO - Downloading docopt-0.6.1.tar.gz 20:05:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 20:05:40 INFO - Installing collected packages: blobuploader, requests, docopt 20:05:40 INFO - Running setup.py install for blobuploader 20:05:40 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 20:05:40 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 20:05:40 INFO - Running setup.py install for requests 20:05:40 INFO - Running setup.py install for docopt 20:05:41 INFO - Successfully installed blobuploader requests docopt 20:05:41 INFO - Cleaning up... 20:05:41 INFO - Return code: 0 20:05:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:05:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:05:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:05:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:05:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:05:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:05:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:05:41 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 0x109869490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1097df570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb4694569e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10967dd30>, '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 0x1094a3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109675b20>, '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.ElAHZnOdet/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.jsZHGJwj8v/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/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 20:05:41 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 20:05:41 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 20:05:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ElAHZnOdet/Render', 20:05:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:05:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:05:41 INFO - 'HOME': '/Users/cltbld', 20:05:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:05:41 INFO - 'LOGNAME': 'cltbld', 20:05:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:05:41 INFO - 'MOZ_NO_REMOTE': '1', 20:05:41 INFO - 'NO_EM_RESTART': '1', 20:05:41 INFO - 'PAGER': '/bin/cat', 20:05:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:05:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:05:41 INFO - 'PWD': '/builds/slave/test', 20:05:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:05:41 INFO - 'SHELL': '/bin/bash', 20:05:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jsZHGJwj8v/Listeners', 20:05:41 INFO - 'TMPDIR': '/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/', 20:05:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:05:41 INFO - 'USER': 'cltbld', 20:05:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:05:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:05:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:05:41 INFO - 'XPC_FLAGS': '0x0', 20:05:41 INFO - 'XPC_SERVICE_NAME': '0', 20:05:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:05:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:05:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:05:41 INFO - Running setup.py (path:/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/pip-TVLqFr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:05:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:05:41 INFO - Running setup.py (path:/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/pip-FkNbHi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:05:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:05:41 INFO - Running setup.py (path:/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/pip-SxrpZr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:05:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:05:41 INFO - Running setup.py (path:/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/pip-MEqmQr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:05:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:05:41 INFO - Running setup.py (path:/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/pip-rkmQVo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:05:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:05:42 INFO - Running setup.py (path:/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/pip-Tm15yE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:05:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:05:42 INFO - Running setup.py (path:/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/pip-y1BhK1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:05:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:05:42 INFO - Running setup.py (path:/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/pip-7eY4s0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:05:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:05:42 INFO - Running setup.py (path:/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/pip-S1KEhM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:05:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:05:42 INFO - Running setup.py (path:/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/pip-qP77qQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:05:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:05:42 INFO - Running setup.py (path:/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/pip-K9b4Mq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:05:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:05:42 INFO - Running setup.py (path:/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/pip-I7Vs_t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:05:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:05:42 INFO - Running setup.py (path:/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/pip-48xszF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:05:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:05:42 INFO - Running setup.py (path:/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/pip-vfezeI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:05:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:05:42 INFO - Running setup.py (path:/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/pip-puS77K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:05:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:05:43 INFO - Running setup.py (path:/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/pip-mSVo2c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:05:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:05:43 INFO - Running setup.py (path:/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/pip-uleytL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:05:43 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 20:05:43 INFO - Running setup.py install for manifestparser 20:05:43 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 20:05:43 INFO - Running setup.py install for mozcrash 20:05:43 INFO - Running setup.py install for mozdebug 20:05:43 INFO - Running setup.py install for mozdevice 20:05:43 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 20:05:43 INFO - Installing dm script to /builds/slave/test/build/venv/bin 20:05:43 INFO - Running setup.py install for mozfile 20:05:43 INFO - Running setup.py install for mozhttpd 20:05:44 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 20:05:44 INFO - Running setup.py install for mozinfo 20:05:44 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 20:05:44 INFO - Running setup.py install for mozInstall 20:05:44 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 20:05:44 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 20:05:44 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 20:05:44 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 20:05:44 INFO - Running setup.py install for mozleak 20:05:44 INFO - Running setup.py install for mozlog 20:05:44 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 20:05:44 INFO - Running setup.py install for moznetwork 20:05:44 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 20:05:44 INFO - Running setup.py install for mozprocess 20:05:45 INFO - Running setup.py install for mozprofile 20:05:45 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 20:05:45 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 20:05:45 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 20:05:45 INFO - Running setup.py install for mozrunner 20:05:45 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 20:05:45 INFO - Running setup.py install for mozscreenshot 20:05:45 INFO - Running setup.py install for moztest 20:05:45 INFO - Running setup.py install for mozversion 20:05:45 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 20:05:45 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 20:05:45 INFO - Cleaning up... 20:05:45 INFO - Return code: 0 20:05:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:05:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:05:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:05:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:05:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:05:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:05:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:05:45 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 0x109869490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1097df570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb4694569e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10967dd30>, '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 0x1094a3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109675b20>, '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.ElAHZnOdet/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.jsZHGJwj8v/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/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 20:05:45 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 20:05:45 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 20:05:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ElAHZnOdet/Render', 20:05:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:05:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:05:45 INFO - 'HOME': '/Users/cltbld', 20:05:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:05:45 INFO - 'LOGNAME': 'cltbld', 20:05:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:05:45 INFO - 'MOZ_NO_REMOTE': '1', 20:05:45 INFO - 'NO_EM_RESTART': '1', 20:05:45 INFO - 'PAGER': '/bin/cat', 20:05:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:05:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:05:45 INFO - 'PWD': '/builds/slave/test', 20:05:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:05:45 INFO - 'SHELL': '/bin/bash', 20:05:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jsZHGJwj8v/Listeners', 20:05:45 INFO - 'TMPDIR': '/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/', 20:05:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:05:45 INFO - 'USER': 'cltbld', 20:05:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:05:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:05:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:05:45 INFO - 'XPC_FLAGS': '0x0', 20:05:45 INFO - 'XPC_SERVICE_NAME': '0', 20:05:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:05:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:05:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:05:46 INFO - Running setup.py (path:/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/pip-27TwtE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:05:46 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)) 20:05:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:05:46 INFO - Running setup.py (path:/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/pip-afea78-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:05:46 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)) 20:05:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:05:46 INFO - Running setup.py (path:/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/pip-xjurjP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:05:46 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)) 20:05:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:05:46 INFO - Running setup.py (path:/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/pip-S6e0Ob-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:05:46 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)) 20:05:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:05:46 INFO - Running setup.py (path:/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/pip-G4gFSe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:05:46 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)) 20:05:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:05:46 INFO - Running setup.py (path:/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/pip-wGJ0Oy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:05:46 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)) 20:05:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:05:46 INFO - Running setup.py (path:/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/pip-mwedb0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:05:46 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)) 20:05:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:05:46 INFO - Running setup.py (path:/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/pip-8vRkKG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:05:46 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)) 20:05:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:05:46 INFO - Running setup.py (path:/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/pip-XqBM9o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:05:47 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)) 20:05:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:05:47 INFO - Running setup.py (path:/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/pip-M49jVD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:05:47 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)) 20:05:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:05:47 INFO - Running setup.py (path:/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/pip-V8bxfm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:05:47 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)) 20:05:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:05:47 INFO - Running setup.py (path:/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/pip-ZC1WuW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:05:47 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)) 20:05:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:05:47 INFO - Running setup.py (path:/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/pip-s2IiE8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:05:47 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)) 20:05:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:05:47 INFO - Running setup.py (path:/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/pip-vlCuQz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:05:47 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)) 20:05:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:05:47 INFO - Running setup.py (path:/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/pip-UvGUxm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:05:47 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)) 20:05:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:05:47 INFO - Running setup.py (path:/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/pip-mxNC6m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:05:47 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)) 20:05:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:05:47 INFO - Running setup.py (path:/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/pip-AtafBf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:05:47 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)) 20:05:47 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)) 20:05:47 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)) 20:05:47 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)) 20:05:47 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)) 20:05:47 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)) 20:05:47 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 20:05: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 20:05: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 20:05: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 20:05: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 20:05: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 20:05: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 20:05:50 INFO - Downloading blessings-1.6.tar.gz 20:05:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 20:05:50 INFO - Installing collected packages: blessings 20:05:50 INFO - Running setup.py install for blessings 20:05:50 INFO - Successfully installed blessings 20:05:50 INFO - Cleaning up... 20:05:50 INFO - Return code: 0 20:05:50 INFO - Done creating virtualenv /builds/slave/test/build/venv. 20:05:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:05:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:05:50 INFO - Reading from file tmpfile_stdout 20:05:50 INFO - Current package versions: 20:05:50 INFO - blessings == 1.6 20:05:50 INFO - blobuploader == 1.2.4 20:05:50 INFO - docopt == 0.6.1 20:05:50 INFO - functools32 == 3.2.3-2 20:05:50 INFO - jsonschema == 2.5.1 20:05:50 INFO - manifestparser == 1.1 20:05:50 INFO - mozInstall == 1.12 20:05:50 INFO - mozcrash == 0.17 20:05:50 INFO - mozdebug == 0.1 20:05:50 INFO - mozdevice == 0.48 20:05:50 INFO - mozfile == 1.2 20:05:50 INFO - mozhttpd == 0.7 20:05:50 INFO - mozinfo == 0.9 20:05:50 INFO - mozleak == 0.1 20:05:50 INFO - mozlog == 3.4 20:05:50 INFO - moznetwork == 0.27 20:05:50 INFO - mozprocess == 0.23 20:05:50 INFO - mozprofile == 0.28 20:05:50 INFO - mozrunner == 6.12 20:05:50 INFO - mozscreenshot == 0.1 20:05:50 INFO - mozsystemmonitor == 0.3 20:05:50 INFO - moztest == 0.7 20:05:50 INFO - mozversion == 1.4 20:05:50 INFO - psutil == 3.1.1 20:05:50 INFO - requests == 1.2.3 20:05:50 INFO - wsgiref == 0.1.2 20:05:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:05:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:05:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:05:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:05:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:05:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:05:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:05:50 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 0x109869490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1097df570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb4694569e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10967dd30>, '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 0x1094a3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109675b20>, '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.ElAHZnOdet/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.jsZHGJwj8v/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/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 20:05:50 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 20:05:50 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 20:05:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ElAHZnOdet/Render', 20:05:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:05:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:05:50 INFO - 'HOME': '/Users/cltbld', 20:05:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:05:50 INFO - 'LOGNAME': 'cltbld', 20:05:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:05:50 INFO - 'MOZ_NO_REMOTE': '1', 20:05:50 INFO - 'NO_EM_RESTART': '1', 20:05:50 INFO - 'PAGER': '/bin/cat', 20:05:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:05:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:05:50 INFO - 'PWD': '/builds/slave/test', 20:05:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:05:50 INFO - 'SHELL': '/bin/bash', 20:05:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jsZHGJwj8v/Listeners', 20:05:50 INFO - 'TMPDIR': '/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/', 20:05:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:05:50 INFO - 'USER': 'cltbld', 20:05:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:05:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:05:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:05:50 INFO - 'XPC_FLAGS': '0x0', 20:05:50 INFO - 'XPC_SERVICE_NAME': '0', 20:05:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:05:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:05:51 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)) 20:05:51 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)) 20:05:51 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)) 20:05:51 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)) 20:05:51 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)) 20:05:51 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)) 20:05:51 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)) 20:05:51 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)) 20:05:51 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)) 20:05:51 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)) 20:05:51 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)) 20:05:51 INFO - Cleaning up... 20:05:51 INFO - Return code: 0 20:05:51 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 20:05:51 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')]} 20:05:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:05:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:05:51 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')]} 20:05:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:05:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:05:51 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 0x109869490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1097df570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb4694569e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10967dd30>, '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 0x1094a3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109675b20>, '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.ElAHZnOdet/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.jsZHGJwj8v/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/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 20:05:51 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 20:05:51 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 20:05:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ElAHZnOdet/Render', 20:05:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:05:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:05:51 INFO - 'HOME': '/Users/cltbld', 20:05:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:05:51 INFO - 'LOGNAME': 'cltbld', 20:05:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:05:51 INFO - 'MOZ_NO_REMOTE': '1', 20:05:51 INFO - 'NO_EM_RESTART': '1', 20:05:51 INFO - 'PAGER': '/bin/cat', 20:05:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:05:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:05:51 INFO - 'PWD': '/builds/slave/test', 20:05:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:05:51 INFO - 'SHELL': '/bin/bash', 20:05:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jsZHGJwj8v/Listeners', 20:05:51 INFO - 'TMPDIR': '/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/', 20:05:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:05:51 INFO - 'USER': 'cltbld', 20:05:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:05:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:05:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:05:51 INFO - 'XPC_FLAGS': '0x0', 20:05:51 INFO - 'XPC_SERVICE_NAME': '0', 20:05:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:05:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:05:51 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 20:05:51 INFO - Cleaning up... 20:05:51 INFO - Return code: 0 20:05:51 INFO - Running post-action listener: _resource_record_post_action 20:05:51 INFO - Running post-action listener: _start_resource_monitoring 20:05:51 INFO - Starting resource monitoring. 20:05:51 INFO - [mozharness: 2016-09-27 03:05:51.553541Z] Finished create-virtualenv step (success) 20:05:51 INFO - [mozharness: 2016-09-27 03:05:51.554570Z] Running install step. 20:05:51 INFO - Running pre-action listener: _resource_record_pre_action 20:05:51 INFO - Running main action method: install 20:05:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:05:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:05:51 INFO - Reading from file tmpfile_stdout 20:05:51 INFO - Detecting whether we're running mozinstall >=1.0... 20:05:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 20:05:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 20:05:51 INFO - Reading from file tmpfile_stdout 20:05:51 INFO - Output received: 20:05:51 INFO - Usage: mozinstall [options] installer 20:05:51 INFO - Options: 20:05:51 INFO - -h, --help show this help message and exit 20:05:51 INFO - -d DEST, --destination=DEST 20:05:51 INFO - Directory to install application into. [default: 20:05:51 INFO - "/builds/slave/test"] 20:05:51 INFO - --app=APP Application being installed. [default: firefox] 20:05:51 INFO - mkdir: /builds/slave/test/build/application 20:05:51 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'] 20:05:51 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 20:06:26 INFO - Reading from file tmpfile_stdout 20:06:26 INFO - Output received: 20:06:26 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 20:06:26 INFO - Running post-action listener: _resource_record_post_action 20:06:26 INFO - [mozharness: 2016-09-27 03:06:26.128004Z] Finished install step (success) 20:06:26 INFO - [mozharness: 2016-09-27 03:06:26.128142Z] Running run-tests step. 20:06:26 INFO - Running pre-action listener: _resource_record_pre_action 20:06:26 INFO - Running main action method: run_tests 20:06:26 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 20:06:26 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 20:06:26 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 20:06:26 INFO - 2016-09-26 20:06:26.142 screenresolution[1658:10967] starting screenresolution argv=screenresolution get 20:06:26 INFO - 2016-09-26 20:06:26.145 screenresolution[1658:10967] Display 0: 1600x1200x32@60 20:06:26 INFO - 2016-09-26 20:06:26.151 screenresolution[1659:10969] starting screenresolution argv=screenresolution list 20:06:26 INFO - Available Modes on Display 0 20:06:26 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 20:06:26 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 20:06:26 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 20:06:26 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 20:06:26 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 20:06:26 INFO - Intel Iris: 20:06:26 INFO - Chipset Model: Intel Iris 20:06:26 INFO - Type: GPU 20:06:26 INFO - Bus: Built-In 20:06:26 INFO - VRAM (Dynamic, Max): 1536 MB 20:06:26 INFO - Vendor: Intel (0x8086) 20:06:26 INFO - Device ID: 0x0a2e 20:06:26 INFO - Revision ID: 0x0009 20:06:26 INFO - Displays: 20:06:26 INFO - Display: 20:06:26 INFO - Resolution: 1600 x 1200 @ 60 Hz 20:06:26 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 20:06:26 INFO - Display Serial Number: 1600x1200 60 20:06:26 INFO - Main Display: Yes 20:06:26 INFO - Mirror: Off 20:06:26 INFO - Online: Yes 20:06:26 INFO - Rotation: Supported 20:06:26 INFO - Return code: 0 20:06:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 20:06:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 20:06:26 INFO - Python 2.7.3 20:06:26 INFO - Return code: 0 20:06:26 INFO - grabbing minidump binary from tooltool 20:06:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:06:26 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 0x10967dd30>, '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 0x1094a3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109675b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 20:06:26 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 20:06:26 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 20:06:26 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 20:06:26 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 20:06:26 INFO - Return code: 0 20:06:26 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 20:06:26 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 20:06:26 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 20:06:26 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 20:06:26 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 20:06:26 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/PIrAxiWaSum_14VKJH53CQ/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0158', '--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 20:06:26 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/PIrAxiWaSum_14VKJH53CQ/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0158 --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 20:06:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ElAHZnOdet/Render', 20:06:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:06:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:06:26 INFO - 'HOME': '/Users/cltbld', 20:06:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:06:26 INFO - 'LOGNAME': 'cltbld', 20:06:26 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 20:06:26 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 20:06:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:06:26 INFO - 'MOZ_NO_REMOTE': '1', 20:06:26 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 20:06:26 INFO - 'NO_EM_RESTART': '1', 20:06:26 INFO - 'PAGER': '/bin/cat', 20:06:26 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:06:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:06:26 INFO - 'PWD': '/builds/slave/test', 20:06:26 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 20:06:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:06:26 INFO - 'SHELL': '/bin/bash', 20:06:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jsZHGJwj8v/Listeners', 20:06:26 INFO - 'TMPDIR': '/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/', 20:06:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:06:26 INFO - 'USER': 'cltbld', 20:06:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:06:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:06:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:06:26 INFO - 'XPC_FLAGS': '0x0', 20:06:26 INFO - 'XPC_SERVICE_NAME': '0', 20:06:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:06:26 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/PIrAxiWaSum_14VKJH53CQ/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0158', '--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 20:06:26 INFO - mozversion application_buildid: 20160926180050 20:06:26 INFO - mozversion application_changeset: 0b7bf04ea3473df47cb569b5d9dc2b0aba05585e 20:06:26 INFO - mozversion application_display_name: Nightly 20:06:26 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 20:06:26 INFO - mozversion application_name: Firefox 20:06:26 INFO - mozversion application_remotingname: firefox 20:06:26 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 20:06:26 INFO - mozversion application_vendor: Mozilla 20:06:26 INFO - mozversion application_version: 52.0a1 20:06:26 INFO - mozversion platform_buildid: 20160926180050 20:06:26 INFO - mozversion platform_changeset: 0b7bf04ea3473df47cb569b5d9dc2b0aba05585e 20:06:26 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 20:06:26 INFO - mozversion platform_version: 52.0a1 20:06:26 INFO - using testdate: 1474945586 20:06:26 INFO - actual date: 1474945586 20:06:26 INFO - starting webserver on 'localhost:49288' 20:06:26 INFO - SUITE-START | Running 2 tests 20:06:26 INFO - TEST-START | dromaeo_css 20:06:26 INFO - operating with platform_type : mac_ 20:06:26 INFO - Initialising browser for dromaeo_css test... 20:06:26 INFO - TEST-INFO | started process 1669 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/tmp8ShEIa/profile http://localhost:49288/getInfo.html) 20:06:29 INFO - PROCESS | 1669 | __metrics Screen width/height:1600/1200 20:06:29 INFO - PROCESS | 1669 | colorDepth:24 20:06:29 INFO - PROCESS | 1669 | Browser inner width/height: 1024/689 20:06:29 INFO - PROCESS | 1669 | __metrics 20:06:29 INFO - PROCESS | 1669 | 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" 20:06:29 INFO - PROCESS | 1669 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 20:06:29 INFO - TEST-INFO | 1669: exit 0 20:06:29 INFO - Browser initialized. 20:06:29 INFO - Running cycle 1/1 for dromaeo_css test... 20:06:29 INFO - TEST-INFO | started process 1672 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/tmp8ShEIa/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:06:41 INFO - PROCESS | 1672 | RSS: Main: 235864064 20:06:41 INFO - PROCESS | 1672 | 20:07:32 INFO - PROCESS | 1672 | 1474945652843 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] 20:09:44 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49288/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49288/tests/dromaeo/cssquery-ext.html) 20:09:46 INFO - PROCESS | 1672 | RSS: Main: 369799168 20:09:46 INFO - PROCESS | 1672 | 20:12:49 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49288/tests/dromaeo/cssquery-ext.html (next: http://localhost:49288/tests/dromaeo/cssquery-jquery.html) 20:12:50 INFO - PROCESS | 1672 | RSS: Main: 374366208 20:12:50 INFO - PROCESS | 1672 | 20:15:52 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49288/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49288/tests/dromaeo/cssquery-mootools.html) 20:15:53 INFO - PROCESS | 1672 | RSS: Main: 343269376 20:15:53 INFO - PROCESS | 1672 | 20:18:55 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49288/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49288/tests/dromaeo/cssquery-prototype.html) 20:18:56 INFO - PROCESS | 1672 | RSS: Main: 340967424 20:18:56 INFO - PROCESS | 1672 | 20:21:59 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49288/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49288/tests/dromaeo/cssquery-yui.html) 20:22:00 INFO - PROCESS | 1672 | RSS: Main: 335302656 20:22:00 INFO - PROCESS | 1672 | 20:25:03 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49288/tests/dromaeo/cssquery-yui.html (next: http://localhost:49288/tests/dromaeo/cssquery-dojo.html) 20:25:03 INFO - PROCESS | 1672 | RSS: Main: 436531200 20:25:03 INFO - PROCESS | 1672 | 20:25:03 INFO - PROCESS | 1672 | __start_tp_report 20:25:03 INFO - PROCESS | 1672 | _x_x_mozilla_page_load 20:25:03 INFO - PROCESS | 1672 | _x_x_mozilla_page_load_details 20:25:03 INFO - PROCESS | 1672 | |i|pagename|runs| 20:25:03 INFO - PROCESS | 1672 | |0;dojo.html;3320.966790332097;3326.251593391487;3331.633520312767;3366.0911553880437;3397.0488263286275;5461.781528738846;5618.269624948761;5653.830385088449;5698.629589076707;5698.715064246787;5602.019646561846;5660.66036037837;5686.289213848269;5757.963566558028;5771.134329850524;5076.746162691869;5105.438401775802;5202.1936599826895;5215.426303106655;5243.161094224924;5138.126518491866;5239.633225674185;5256.579473642099;5260.421353651095;5280.683159010472;5245.921311180336;5250.7374631268285;5266.973665131669;5303.496167864066;5364.490373414519;5073.568746656539;5105.387353517602;5114.795408183668;5116.565091967187;5157.819476318348;5076.086304465195;5083.74581270935;5117.948820511784;5140.768665410065;5208;5565.387807341189;5624.6343987641085;5660.320761508646;5674.2623458950075;5693.060644993571;5966.880662386728;6063.969680151615;6069.787557435468;6142.385761423867;6144.324124346318;5432.972835135799;6119.632822030692;6219.906701399483;6219.937800622027;6264.592801467936;5740.540756739534;5747.425257474303;5756.942430575725;5758.3665796762325;5759.337676167211;6109.009944784373;6125.9680843641045;6138.048602466535;6181.536384771161;6204.441600255908;5563.749631266603;5594.608377413542;5988.610740301953;6005.489533389624;6023;6121.908171377433;6125.479334256549;6152.723127459275;6155.907661385083;6156.29202641693;5736.225609542658;5802;5994;6087.66517841523;6100.359462256399;6103.992841181155;6122.459149553274;6144.293406258337;6188.566800324024;6189.133521307021;4894.241392584155;4900.313956046085;4906.656534042583;4907;4941.48114447985;4410.5368936261875;4432.955670443319;4433.6009759121835;4444.11117776446;4455.2648812946145;5610.438956104357;5612.326520817528;5662.801801936913;5679.630823996427;5713.771449141987;6256.405641464054;6258.874822503524;6267.1539342189135;6270.404311590391;6273.654948977759;5711;5720.342160651495;5734.6845923473775;5735.254416925773;5743.4543718346695;5134.306868572769;5237.109691352479;5338.386085600128;5351.812686555952;5353.892922141613;6200.689965501707;6247.156633854463;6263.718132683949;6273.780417685542;6295.087212354275;6233.407826256498;6249.1563638908165;6258.436740693177;6263.248410190807;6268.9969604863;5961;5978.880422391615;6261.686915654108;6269.686515674107;6298.338674439118;5970.402959703995;6053.182820319201;6054.273487181566;6061.575689701678;6095.725692343766;6233.968830156002;6237.5321850860455;6244.469220116341;6250.593711408744;6264.154339164337;5982.132590774227;6023.247094113236;6040.5097678877;6049.697515124314;6089.086637004485;5869.501092407193;5939.821805345847;5945.3757355477055;6006.279246490449;6029.366916473882;5850.94149058504;5854.531637469077;5863.120531920075;5867.031939729897;5875.706214689163;5985.25184351956;5999.220101386966;6026.698665066817;6041.546883983807;6129;5839.328477225004;5909.438603332676;5910.852228694317;5912.497437717842;5959.463648271676 20:25:03 INFO - PROCESS | 1672 | |1;ext.html;477.92114301140316;482.7272590986091;484.3388774323048;525.408914970658;533.5491509674324;25301.240962771124;27654.61726913654;33589.992300231;33670.83164584174;34579.827100864524;40255.99360016001;40458.59541404585;40720;40721.38917916234;40792;9591.136797688207;9761.170300524464;9761.463119528424;9769;9785.706428807112;8715.433496822718;8940.24007959321;9527.523623818815;11625.360605166712;11978;11761.470733816956;11784.7643047139;11801.940990295037;11848.17062805604;11875.287482751019;11656.883431165706;11722.17944743864;11727.88272117285;11733.296002239893;11752.118591105702;8579.356548258906;8812.339074569369;9638.855417168748;11719.472623731866;11733.178677492579;38252.61747382519;38511.80744096261;38629;38655.22689546221;38692.61307386918;3393.321335732863;3445.793252404864;3795.4686343911876;3923.960150560104;3965.940510892339;24985.125520606874;28920.019870839544;30278.09165725032;30441.695583044107;30657.846710766527;3233.4341490239112;3253.96746032539;3307.7849939753837;3311.122552523583;3353.5137405076125;346943;401896;404314.93527596816;404994;408027;54497.547610356836;54956.450435495935;55016.17475737867;55048;55053;57340.71329643325;57398.7130064347;57565.71217143888;57717.4228257712;57784.8443031137;15558.844411555965;15755.606109847346;15763.763543546856;15790.526284211492;15807.288672009787;11218.943905280421;12404.62786116418;12466.314352710506;12471.251724896536;12519.937400313122;13103.541376051982;13120.540781072617;13179.934100329438;14989.475368362055;15041.774373384407;5932.614380065282;6728;6929.757458488929;6946.756863509753;6972.9302706972285;874.842528344904;904.6562306323686;906.3972458315278;911.6216770040359;951.2342564235856;27651.58522622162;28943.56584651232;29240.588381949638;29714.851425742734;29736.702632973826;1006.3157053203745;1032.7418145463635;1081.1080858291941;1114.1588100983706;1142.2118738070706;13313.134646247963;14117.435302587986;15094.169820659969;15127.773083403757;15544;486341;487661;488359;489781;680784;45755.54244457513;54108.45891541113;55044.44955550473;55094.173587396224;57837.710811446515;1191.9404029798475;1335.7395307914862;1376.8554301798167;1386.5424409944897;1389.9444022238997;29192.562111568768;29341.706582933897;29507;29520.704792951794;30239.09282721522;45925.77037114793;46932;46964.295535567675;47080.293795592406;47081.76459117683;377127;380250;381436;382366;384901;36302.8184859074;37342.2531549362;37374.626253737115;37478.81260593679;37539.06152346213;43547.56452435562;44075.77962110169;44753.55246447624;44785;44878.326825097;36994;37073.44389834101;37341;38050;38552;36855.44716829196;37314.8134259327;37592.43611345777;38035.619643803206;38044;36067.81966090153;36154.27691446209;36533.45199822058;36669.816650917644;37125.07187320231;25521.744782551938;31429.52855707212;32564.743525647245;32588.83705581457;32652.51021234636;24378.75621243765;24402.389940251636;24452.877735611208;24868.50262994694;25294.241172764847 20:25:03 INFO - PROCESS | 1672 | |2;jquery.html;352.74249797647735;369.5971391183611;378.7140708764883;385.3891581842779;404.4903421688673;14732.96869219155;14856.108633481985;16548.503544893658;20129.19483220673;21045.158193672272;19781;20077.598448031065;20713.482162945933;20887.582248355062;20986.475338116517;4902.240152776308;6010.36891126432;6272.153259310003;6279.215098112736;6282.52881033922;6071.696415179245;6190.8452288692915;6207.348228435994;6209.068639704058;6213.596116252429;5934;6045.486133678621;6101.420365065312;6228.750849965996;6234;6077.696115194245;6138.815835524942;6143.569950103472;6144.293406258293;6154.384561543855;5189.403218629868;5248.081585722522;5304.867378315535;5334.199870019489;5336.199570064483;25608.23175304744;25652.230433087036;25760.742392576023;25822.483550329078;25938.351541211432;2281.498070424504;2292.1862738727846;2386.7016622922133;2435.866027368494;2443.1571107967725;15152.545423637308;15294.929354945158;15436.826918764373;15692.92153539225;16413.507594772174;1853.33280019193;1864.9813501864944;1911.3883557261681;1923.5671973805922;1937.6609093408597;88472.55763721204;111147.44426277898;113279;132633.3368333152;137890.6210937888;19634.50913727168;19981.500462488555;20515.076821543065;20582.588348232952;21120.89439552823;33247.00258992234;33438.3312333752;34086.147846303546;34404.82797586046;34637.30725385478;10636.829948705636;10745.462726863625;10975.451227438596;11074.446277686084;11145.275557088764;8897.110288971051;8901.020887702347;8906.86639700405;9069.954650226706;9122;8437.535935523605;9215.400998935047;9448.90551094494;9683.951580242194;9837.9016209837;3666.5233519642275;3757.6242375762754;3757.891422030508;3766.4162054881535;3838.616138386195;810.6797814863214;853.8633818588996;940.7554035950702;981.7496538382667;1004.1113614451264;20342.389728308175;21259.36221913314;21307.78692213058;21384.572308553743;21419;830.9198042544667;842.3135144856922;873.9207079257112;910.4582773249906;954.8112599813277;9369.531523423802;10399.220058495643;11317.547298107984;11320.71698207535;11377.88622113785;465504;477591;484490;489990;493278;87248;102284;124032.0607256122;129160.35419822841;130186.04720929194;879.3097418526554;900.2887718702152;966.6085235479642;968.9370190937567;971.6647756523988;11904;18830.811691882907;18918.527036823638;19375.224991000203;19514.707279390535;51405;52895.67760805857;53379.73310133425;53601.65995850135;54537.72731136319;64735.35264647293;67759.3224067753;68863.65568172127;69105.65447172732;70060;7707.92292077072;8223.383246256675;8256.380771442045;8298.792530186794;8433.620487077973;11821.29072255633;12978.93510532479;13060.151090179108;13433.66415839612;13514;9432.434053956784;11178;11625.302481851117;11677.299362038304;11789.646310610353;11083.334999900031;11094.44527773592;11320.37737924422;11481.770364592829;11607.187496875138;11572.18994670365;11701.941490292495;11810.704732381759;11849.763004739685;11899.04807615406;7964.84070318602;8238.546879921661;8309.37679674039;8403.201695838885;8411.62147703367;8886.60010299551;10791.244612877337;11272.436378181223;11373;11585.304881707125 20:25:03 INFO - PROCESS | 1672 | |3;mootools.html;1411.8235220597426;1491.0308299605256;1707.5816424975883;1882.783479899812;1919.5105248161717;8603.44077634954;9140.040295768948;9140.588673509692;9140.857392825905;9158;7961.92038079619;8233.752987410388;8239.91760082399;8729.083446238148;8931.73204803857;2387.176424133671;2417.867017314056;2419.250032489925;2424.309071914505;2426.9271921842374;2391.5575618510543;2399.6160614301716;2426.9271921842374;2428.963565546518;2430.307362401716;2241.9215327463544;2257.683924250606;2259.8757068361315;2261.513774538474;2265.830062745301;2262.2760716570706;2316.779905908953;2395.556821987929;2408.542376948374;2410.4817464245184;2374.062245413052;2391.198948352304;2400.327908185711;2402.711674599042;2403.771641694036;8935.776605584848;9033.909660903439;9064.138906803842;9067.319951003636;9076.546172691405;5256.106461901486;5421.620486565942;5422.728863556807;5426.158945363475;5428.185772134172;3147.339058797655;3656.3601369760186;3702.5927148013698;3707.3326801175776;3721.1999420124803;1095.9726006849812;1098.8022156011914;1099.2030777686193;1112.7996960547098;1124.4096849154178;11786;11830.704232394173;11844.822327665092;11850.585229516926;11870.821937670942;4526.456825181;4608.262677971508;4802.063597598435;4815.614750819926;4821.662483626183;10026.69919902404;10027.498625068718;10041.598336066621;10043.246756493292;10044.447555384524;5380.085385484477;5393.541548968382;5399.730013499309;5415.972920135374;5462.590305727086;4460.30865215892;4595.517470665599;4611.354410382549;4953.900921981613;4997.475265097112;3832.5784163741964;3896.279188350164;3944.8422063117155;3984.163325701635;4002.7398219115667;1077.7521170130758;1080.270817198388;1089.2647462962627;1093.6117678224116;1105.2870898270571;837.1837458477935;846.2552953400967;904.9095090490898;906.3655441191192;939.5020639061308;5539.307586551681;5702.201691763156;5794.50746686528;5872.655883146316;5946.762129514857;938.5401153434905;944.3719926249105;947.0766003147014;949.1837020162654;987.4322264697828;3706.9435210964743;3790.5830358660523;3830.578636349999;3952.5256969163884;3974.5826688197903;10745.892541074489;10970.286931349438;11057.06014988719;11087.778244435067;11107;11010.889891101147;11026.173037022256;11029.558817647365;11038.337699738042;11060.115190784718;6614.239362473377;8206.343492520584;8223.301019413297;8248.793780155424;8362.958185209034;5784.652920824764;5889.911651325147;5986.850328741816;6010.699465026819;6096.29892562361;7350.558966462029;10166.18670506343;10184.745381365525;10332.793344133226;10360.533775979948;9922.652707155215;10348.275620706478;10459.21555883327;10583;10602.46987650599;7514.511556748794;7662.0422447194105;7768.728094516665;7780.183080776437;7794.259545343183;8417;8440.577971101298;8497.702580409656;8522.147785221428;8527;7551.924480755122;7600.543967361976;7634.618269086634;7815.218478152139;7826.726064587712;7003.089598352181;7056.259092795182;7428.997085393403;7470.439717021137;7527.247275272429;7042.295770422917;7149.285071492809;7153.964230178815;7163.964180179066;7166.677499512431;4781.42622885256;4838.346823178826;4964.776585053609;4988.6757360771435;5131.615128865275;4767;4917.455578753203;5045.066662667418;5065.949340506548;5168.147255702767 20:25:03 INFO - PROCESS | 1672 | |4;prototype.html;294.2584686589794;297.501684678164;310.7017263427109;314.9023802621189;316.1038455977304;4585.679002469824;4659.487456379796;4869.951300486994;5008.824691135811;5143.665661731985;4446.510883802787;4626.606738427229;4867.544043728956;4934.309196712463;5085.21179217221;3963.701053389042;3984;3988.3419235826054;4007.8597249096288;4016.8594099206534;3712.2204337089242;3719.460678201659;3986.2824691555506;3996.6602838758595;4009.6391324780766;3525.8589656413715;3649.1242101895486;3955.4066889966593;3973.0464688474704;4006.879793606182;3166.477531207348;3955.2880481513316;3985.6612187964056;3986.428753454035;4025.7383270087644;2915.1400336900665;3464.7921124732597;3469.444888817802;3478.4434490481653;3541.256336169382;5000.549950504472;5043.646944713872;5047.671901326402;5055.620828437845;5095.133827249377;3631.673149416565;4001.419794129835;4379.146066517031;4525.434320709911;4557.453105627313;5373.543248823855;5390.595705322116;5395.352557693062;5437.238786569884;5441.809536666237;3502.2295095079044;3758.3798673218885;3787.9393769744515;3805.334066538345;3817.3701339278987;4978.979309241597;5460.453954604547;5550.8057217997175;5587.916181257285;5648.63283886546;3826.7512611680154;3844.2503711776494;3844.615538446189;3848.8845334640005;3852.2295540891932;3721.739478236552;3918.6277303656675;3921.3529767588598;3922.764634121962;3940.862069827542;4232.407462955189;4484.461864576272;4497.977510112429;4513.284951718326;4520.9095818084115;4987.852793857433;5142.6914385137015;5231.764570594332;5396.622236443412;5472.398036216013;1209.6552482542434;1213.4660749270292;1337.0239725000608;1342.6240652617282;1348.6358683155493;768.3929695540461;882.6734108379941;889.6832687622356;909.6770646420425;924.2652091587204;5087.389513258358;5098.362704661918;5105.591552675777;5157.4584668610005;5188.766505507261;4739.691920025188;5413.323334583177;5554.527865131428;5598.664080155204;5620.718964051781;4383.342498625232;4838.95161048385;5037.294778730908;5058.924116138261;5082.941408729471;2304.723433188028;2915.6355455568055;2918.4163167366187;2929.311611771232;2931.4137172565147;4627.30590411441;5770.422957704196;5781.571739869265;5787.681677507778;5812.360640329561;5270.578353731692;5432.75552600134;5701.914471282934;5708.71456427177;5730.3410107838135;4899.730514821647;5759.308882934075;5803.65178089316;5806.506446952057;5829.62107463022;4847.612191024639;5330.721606212074;5537.584681148849;5574.993002519171;5606.523445507178;4690.460597031249;4941.813964648531;4991.550760431579;5521.254630624814;5574.9442505574425;5318.813841515683;5735.272073152318;5775.595708300379;5811.360750317377;5821.7089145543405;3124.9375012500077;3422.9657703423645;3477.9132520487506;3797.6582107610448;3911.354626486712;4550.772461376984;5163.199704045879;5515.4760297771645;5549.723563580318;5568.972155139199;5172.1465958118;5461.863453413696;5468.699221542694;5507.917381239205;5516.448355164612;4814.807407703653;5148.7425628717665;5174.7153906535505;5251.396089449762;5441.183822426668;5036.496350364934;5261.8158364458595;5264.86837829042;5279.472052794844;5284.7886084556185;4485.67672536609;5253.921191182212;5334.466553344634;5371.743867575706;5427.33654783012;4721.858344249678;4745.976270118627;5316.362036555638;5326.7336633167415;5352.635078055227 20:25:03 INFO - PROCESS | 1672 | |5;yui.html;610.3194937644525;736.8836213137098;782.327198609196;793.9563324017176;805.3610901814808;15248.466303679374;15951.521454356387;15973.520794376158;15980.920095399535;16010.519684409457;14164.858351416482;14226.715465690706;14238.216898070603;14247.287635618204;14266.286685665702;682.0791930893304;697.8883378659416;698.7973487688564;827.7433995461396;843.9789005274856;857.4126723194631;858.8797568340406;867.7743786615463;867.7873920889359;869.9130086991313;930.6835675870203;930.6928713524554;931.5435436636034;931.7204838548442;932.8927173375047;922.1516205091265;924.2282693950559;924.3945215883607;924.4776701163821;925.8379783537854;517.7152566088674;534.5910378560404;655.5116438253484;676.3912478769098;687.2097088348389;14823.851761482463;14882.776758348633;14887.255637218095;14900.850991490162;14901.925490372587;12103.930606395006;13424.530141445002;13929.024968252226;13985.58043258704;14074.648133796634;10534.315269507457;12093.395330233454;12655.557055503104;12765.617031488977;12976.091673582758;4139.606737359946;4455.198064348416;4481.012406355376;4509.413776209105;4561.1105834362315;108523;108814.45592772064;109747.45126274397;109784;109832;9115.863262051074;10675.466226688635;10838.783224335626;10956.178286628376;10963.83554246687;18629.81370186308;21881.781182188293;21955.560888782136;21968.780312196992;22091.447713807283;7351.338379545867;7382.3724983377015;7394.445416593777;7488.9625551871895;7625.466217364842;4406.669499787528;4492.191405547033;4500.504944456107;4623.306504024423;4675.485696573374;3400;3549.893503194908;3550.343186510504;3560.287942411528;3562.5368702068563;544.3576579635989;654.8101050695341;662.5163630549725;663.3697986912453;665.2283351312454;532.5021105266588;541.9132938729784;639.8848207322634;685.7531288736051;707.5259576084036;8304.875426868603;8892;9546.830208655889;9708.223342132753;9841.45871977048;532.4701921587967;593.2495393327445;607.8723468071667;615.0569524823698;639.3957709964039;4510.526394728572;4736.621070314367;4760;4765.451973023078;4782.115308667838;97550.51224743831;126265.47469050568;149722.25138874454;154527;156490.43509564758;129509;129513;132400;133464;136681;68769.3123068773;70823.64588177027;87331.56334218288;89045.55477222572;115005;8820.080926412937;8857.158569936104;9711.27165462579;9715.22278217755;9821.705348839547;60806;61618.004866180265;61942.69028654828;64965;65435.01847472387;76919.61540192264;81418.77871832046;81960.18039819764;83709;85560;13049.608511744284;13083.280419577015;13256.602301930958;13266.668333291746;13773.311334433038;14468.85531144675;14807;15071.321790519234;15323;15437;13818.792718109034;13984.160950343012;14308.356123974238;14549.12705237689;14761.188134652268;13770.24263665508;13831.446742130202;13831.550549269854;13864.306784660928;13960.511382101578;13355.399007044512;13438.193708377528;13470.953689265194;13717.862821372059;14202.289885505477;9255.559329484024;11140.777184456427;11253.381064041556;11544.307341559534;11686.298822070703;10941.343519388862;11294.152938529478;11327;11510.769784604094;11528 20:25:03 INFO - PROCESS | 1672 | __end_tp_report 20:25:03 INFO - PROCESS | 1672 | __start_cc_report 20:25:03 INFO - PROCESS | 1672 | _x_x_mozilla_cycle_collect,2128 20:25:03 INFO - PROCESS | 1672 | __end_cc_report 20:25:03 INFO - PROCESS | 1672 | __startTimestamp1474946703491__endTimestamp 20:25:03 INFO - PROCESS | 1672 | 20:25:03 INFO - PROCESS | 1672 | ------- Summary: start ------- 20:25:03 INFO - PROCESS | 1672 | Number of tests: 6 20:25:03 INFO - PROCESS | 1672 | 20:25:03 INFO - PROCESS | 1672 | [#0] dojo.html Cycles:165 Average:5678.28 Median:5854.53 stddev:614.36 (10.5%) stddev-sans-first:587.76 20:25:03 INFO - PROCESS | 1672 | Values: 3321.0 3326.3 3331.6 3366.1 3397.0 5461.8 5618.3 5653.8 5698.6 5698.7 5602.0 5660.7 5686.3 5758.0 5771.1 5076.7 5105.4 5202.2 5215.4 5243.2 5138.1 5239.6 5256.6 5260.4 5280.7 5245.9 5250.7 5267.0 5303.5 5364.5 5073.6 5105.4 5114.8 5116.6 5157.8 5076.1 5083.7 5117.9 5140.8 5208.0 5565.4 5624.6 5660.3 5674.3 5693.1 5966.9 6064.0 6069.8 6142.4 6144.3 5433.0 6119.6 6219.9 6219.9 6264.6 5740.5 5747.4 5756.9 5758.4 5759.3 6109.0 6126.0 6138.0 6181.5 6204.4 5563.7 5594.6 5988.6 6005.5 6023.0 6121.9 6125.5 6152.7 6155.9 6156.3 5736.2 5802.0 5994.0 6087.7 6100.4 6104.0 6122.5 6144.3 6188.6 6189.1 4894.2 4900.3 4906.7 4907.0 4941.5 4410.5 4433.0 4433.6 4444.1 4455.3 5610.4 5612.3 5662.8 5679.6 5713.8 6256.4 6258.9 6267.2 6270.4 6273.7 5711.0 5720.3 5734.7 5735.3 5743.5 5134.3 5237.1 5338.4 5351.8 5353.9 6200.7 6247.2 6263.7 6273.8 6295.1 6233.4 6249.2 6258.4 6263.2 6269.0 5961.0 5978.9 6261.7 6269.7 6298.3 5970.4 6053.2 6054.3 6061.6 6095.7 6234.0 6237.5 6244.5 6250.6 6264.2 5982.1 6023.2 6040.5 6049.7 6089.1 5869.5 5939.8 5945.4 6006.3 6029.4 5850.9 5854.5 5863.1 5867.0 5875.7 5985.3 5999.2 6026.7 6041.5 6129.0 5839.3 5909.4 5910.9 5912.5 5959.5 20:25:03 INFO - PROCESS | 1672 | 20:25:03 INFO - PROCESS | 1672 | [#1] ext.html Cycles:180 Average:58002.62 Median:37219.94 stddev:117142.18 (314.7%) stddev-sans-first:117391.18 20:25:03 INFO - PROCESS | 1672 | Values: 477.9 482.7 484.3 525.4 533.5 25301.2 27654.6 33590.0 33670.8 34579.8 40256.0 40458.6 40720.0 40721.4 40792.0 9591.1 9761.2 9761.5 9769.0 9785.7 8715.4 8940.2 9527.5 11625.4 11978.0 11761.5 11784.8 11801.9 11848.2 11875.3 11656.9 11722.2 11727.9 11733.3 11752.1 8579.4 8812.3 9638.9 11719.5 11733.2 38252.6 38511.8 38629.0 38655.2 38692.6 3393.3 3445.8 3795.5 3924.0 3965.9 24985.1 28920.0 30278.1 30441.7 30657.8 3233.4 3254.0 3307.8 3311.1 3353.5 346943.0 401896.0 404314.9 404994.0 408027.0 54497.5 54956.5 55016.2 55048.0 55053.0 57340.7 57398.7 57565.7 57717.4 57784.8 15558.8 15755.6 15763.8 15790.5 15807.3 11218.9 12404.6 12466.3 12471.3 12519.9 13103.5 13120.5 13179.9 14989.5 15041.8 5932.6 6728.0 6929.8 6946.8 6972.9 874.8 904.7 906.4 911.6 951.2 27651.6 28943.6 29240.6 29714.9 29736.7 1006.3 1032.7 1081.1 1114.2 1142.2 13313.1 14117.4 15094.2 15127.8 15544.0 486341.0 487661.0 488359.0 489781.0 680784.0 45755.5 54108.5 55044.4 55094.2 57837.7 1191.9 1335.7 1376.9 1386.5 1389.9 29192.6 29341.7 29507.0 29520.7 30239.1 45925.8 46932.0 46964.3 47080.3 47081.8 377127.0 380250.0 381436.0 382366.0 384901.0 36302.8 37342.3 37374.6 37478.8 37539.1 43547.6 44075.8 44753.6 44785.0 44878.3 36994.0 37073.4 37341.0 38050.0 38552.0 36855.4 37314.8 37592.4 38035.6 38044.0 36067.8 36154.3 36533.5 36669.8 37125.1 25521.7 31429.5 32564.7 32588.8 32652.5 24378.8 24402.4 24452.9 24868.5 25294.2 20:25:03 INFO - PROCESS | 1672 | 20:25:03 INFO - PROCESS | 1672 | [#2] jquery.html Cycles:180 Average:32288.27 Median:17495.02 stddev:81065.04 (463.4%) stddev-sans-first:81256.98 20:25:03 INFO - PROCESS | 1672 | Values: 352.7 369.6 378.7 385.4 404.5 14733.0 14856.1 16548.5 20129.2 21045.2 19781.0 20077.6 20713.5 20887.6 20986.5 4902.2 6010.4 6272.2 6279.2 6282.5 6071.7 6190.8 6207.3 6209.1 6213.6 5934.0 6045.5 6101.4 6228.8 6234.0 6077.7 6138.8 6143.6 6144.3 6154.4 5189.4 5248.1 5304.9 5334.2 5336.2 25608.2 25652.2 25760.7 25822.5 25938.4 2281.5 2292.2 2386.7 2435.9 2443.2 15152.5 15294.9 15436.8 15692.9 16413.5 1853.3 1865.0 1911.4 1923.6 1937.7 88472.6 111147.4 113279.0 132633.3 137890.6 19634.5 19981.5 20515.1 20582.6 21120.9 33247.0 33438.3 34086.1 34404.8 34637.3 10636.8 10745.5 10975.5 11074.4 11145.3 8897.1 8901.0 8906.9 9070.0 9122.0 8437.5 9215.4 9448.9 9684.0 9837.9 3666.5 3757.6 3757.9 3766.4 3838.6 810.7 853.9 940.8 981.7 1004.1 20342.4 21259.4 21307.8 21384.6 21419.0 830.9 842.3 873.9 910.5 954.8 9369.5 10399.2 11317.5 11320.7 11377.9 465504.0 477591.0 484490.0 489990.0 493278.0 87248.0 102284.0 124032.1 129160.4 130186.0 879.3 900.3 966.6 968.9 971.7 11904.0 18830.8 18918.5 19375.2 19514.7 51405.0 52895.7 53379.7 53601.7 54537.7 64735.4 67759.3 68863.7 69105.7 70060.0 7707.9 8223.4 8256.4 8298.8 8433.6 11821.3 12978.9 13060.2 13433.7 13514.0 9432.4 11178.0 11625.3 11677.3 11789.6 11083.3 11094.4 11320.4 11481.8 11607.2 11572.2 11701.9 11810.7 11849.8 11899.0 7964.8 8238.5 8309.4 8403.2 8411.6 8886.6 10791.2 11272.4 11373.0 11585.3 20:25:03 INFO - PROCESS | 1672 | 20:25:03 INFO - PROCESS | 1672 | [#3] mootools.html Cycles:180 Average:5764.31 Median:4808.84 stddev:3265.83 (67.9%) stddev-sans-first:3258.61 20:25:03 INFO - PROCESS | 1672 | Values: 1411.8 1491.0 1707.6 1882.8 1919.5 8603.4 9140.0 9140.6 9140.9 9158.0 7961.9 8233.8 8239.9 8729.1 8931.7 2387.2 2417.9 2419.3 2424.3 2426.9 2391.6 2399.6 2426.9 2429.0 2430.3 2241.9 2257.7 2259.9 2261.5 2265.8 2262.3 2316.8 2395.6 2408.5 2410.5 2374.1 2391.2 2400.3 2402.7 2403.8 8935.8 9033.9 9064.1 9067.3 9076.5 5256.1 5421.6 5422.7 5426.2 5428.2 3147.3 3656.4 3702.6 3707.3 3721.2 1096.0 1098.8 1099.2 1112.8 1124.4 11786.0 11830.7 11844.8 11850.6 11870.8 4526.5 4608.3 4802.1 4815.6 4821.7 10026.7 10027.5 10041.6 10043.2 10044.4 5380.1 5393.5 5399.7 5416.0 5462.6 4460.3 4595.5 4611.4 4953.9 4997.5 3832.6 3896.3 3944.8 3984.2 4002.7 1077.8 1080.3 1089.3 1093.6 1105.3 837.2 846.3 904.9 906.4 939.5 5539.3 5702.2 5794.5 5872.7 5946.8 938.5 944.4 947.1 949.2 987.4 3706.9 3790.6 3830.6 3952.5 3974.6 10745.9 10970.3 11057.1 11087.8 11107.0 11010.9 11026.2 11029.6 11038.3 11060.1 6614.2 8206.3 8223.3 8248.8 8363.0 5784.7 5889.9 5986.9 6010.7 6096.3 7350.6 10166.2 10184.7 10332.8 10360.5 9922.7 10348.3 10459.2 10583.0 10602.5 7514.5 7662.0 7768.7 7780.2 7794.3 8417.0 8440.6 8497.7 8522.1 8527.0 7551.9 7600.5 7634.6 7815.2 7826.7 7003.1 7056.3 7429.0 7470.4 7527.2 7042.3 7149.3 7154.0 7164.0 7166.7 4781.4 4838.3 4964.8 4988.7 5131.6 4767.0 4917.5 5045.1 5065.9 5168.1 20:25:03 INFO - PROCESS | 1672 | 20:25:03 INFO - PROCESS | 1672 | [#4] prototype.html Cycles:180 Average:4398.56 Median:4983.42 stddev:1338.52 (26.9%) stddev-sans-first:1306.35 20:25:03 INFO - PROCESS | 1672 | Values: 294.3 297.5 310.7 314.9 316.1 4585.7 4659.5 4870.0 5008.8 5143.7 4446.5 4626.6 4867.5 4934.3 5085.2 3963.7 3984.0 3988.3 4007.9 4016.9 3712.2 3719.5 3986.3 3996.7 4009.6 3525.9 3649.1 3955.4 3973.0 4006.9 3166.5 3955.3 3985.7 3986.4 4025.7 2915.1 3464.8 3469.4 3478.4 3541.3 5000.5 5043.6 5047.7 5055.6 5095.1 3631.7 4001.4 4379.1 4525.4 4557.5 5373.5 5390.6 5395.4 5437.2 5441.8 3502.2 3758.4 3787.9 3805.3 3817.4 4979.0 5460.5 5550.8 5587.9 5648.6 3826.8 3844.3 3844.6 3848.9 3852.2 3721.7 3918.6 3921.4 3922.8 3940.9 4232.4 4484.5 4498.0 4513.3 4520.9 4987.9 5142.7 5231.8 5396.6 5472.4 1209.7 1213.5 1337.0 1342.6 1348.6 768.4 882.7 889.7 909.7 924.3 5087.4 5098.4 5105.6 5157.5 5188.8 4739.7 5413.3 5554.5 5598.7 5620.7 4383.3 4839.0 5037.3 5058.9 5082.9 2304.7 2915.6 2918.4 2929.3 2931.4 4627.3 5770.4 5781.6 5787.7 5812.4 5270.6 5432.8 5701.9 5708.7 5730.3 4899.7 5759.3 5803.7 5806.5 5829.6 4847.6 5330.7 5537.6 5575.0 5606.5 4690.5 4941.8 4991.6 5521.3 5574.9 5318.8 5735.3 5775.6 5811.4 5821.7 3124.9 3423.0 3477.9 3797.7 3911.4 4550.8 5163.2 5515.5 5549.7 5569.0 5172.1 5461.9 5468.7 5507.9 5516.4 4814.8 5148.7 5174.7 5251.4 5441.2 5036.5 5261.8 5264.9 5279.5 5284.8 4485.7 5253.9 5334.5 5371.7 5427.3 4721.9 4746.0 5316.4 5326.7 5352.6 20:25:03 INFO - PROCESS | 1672 | 20:25:03 INFO - PROCESS | 1672 | [#5] yui.html Cycles:180 Average:23734.79 Median:4468.11 stddev:37351.60 (836.0%) stddev-sans-first:37416.02 20:25:03 INFO - PROCESS | 1672 | Values: 610.3 736.9 782.3 794.0 805.4 15248.5 15951.5 15973.5 15980.9 16010.5 14164.9 14226.7 14238.2 14247.3 14266.3 682.1 697.9 698.8 827.7 844.0 857.4 858.9 867.8 867.8 869.9 930.7 930.7 931.5 931.7 932.9 922.2 924.2 924.4 924.5 925.8 517.7 534.6 655.5 676.4 687.2 14823.9 14882.8 14887.3 14900.9 14901.9 12103.9 13424.5 13929.0 13985.6 14074.6 10534.3 12093.4 12655.6 12765.6 12976.1 4139.6 4455.2 4481.0 4509.4 4561.1 108523.0 108814.5 109747.5 109784.0 109832.0 9115.9 10675.5 10838.8 10956.2 10963.8 18629.8 21881.8 21955.6 21968.8 22091.4 7351.3 7382.4 7394.4 7489.0 7625.5 4406.7 4492.2 4500.5 4623.3 4675.5 3400.0 3549.9 3550.3 3560.3 3562.5 544.4 654.8 662.5 663.4 665.2 532.5 541.9 639.9 685.8 707.5 8304.9 8892.0 9546.8 9708.2 9841.5 532.5 593.2 607.9 615.1 639.4 4510.5 4736.6 4760.0 4765.5 4782.1 97550.5 126265.5 149722.3 154527.0 156490.4 129509.0 129513.0 132400.0 133464.0 136681.0 68769.3 70823.6 87331.6 89045.6 115005.0 8820.1 8857.2 9711.3 9715.2 9821.7 60806.0 61618.0 61942.7 64965.0 65435.0 76919.6 81418.8 81960.2 83709.0 85560.0 13049.6 13083.3 13256.6 13266.7 13773.3 14468.9 14807.0 15071.3 15323.0 15437.0 13818.8 13984.2 14308.4 14549.1 14761.2 13770.2 13831.4 13831.6 13864.3 13960.5 13355.4 13438.2 13471.0 13717.9 14202.3 9255.6 11140.8 11253.4 11544.3 11686.3 10941.3 11294.2 11327.0 11510.8 11528.0 20:25:03 INFO - PROCESS | 1672 | -------- Summary: end -------- 20:25:03 INFO - PROCESS | 1672 | 20:25:04 INFO - TEST-INFO | 1672: exit 0 20:25:04 INFO - TEST-OK | dromaeo_css | took 1117424ms 20:25:04 INFO - TEST-START | kraken 20:25:04 INFO - operating with platform_type : mac_ 20:25:04 INFO - Initialising browser for kraken test... 20:25:04 INFO - TEST-INFO | started process 1678 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/tmpK2mpuP/profile http://localhost:49288/getInfo.html) 20:25:06 INFO - PROCESS | 1678 | __metrics Screen width/height:1600/1200 20:25:06 INFO - PROCESS | 1678 | colorDepth:24 20:25:06 INFO - PROCESS | 1678 | Browser inner width/height: 1024/689 20:25:06 INFO - PROCESS | 1678 | __metrics 20:25:06 INFO - PROCESS | 1678 | 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" 20:25:06 INFO - PROCESS | 1678 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 20:25:07 INFO - TEST-INFO | 1678: exit 0 20:25:07 INFO - Browser initialized. 20:25:07 INFO - Running cycle 1/1 for kraken test... 20:25:07 INFO - TEST-INFO | started process 1679 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/tmpK2mpuP/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:25:19 INFO - PROCESS | 1679 | RSS: Main: 235663360 20:25:19 INFO - PROCESS | 1679 | 20:25:22 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49288/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49288/tests/kraken/driver.html?testName=audio-beat-detection) 20:25:23 INFO - PROCESS | 1679 | RSS: Main: 294248448 20:25:23 INFO - PROCESS | 1679 | 20:25:25 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49288/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49288/tests/kraken/driver.html?testName=audio-dft) 20:25:26 INFO - PROCESS | 1679 | RSS: Main: 292827136 20:25:26 INFO - PROCESS | 1679 | 20:25:29 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49288/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49288/tests/kraken/driver.html?testName=audio-fft) 20:25:30 INFO - PROCESS | 1679 | RSS: Main: 383979520 20:25:30 INFO - PROCESS | 1679 | 20:25:32 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49288/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49288/tests/kraken/driver.html?testName=audio-oscillator) 20:25:33 INFO - PROCESS | 1679 | RSS: Main: 283541504 20:25:33 INFO - PROCESS | 1679 | 20:25:35 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49288/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49288/tests/kraken/driver.html?testName=imaging-gaussian-blur) 20:25:35 INFO - PROCESS | 1679 | RSS: Main: 288452608 20:25:35 INFO - PROCESS | 1679 | 20:25:38 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49288/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49288/tests/kraken/driver.html?testName=imaging-darkroom) 20:25:39 INFO - PROCESS | 1679 | RSS: Main: 326733824 20:25:39 INFO - PROCESS | 1679 | 20:25:41 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49288/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49288/tests/kraken/driver.html?testName=imaging-desaturate) 20:25:42 INFO - PROCESS | 1679 | RSS: Main: 328441856 20:25:42 INFO - PROCESS | 1679 | 20:25:45 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49288/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49288/tests/kraken/driver.html?testName=json-parse-financial) 20:25:45 INFO - PROCESS | 1679 | RSS: Main: 327516160 20:25:45 INFO - PROCESS | 1679 | 20:25:47 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49288/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49288/tests/kraken/driver.html?testName=json-stringify-tinderbox) 20:25:48 INFO - PROCESS | 1679 | RSS: Main: 304631808 20:25:48 INFO - PROCESS | 1679 | 20:25:50 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49288/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49288/tests/kraken/driver.html?testName=stanford-crypto-aes) 20:25:50 INFO - PROCESS | 1679 | RSS: Main: 303472640 20:25:50 INFO - PROCESS | 1679 | 20:25:52 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49288/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49288/tests/kraken/driver.html?testName=stanford-crypto-ccm) 20:25:53 INFO - PROCESS | 1679 | RSS: Main: 306868224 20:25:53 INFO - PROCESS | 1679 | 20:25:56 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49288/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49288/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 20:25:57 INFO - PROCESS | 1679 | RSS: Main: 317394944 20:25:57 INFO - PROCESS | 1679 | 20:26:00 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49288/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49288/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 20:26:00 INFO - PROCESS | 1679 | RSS: Main: 319344640 20:26:00 INFO - PROCESS | 1679 | 20:26:02 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49288/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49288/tests/kraken/driver.html?testName=ai-astar) 20:26:02 INFO - PROCESS | 1679 | RSS: Main: 362475520 20:26:02 INFO - PROCESS | 1679 | 20:26:02 INFO - PROCESS | 1679 | __start_tp_report 20:26:02 INFO - PROCESS | 1679 | _x_x_mozilla_page_load 20:26:02 INFO - PROCESS | 1679 | _x_x_mozilla_page_load_details 20:26:02 INFO - PROCESS | 1679 | |i|pagename|runs| 20:26:02 INFO - PROCESS | 1679 | |0;ai-astar;113;114;113;113;121;161;160;112;112;112 20:26:02 INFO - PROCESS | 1679 | |1;audio-beat-detection;149;109;111;148;110;109;109;117;168;112 20:26:02 INFO - PROCESS | 1679 | |2;audio-dft;186;186;184;187;183;185;184;182;186;186 20:26:02 INFO - PROCESS | 1679 | |3;audio-fft;79;62;60;88;59;60;58;59;82;58 20:26:02 INFO - PROCESS | 1679 | |4;audio-oscillator;89;71;92;70;69;74;112;81;70;90 20:26:02 INFO - PROCESS | 1679 | |5;imaging-gaussian-blur;88;85;87;84;88;84;88;85;88;84 20:26:02 INFO - PROCESS | 1679 | |6;imaging-darkroom;93;95;93;94;104;145;88;135;94;95 20:26:02 INFO - PROCESS | 1679 | |7;imaging-desaturate;87;85;86;84;82;86;86;87;87;84 20:26:02 INFO - PROCESS | 1679 | |8;json-parse-financial;53;52;55;53;54;53;56;53;53;54 20:26:02 INFO - PROCESS | 1679 | |9;json-stringify-tinderbox;69;77;73;77;75;73;70;73;72;72 20:26:02 INFO - PROCESS | 1679 | |10;stanford-crypto-aes;87;89;86;84;84;85;96;105;96;81 20:26:02 INFO - PROCESS | 1679 | |11;stanford-crypto-ccm;141;139;150;147;152;141;138;139;169;138 20:26:02 INFO - PROCESS | 1679 | |12;stanford-crypto-pbkdf2;168;167;169;167;168;167;169;166;168;166 20:26:02 INFO - PROCESS | 1679 | |13;stanford-crypto-sha256-iterative;67;67;67;67;68;65;70;83;82;76 20:26:02 INFO - PROCESS | 1679 | __end_tp_report 20:26:02 INFO - PROCESS | 1679 | __start_cc_report 20:26:02 INFO - PROCESS | 1679 | _x_x_mozilla_cycle_collect,1911 20:26:02 INFO - PROCESS | 1679 | __end_cc_report 20:26:02 INFO - PROCESS | 1679 | __startTimestamp1474946762727__endTimestamp 20:26:02 INFO - PROCESS | 1679 | 20:26:02 INFO - PROCESS | 1679 | ------- Summary: start ------- 20:26:02 INFO - PROCESS | 1679 | Number of tests: 14 20:26:02 INFO - PROCESS | 1679 | 20:26:02 INFO - PROCESS | 1679 | [#0] ai-astar Cycles:10 Average:123.10 Median:113.50 stddev:19.89 (17.5%) stddev-sans-first:20.76 20:26:02 INFO - PROCESS | 1679 | Values: 113.0 114.0 113.0 113.0 121.0 161.0 160.0 112.0 112.0 112.0 20:26:02 INFO - PROCESS | 1679 | 20:26:02 INFO - PROCESS | 1679 | [#1] audio-beat-detection Cycles:10 Average:124.20 Median:114.50 stddev:22.03 (19.2%) stddev-sans-first:21.47 20:26:02 INFO - PROCESS | 1679 | Values: 149.0 109.0 111.0 148.0 110.0 109.0 109.0 117.0 168.0 112.0 20:26:02 INFO - PROCESS | 1679 | 20:26:02 INFO - PROCESS | 1679 | [#2] audio-dft Cycles:10 Average:184.90 Median:186.00 stddev:1.60 (0.9%) stddev-sans-first:1.64 20:26:02 INFO - PROCESS | 1679 | Values: 186.0 186.0 184.0 187.0 183.0 185.0 184.0 182.0 186.0 186.0 20:26:02 INFO - PROCESS | 1679 | 20:26:02 INFO - PROCESS | 1679 | [#3] audio-fft Cycles:10 Average:66.50 Median:61.00 stddev:11.65 (19.1%) stddev-sans-first:11.44 20:26:02 INFO - PROCESS | 1679 | Values: 79.0 62.0 60.0 88.0 59.0 60.0 58.0 59.0 82.0 58.0 20:26:02 INFO - PROCESS | 1679 | 20:26:02 INFO - PROCESS | 1679 | [#4] audio-oscillator Cycles:10 Average:81.80 Median:77.50 stddev:13.97 (18.0%) stddev-sans-first:14.57 20:26:02 INFO - PROCESS | 1679 | Values: 89.0 71.0 92.0 70.0 69.0 74.0 112.0 81.0 70.0 90.0 20:26:02 INFO - PROCESS | 1679 | 20:26:02 INFO - PROCESS | 1679 | [#5] imaging-gaussian-blur Cycles:10 Average:86.10 Median:87.50 stddev:1.85 (2.1%) stddev-sans-first:1.83 20:26:02 INFO - PROCESS | 1679 | Values: 88.0 85.0 87.0 84.0 88.0 84.0 88.0 85.0 88.0 84.0 20:26:02 INFO - PROCESS | 1679 | 20:26:02 INFO - PROCESS | 1679 | [#6] imaging-darkroom Cycles:10 Average:103.60 Median:93.50 stddev:19.72 (21.1%) stddev-sans-first:20.54 20:26:02 INFO - PROCESS | 1679 | Values: 93.0 95.0 93.0 94.0 104.0 145.0 88.0 135.0 94.0 95.0 20:26:02 INFO - PROCESS | 1679 | 20:26:02 INFO - PROCESS | 1679 | [#7] imaging-desaturate Cycles:10 Average:85.40 Median:86.00 stddev:1.65 (1.9%) stddev-sans-first:1.64 20:26:02 INFO - PROCESS | 1679 | Values: 87.0 85.0 86.0 84.0 82.0 86.0 86.0 87.0 87.0 84.0 20:26:02 INFO - PROCESS | 1679 | 20:26:02 INFO - PROCESS | 1679 | [#8] json-parse-financial Cycles:10 Average:53.60 Median:53.50 stddev:1.17 (2.2%) stddev-sans-first:1.22 20:26:02 INFO - PROCESS | 1679 | Values: 53.0 52.0 55.0 53.0 54.0 53.0 56.0 53.0 53.0 54.0 20:26:02 INFO - PROCESS | 1679 | 20:26:02 INFO - PROCESS | 1679 | [#9] json-stringify-tinderbox Cycles:10 Average:73.10 Median:73.00 stddev:2.64 (3.6%) stddev-sans-first:2.35 20:26:02 INFO - PROCESS | 1679 | Values: 69.0 77.0 73.0 77.0 75.0 73.0 70.0 73.0 72.0 72.0 20:26:02 INFO - PROCESS | 1679 | 20:26:02 INFO - PROCESS | 1679 | [#10] stanford-crypto-aes Cycles:10 Average:89.30 Median:86.50 stddev:7.42 (8.6%) stddev-sans-first:7.83 20:26:02 INFO - PROCESS | 1679 | Values: 87.0 89.0 86.0 84.0 84.0 85.0 96.0 105.0 96.0 81.0 20:26:02 INFO - PROCESS | 1679 | 20:26:02 INFO - PROCESS | 1679 | [#11] stanford-crypto-ccm Cycles:10 Average:145.40 Median:144.00 stddev:9.74 (6.8%) stddev-sans-first:10.20 20:26:02 INFO - PROCESS | 1679 | Values: 141.0 139.0 150.0 147.0 152.0 141.0 138.0 139.0 169.0 138.0 20:26:02 INFO - PROCESS | 1679 | 20:26:02 INFO - PROCESS | 1679 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:167.50 Median:168.00 stddev:1.08 (0.6%) stddev-sans-first:1.13 20:26:02 INFO - PROCESS | 1679 | Values: 168.0 167.0 169.0 167.0 168.0 167.0 169.0 166.0 168.0 166.0 20:26:02 INFO - PROCESS | 1679 | 20:26:02 INFO - PROCESS | 1679 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.20 Median:69.00 stddev:6.66 (9.7%) stddev-sans-first:6.89 20:26:02 INFO - PROCESS | 1679 | Values: 67.0 67.0 67.0 67.0 68.0 65.0 70.0 83.0 82.0 76.0 20:26:02 INFO - PROCESS | 1679 | -------- Summary: end -------- 20:26:02 INFO - PROCESS | 1679 | 20:26:03 INFO - TEST-INFO | 1679: exit 0 20:26:03 INFO - TEST-OK | kraken | took 59451ms 20:26:03 INFO - SUITE-END | took 1176s 20:26:03 INFO - Completed test suite (00:19:37) 20:26:03 INFO - javascript benchmark 20:26:03 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3320.966790332097, 3326.251593391487, 3331.633520312767, 3366.0911553880437, 3397.0488263286275, 5461.781528738846, 5618.269624948761, 5653.830385088449, 5698.629589076707, 5698.715064246787, 5602.019646561846, 5660.66036037837, 5686.289213848269, 5757.963566558028, 5771.134329850524, 5076.746162691869, 5105.438401775802, 5202.1936599826895, 5215.426303106655, 5243.161094224924, 5138.126518491866, 5239.633225674185, 5256.579473642099, 5260.421353651095, 5280.683159010472, 5245.921311180336, 5250.7374631268285, 5266.973665131669, 5303.496167864066, 5364.490373414519, 5073.568746656539, 5105.387353517602, 5114.795408183668, 5116.565091967187, 5157.819476318348, 5076.086304465195, 5083.74581270935, 5117.948820511784, 5140.768665410065, 5208.0, 5565.387807341189, 5624.6343987641085, 5660.320761508646, 5674.2623458950075, 5693.060644993571, 5966.880662386728, 6063.969680151615, 6069.787557435468, 6142.385761423867, 6144.324124346318, 5432.972835135799, 6119.632822030692, 6219.906701399483, 6219.937800622027, 6264.592801467936, 5740.540756739534, 5747.425257474303, 5756.942430575725, 5758.3665796762325, 5759.337676167211, 6109.009944784373, 6125.9680843641045, 6138.048602466535, 6181.536384771161, 6204.441600255908, 5563.749631266603, 5594.608377413542, 5988.610740301953, 6005.489533389624, 6023.0, 6121.908171377433, 6125.479334256549, 6152.723127459275, 6155.907661385083, 6156.29202641693, 5736.225609542658, 5802.0, 5994.0, 6087.66517841523, 6100.359462256399, 6103.992841181155, 6122.459149553274, 6144.293406258337, 6188.566800324024, 6189.133521307021, 4894.241392584155, 4900.313956046085, 4906.656534042583, 4907.0, 4941.48114447985, 4410.5368936261875, 4432.955670443319, 4433.6009759121835, 4444.11117776446, 4455.2648812946145, 5610.438956104357, 5612.326520817528, 5662.801801936913, 5679.630823996427, 5713.771449141987, 6256.405641464054, 6258.874822503524, 6267.1539342189135, 6270.404311590391, 6273.654948977759, 5711.0, 5720.342160651495, 5734.6845923473775, 5735.254416925773, 5743.4543718346695, 5134.306868572769, 5237.109691352479, 5338.386085600128, 5351.812686555952, 5353.892922141613, 6200.689965501707, 6247.156633854463, 6263.718132683949, 6273.780417685542, 6295.087212354275, 6233.407826256498, 6249.1563638908165, 6258.436740693177, 6263.248410190807, 6268.9969604863, 5961.0, 5978.880422391615, 6261.686915654108, 6269.686515674107, 6298.338674439118, 5970.402959703995, 6053.182820319201, 6054.273487181566, 6061.575689701678, 6095.725692343766, 6233.968830156002, 6237.5321850860455, 6244.469220116341, 6250.593711408744, 6264.154339164337, 5982.132590774227, 6023.247094113236, 6040.5097678877, 6049.697515124314, 6089.086637004485, 5869.501092407193, 5939.821805345847, 5945.3757355477055, 6006.279246490449, 6029.366916473882, 5850.94149058504, 5854.531637469077, 5863.120531920075, 5867.031939729897, 5875.706214689163, 5985.25184351956, 5999.220101386966, 6026.698665066817, 6041.546883983807, 6129.0, 5839.328477225004, 5909.438603332676, 5910.852228694317, 5912.497437717842, 5959.463648271676], "value": 5639.571391988412, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [477.92114301140316, 482.7272590986091, 484.3388774323048, 525.408914970658, 533.5491509674324, 25301.240962771124, 27654.61726913654, 33589.992300231, 33670.83164584174, 34579.827100864524, 40255.99360016001, 40458.59541404585, 40720.0, 40721.38917916234, 40792.0, 9591.136797688207, 9761.170300524464, 9761.463119528424, 9769.0, 9785.706428807112, 8715.433496822718, 8940.24007959321, 9527.523623818815, 11625.360605166712, 11978.0, 11761.470733816956, 11784.7643047139, 11801.940990295037, 11848.17062805604, 11875.287482751019, 11656.883431165706, 11722.17944743864, 11727.88272117285, 11733.296002239893, 11752.118591105702, 8579.356548258906, 8812.339074569369, 9638.855417168748, 11719.472623731866, 11733.178677492579, 38252.61747382519, 38511.80744096261, 38629.0, 38655.22689546221, 38692.61307386918, 3393.321335732863, 3445.793252404864, 3795.4686343911876, 3923.960150560104, 3965.940510892339, 24985.125520606874, 28920.019870839544, 30278.09165725032, 30441.695583044107, 30657.846710766527, 3233.4341490239112, 3253.96746032539, 3307.7849939753837, 3311.122552523583, 3353.5137405076125, 346943.0, 401896.0, 404314.93527596816, 404994.0, 408027.0, 54497.547610356836, 54956.450435495935, 55016.17475737867, 55048.0, 55053.0, 57340.71329643325, 57398.7130064347, 57565.71217143888, 57717.4228257712, 57784.8443031137, 15558.844411555965, 15755.606109847346, 15763.763543546856, 15790.526284211492, 15807.288672009787, 11218.943905280421, 12404.62786116418, 12466.314352710506, 12471.251724896536, 12519.937400313122, 13103.541376051982, 13120.540781072617, 13179.934100329438, 14989.475368362055, 15041.774373384407, 5932.614380065282, 6728.0, 6929.757458488929, 6946.756863509753, 6972.9302706972285, 874.842528344904, 904.6562306323686, 906.3972458315278, 911.6216770040359, 951.2342564235856, 27651.58522622162, 28943.56584651232, 29240.588381949638, 29714.851425742734, 29736.702632973826, 1006.3157053203745, 1032.7418145463635, 1081.1080858291941, 1114.1588100983706, 1142.2118738070706, 13313.134646247963, 14117.435302587986, 15094.169820659969, 15127.773083403757, 15544.0, 486341.0, 487661.0, 488359.0, 489781.0, 680784.0, 45755.54244457513, 54108.45891541113, 55044.44955550473, 55094.173587396224, 57837.710811446515, 1191.9404029798475, 1335.7395307914862, 1376.8554301798167, 1386.5424409944897, 1389.9444022238997, 29192.562111568768, 29341.706582933897, 29507.0, 29520.704792951794, 30239.09282721522, 45925.77037114793, 46932.0, 46964.295535567675, 47080.293795592406, 47081.76459117683, 377127.0, 380250.0, 381436.0, 382366.0, 384901.0, 36302.8184859074, 37342.2531549362, 37374.626253737115, 37478.81260593679, 37539.06152346213, 43547.56452435562, 44075.77962110169, 44753.55246447624, 44785.0, 44878.326825097, 36994.0, 37073.44389834101, 37341.0, 38050.0, 38552.0, 36855.44716829196, 37314.8134259327, 37592.43611345777, 38035.619643803206, 38044.0, 36067.81966090153, 36154.27691446209, 36533.45199822058, 36669.816650917644, 37125.07187320231, 25521.744782551938, 31429.52855707212, 32564.743525647245, 32588.83705581457, 32652.51021234636, 24378.75621243765, 24402.389940251636, 24452.877735611208, 24868.50262994694, 25294.241172764847], "value": 19146.454418623438, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [352.74249797647735, 369.5971391183611, 378.7140708764883, 385.3891581842779, 404.4903421688673, 14732.96869219155, 14856.108633481985, 16548.503544893658, 20129.19483220673, 21045.158193672272, 19781.0, 20077.598448031065, 20713.482162945933, 20887.582248355062, 20986.475338116517, 4902.240152776308, 6010.36891126432, 6272.153259310003, 6279.215098112736, 6282.52881033922, 6071.696415179245, 6190.8452288692915, 6207.348228435994, 6209.068639704058, 6213.596116252429, 5934.0, 6045.486133678621, 6101.420365065312, 6228.750849965996, 6234.0, 6077.696115194245, 6138.815835524942, 6143.569950103472, 6144.293406258293, 6154.384561543855, 5189.403218629868, 5248.081585722522, 5304.867378315535, 5334.199870019489, 5336.199570064483, 25608.23175304744, 25652.230433087036, 25760.742392576023, 25822.483550329078, 25938.351541211432, 2281.498070424504, 2292.1862738727846, 2386.7016622922133, 2435.866027368494, 2443.1571107967725, 15152.545423637308, 15294.929354945158, 15436.826918764373, 15692.92153539225, 16413.507594772174, 1853.33280019193, 1864.9813501864944, 1911.3883557261681, 1923.5671973805922, 1937.6609093408597, 88472.55763721204, 111147.44426277898, 113279.0, 132633.3368333152, 137890.6210937888, 19634.50913727168, 19981.500462488555, 20515.076821543065, 20582.588348232952, 21120.89439552823, 33247.00258992234, 33438.3312333752, 34086.147846303546, 34404.82797586046, 34637.30725385478, 10636.829948705636, 10745.462726863625, 10975.451227438596, 11074.446277686084, 11145.275557088764, 8897.110288971051, 8901.020887702347, 8906.86639700405, 9069.954650226706, 9122.0, 8437.535935523605, 9215.400998935047, 9448.90551094494, 9683.951580242194, 9837.9016209837, 3666.5233519642275, 3757.6242375762754, 3757.891422030508, 3766.4162054881535, 3838.616138386195, 810.6797814863214, 853.8633818588996, 940.7554035950702, 981.7496538382667, 1004.1113614451264, 20342.389728308175, 21259.36221913314, 21307.78692213058, 21384.572308553743, 21419.0, 830.9198042544667, 842.3135144856922, 873.9207079257112, 910.4582773249906, 954.8112599813277, 9369.531523423802, 10399.220058495643, 11317.547298107984, 11320.71698207535, 11377.88622113785, 465504.0, 477591.0, 484490.0, 489990.0, 493278.0, 87248.0, 102284.0, 124032.0607256122, 129160.35419822841, 130186.04720929194, 879.3097418526554, 900.2887718702152, 966.6085235479642, 968.9370190937567, 971.6647756523988, 11904.0, 18830.811691882907, 18918.527036823638, 19375.224991000203, 19514.707279390535, 51405.0, 52895.67760805857, 53379.73310133425, 53601.65995850135, 54537.72731136319, 64735.35264647293, 67759.3224067753, 68863.65568172127, 69105.65447172732, 70060.0, 7707.92292077072, 8223.383246256675, 8256.380771442045, 8298.792530186794, 8433.620487077973, 11821.29072255633, 12978.93510532479, 13060.151090179108, 13433.66415839612, 13514.0, 9432.434053956784, 11178.0, 11625.302481851117, 11677.299362038304, 11789.646310610353, 11083.334999900031, 11094.44527773592, 11320.37737924422, 11481.770364592829, 11607.187496875138, 11572.18994670365, 11701.941490292495, 11810.704732381759, 11849.763004739685, 11899.04807615406, 7964.84070318602, 8238.546879921661, 8309.37679674039, 8403.201695838885, 8411.62147703367, 8886.60010299551, 10791.244612877337, 11272.436378181223, 11373.0, 11585.304881707125], "value": 10410.325579633434, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1411.8235220597426, 1491.0308299605256, 1707.5816424975883, 1882.783479899812, 1919.5105248161717, 8603.44077634954, 9140.040295768948, 9140.588673509692, 9140.857392825905, 9158.0, 7961.92038079619, 8233.752987410388, 8239.91760082399, 8729.083446238148, 8931.73204803857, 2387.176424133671, 2417.867017314056, 2419.250032489925, 2424.309071914505, 2426.9271921842374, 2391.5575618510543, 2399.6160614301716, 2426.9271921842374, 2428.963565546518, 2430.307362401716, 2241.9215327463544, 2257.683924250606, 2259.8757068361315, 2261.513774538474, 2265.830062745301, 2262.2760716570706, 2316.779905908953, 2395.556821987929, 2408.542376948374, 2410.4817464245184, 2374.062245413052, 2391.198948352304, 2400.327908185711, 2402.711674599042, 2403.771641694036, 8935.776605584848, 9033.909660903439, 9064.138906803842, 9067.319951003636, 9076.546172691405, 5256.106461901486, 5421.620486565942, 5422.728863556807, 5426.158945363475, 5428.185772134172, 3147.339058797655, 3656.3601369760186, 3702.5927148013698, 3707.3326801175776, 3721.1999420124803, 1095.9726006849812, 1098.8022156011914, 1099.2030777686193, 1112.7996960547098, 1124.4096849154178, 11786.0, 11830.704232394173, 11844.822327665092, 11850.585229516926, 11870.821937670942, 4526.456825181, 4608.262677971508, 4802.063597598435, 4815.614750819926, 4821.662483626183, 10026.69919902404, 10027.498625068718, 10041.598336066621, 10043.246756493292, 10044.447555384524, 5380.085385484477, 5393.541548968382, 5399.730013499309, 5415.972920135374, 5462.590305727086, 4460.30865215892, 4595.517470665599, 4611.354410382549, 4953.900921981613, 4997.475265097112, 3832.5784163741964, 3896.279188350164, 3944.8422063117155, 3984.163325701635, 4002.7398219115667, 1077.7521170130758, 1080.270817198388, 1089.2647462962627, 1093.6117678224116, 1105.2870898270571, 837.1837458477935, 846.2552953400967, 904.9095090490898, 906.3655441191192, 939.5020639061308, 5539.307586551681, 5702.201691763156, 5794.50746686528, 5872.655883146316, 5946.762129514857, 938.5401153434905, 944.3719926249105, 947.0766003147014, 949.1837020162654, 987.4322264697828, 3706.9435210964743, 3790.5830358660523, 3830.578636349999, 3952.5256969163884, 3974.5826688197903, 10745.892541074489, 10970.286931349438, 11057.06014988719, 11087.778244435067, 11107.0, 11010.889891101147, 11026.173037022256, 11029.558817647365, 11038.337699738042, 11060.115190784718, 6614.239362473377, 8206.343492520584, 8223.301019413297, 8248.793780155424, 8362.958185209034, 5784.652920824764, 5889.911651325147, 5986.850328741816, 6010.699465026819, 6096.29892562361, 7350.558966462029, 10166.18670506343, 10184.745381365525, 10332.793344133226, 10360.533775979948, 9922.652707155215, 10348.275620706478, 10459.21555883327, 10583.0, 10602.46987650599, 7514.511556748794, 7662.0422447194105, 7768.728094516665, 7780.183080776437, 7794.259545343183, 8417.0, 8440.577971101298, 8497.702580409656, 8522.147785221428, 8527.0, 7551.924480755122, 7600.543967361976, 7634.618269086634, 7815.218478152139, 7826.726064587712, 7003.089598352181, 7056.259092795182, 7428.997085393403, 7470.439717021137, 7527.247275272429, 7042.295770422917, 7149.285071492809, 7153.964230178815, 7163.964180179066, 7166.677499512431, 4781.42622885256, 4838.346823178826, 4964.776585053609, 4988.6757360771435, 5131.615128865275, 4767.0, 4917.455578753203, 5045.066662667418, 5065.949340506548, 5168.147255702767], "value": 4611.187303974135, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [294.2584686589794, 297.501684678164, 310.7017263427109, 314.9023802621189, 316.1038455977304, 4585.679002469824, 4659.487456379796, 4869.951300486994, 5008.824691135811, 5143.665661731985, 4446.510883802787, 4626.606738427229, 4867.544043728956, 4934.309196712463, 5085.21179217221, 3963.701053389042, 3984.0, 3988.3419235826054, 4007.8597249096288, 4016.8594099206534, 3712.2204337089242, 3719.460678201659, 3986.2824691555506, 3996.6602838758595, 4009.6391324780766, 3525.8589656413715, 3649.1242101895486, 3955.4066889966593, 3973.0464688474704, 4006.879793606182, 3166.477531207348, 3955.2880481513316, 3985.6612187964056, 3986.428753454035, 4025.7383270087644, 2915.1400336900665, 3464.7921124732597, 3469.444888817802, 3478.4434490481653, 3541.256336169382, 5000.549950504472, 5043.646944713872, 5047.671901326402, 5055.620828437845, 5095.133827249377, 3631.673149416565, 4001.419794129835, 4379.146066517031, 4525.434320709911, 4557.453105627313, 5373.543248823855, 5390.595705322116, 5395.352557693062, 5437.238786569884, 5441.809536666237, 3502.2295095079044, 3758.3798673218885, 3787.9393769744515, 3805.334066538345, 3817.3701339278987, 4978.979309241597, 5460.453954604547, 5550.8057217997175, 5587.916181257285, 5648.63283886546, 3826.7512611680154, 3844.2503711776494, 3844.615538446189, 3848.8845334640005, 3852.2295540891932, 3721.739478236552, 3918.6277303656675, 3921.3529767588598, 3922.764634121962, 3940.862069827542, 4232.407462955189, 4484.461864576272, 4497.977510112429, 4513.284951718326, 4520.9095818084115, 4987.852793857433, 5142.6914385137015, 5231.764570594332, 5396.622236443412, 5472.398036216013, 1209.6552482542434, 1213.4660749270292, 1337.0239725000608, 1342.6240652617282, 1348.6358683155493, 768.3929695540461, 882.6734108379941, 889.6832687622356, 909.6770646420425, 924.2652091587204, 5087.389513258358, 5098.362704661918, 5105.591552675777, 5157.4584668610005, 5188.766505507261, 4739.691920025188, 5413.323334583177, 5554.527865131428, 5598.664080155204, 5620.718964051781, 4383.342498625232, 4838.95161048385, 5037.294778730908, 5058.924116138261, 5082.941408729471, 2304.723433188028, 2915.6355455568055, 2918.4163167366187, 2929.311611771232, 2931.4137172565147, 4627.30590411441, 5770.422957704196, 5781.571739869265, 5787.681677507778, 5812.360640329561, 5270.578353731692, 5432.75552600134, 5701.914471282934, 5708.71456427177, 5730.3410107838135, 4899.730514821647, 5759.308882934075, 5803.65178089316, 5806.506446952057, 5829.62107463022, 4847.612191024639, 5330.721606212074, 5537.584681148849, 5574.993002519171, 5606.523445507178, 4690.460597031249, 4941.813964648531, 4991.550760431579, 5521.254630624814, 5574.9442505574425, 5318.813841515683, 5735.272073152318, 5775.595708300379, 5811.360750317377, 5821.7089145543405, 3124.9375012500077, 3422.9657703423645, 3477.9132520487506, 3797.6582107610448, 3911.354626486712, 4550.772461376984, 5163.199704045879, 5515.4760297771645, 5549.723563580318, 5568.972155139199, 5172.1465958118, 5461.863453413696, 5468.699221542694, 5507.917381239205, 5516.448355164612, 4814.807407703653, 5148.7425628717665, 5174.7153906535505, 5251.396089449762, 5441.183822426668, 5036.496350364934, 5261.8158364458595, 5264.86837829042, 5279.472052794844, 5284.7886084556185, 4485.67672536609, 5253.921191182212, 5334.466553344634, 5371.743867575706, 5427.33654783012, 4721.858344249678, 4745.976270118627, 5316.362036555638, 5326.7336633167415, 5352.635078055227], "value": 3974.7897165592385, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [610.3194937644525, 736.8836213137098, 782.327198609196, 793.9563324017176, 805.3610901814808, 15248.466303679374, 15951.521454356387, 15973.520794376158, 15980.920095399535, 16010.519684409457, 14164.858351416482, 14226.715465690706, 14238.216898070603, 14247.287635618204, 14266.286685665702, 682.0791930893304, 697.8883378659416, 698.7973487688564, 827.7433995461396, 843.9789005274856, 857.4126723194631, 858.8797568340406, 867.7743786615463, 867.7873920889359, 869.9130086991313, 930.6835675870203, 930.6928713524554, 931.5435436636034, 931.7204838548442, 932.8927173375047, 922.1516205091265, 924.2282693950559, 924.3945215883607, 924.4776701163821, 925.8379783537854, 517.7152566088674, 534.5910378560404, 655.5116438253484, 676.3912478769098, 687.2097088348389, 14823.851761482463, 14882.776758348633, 14887.255637218095, 14900.850991490162, 14901.925490372587, 12103.930606395006, 13424.530141445002, 13929.024968252226, 13985.58043258704, 14074.648133796634, 10534.315269507457, 12093.395330233454, 12655.557055503104, 12765.617031488977, 12976.091673582758, 4139.606737359946, 4455.198064348416, 4481.012406355376, 4509.413776209105, 4561.1105834362315, 108523.0, 108814.45592772064, 109747.45126274397, 109784.0, 109832.0, 9115.863262051074, 10675.466226688635, 10838.783224335626, 10956.178286628376, 10963.83554246687, 18629.81370186308, 21881.781182188293, 21955.560888782136, 21968.780312196992, 22091.447713807283, 7351.338379545867, 7382.3724983377015, 7394.445416593777, 7488.9625551871895, 7625.466217364842, 4406.669499787528, 4492.191405547033, 4500.504944456107, 4623.306504024423, 4675.485696573374, 3400.0, 3549.893503194908, 3550.343186510504, 3560.287942411528, 3562.5368702068563, 544.3576579635989, 654.8101050695341, 662.5163630549725, 663.3697986912453, 665.2283351312454, 532.5021105266588, 541.9132938729784, 639.8848207322634, 685.7531288736051, 707.5259576084036, 8304.875426868603, 8892.0, 9546.830208655889, 9708.223342132753, 9841.45871977048, 532.4701921587967, 593.2495393327445, 607.8723468071667, 615.0569524823698, 639.3957709964039, 4510.526394728572, 4736.621070314367, 4760.0, 4765.451973023078, 4782.115308667838, 97550.51224743831, 126265.47469050568, 149722.25138874454, 154527.0, 156490.43509564758, 129509.0, 129513.0, 132400.0, 133464.0, 136681.0, 68769.3123068773, 70823.64588177027, 87331.56334218288, 89045.55477222572, 115005.0, 8820.080926412937, 8857.158569936104, 9711.27165462579, 9715.22278217755, 9821.705348839547, 60806.0, 61618.004866180265, 61942.69028654828, 64965.0, 65435.01847472387, 76919.61540192264, 81418.77871832046, 81960.18039819764, 83709.0, 85560.0, 13049.608511744284, 13083.280419577015, 13256.602301930958, 13266.668333291746, 13773.311334433038, 14468.85531144675, 14807.0, 15071.321790519234, 15323.0, 15437.0, 13818.792718109034, 13984.160950343012, 14308.356123974238, 14549.12705237689, 14761.188134652268, 13770.24263665508, 13831.446742130202, 13831.550549269854, 13864.306784660928, 13960.511382101578, 13355.399007044512, 13438.193708377528, 13470.953689265194, 13717.862821372059, 14202.289885505477, 9255.559329484024, 11140.777184456427, 11253.381064041556, 11544.307341559534, 11686.298822070703, 10941.343519388862, 11294.152938529478, 11327.0, 11510.769784604094, 11528.0], "value": 7734.756061541617, "unit": "score"}], "name": "dromaeo_css", "value": 7363.25604897572, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 114.0, 113.0, 113.0, 121.0, 161.0, 160.0, 112.0, 112.0, 112.0], "value": 123.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 109.0, 111.0, 148.0, 110.0, 109.0, 109.0, 117.0, 168.0, 112.0], "value": 124.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [186.0, 186.0, 184.0, 187.0, 183.0, 185.0, 184.0, 182.0, 186.0, 186.0], "value": 184.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 62.0, 60.0, 88.0, 59.0, 60.0, 58.0, 59.0, 82.0, 58.0], "value": 66.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 71.0, 92.0, 70.0, 69.0, 74.0, 112.0, 81.0, 70.0, 90.0], "value": 81.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 85.0, 87.0, 84.0, 88.0, 84.0, 88.0, 85.0, 88.0, 84.0], "value": 86.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 95.0, 93.0, 94.0, 104.0, 145.0, 88.0, 135.0, 94.0, 95.0], "value": 103.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 85.0, 86.0, 84.0, 82.0, 86.0, 86.0, 87.0, 87.0, 84.0], "value": 85.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 52.0, 55.0, 53.0, 54.0, 53.0, 56.0, 53.0, 53.0, 54.0], "value": 53.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 77.0, 73.0, 77.0, 75.0, 73.0, 70.0, 73.0, 72.0, 72.0], "value": 73.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 89.0, 86.0, 84.0, 84.0, 85.0, 96.0, 105.0, 96.0, 81.0], "value": 89.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 139.0, 150.0, 147.0, 152.0, 141.0, 138.0, 139.0, 169.0, 138.0], "value": 145.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [168.0, 167.0, 169.0, 167.0, 168.0, 167.0, 169.0, 166.0, 168.0, 166.0], "value": 167.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 67.0, 67.0, 67.0, 68.0, 65.0, 70.0, 83.0, 82.0, 76.0], "value": 71.2, "unit": "score"}], "name": "kraken", "value": 1455.7000000000003, "alertThreshold": 2.0}]} 20:26:03 INFO - Return code: 0 20:26:04 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 20:26:04 INFO - # TBPL SUCCESS # 20:26:04 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 20:26:04 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 20:26:04 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 20:26:04 INFO - 2016-09-26 20:26:04.029 screenresolution[1683:13259] starting screenresolution argv=screenresolution get 20:26:04 INFO - 2016-09-26 20:26:04.032 screenresolution[1683:13259] Display 0: 1600x1200x32@60 20:26:04 INFO - 2016-09-26 20:26:04.038 screenresolution[1684:13262] starting screenresolution argv=screenresolution list 20:26:04 INFO - Available Modes on Display 0 20:26:04 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 20:26:04 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 20:26:04 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 20:26:04 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 20:26:04 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 20:26:04 INFO - Intel Iris: 20:26:04 INFO - Chipset Model: Intel Iris 20:26:04 INFO - Type: GPU 20:26:04 INFO - Bus: Built-In 20:26:04 INFO - VRAM (Dynamic, Max): 1536 MB 20:26:04 INFO - Vendor: Intel (0x8086) 20:26:04 INFO - Device ID: 0x0a2e 20:26:04 INFO - Revision ID: 0x0009 20:26:04 INFO - Displays: 20:26:04 INFO - Display: 20:26:04 INFO - Resolution: 1600 x 1200 @ 60 Hz 20:26:04 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 20:26:04 INFO - Display Serial Number: 1600x1200 60 20:26:04 INFO - Main Display: Yes 20:26:04 INFO - Mirror: Off 20:26:04 INFO - Online: Yes 20:26:04 INFO - Rotation: Supported 20:26:04 INFO - Return code: 0 20:26:04 INFO - Running post-action listener: _resource_record_post_action 20:26:04 INFO - [mozharness: 2016-09-27 03:26:04.273995Z] Finished run-tests step (success) 20:26:04 INFO - Running post-run listener: _resource_record_post_run 20:26:04 INFO - Total resource usage - Wall time: 1212s; CPU: 54.0%; Read bytes: 32705536; Write bytes: 709204480; Read time: 310; Write time: 2021 20:26:04 INFO - TinderboxPrint: CPU usage
53.8% 20:26:04 INFO - TinderboxPrint: I/O read bytes / time
32,705,536 / 310 20:26:04 INFO - TinderboxPrint: I/O write bytes / time
709,204,480 / 2,021 20:26:04 INFO - TinderboxPrint: CPU idle
2,241.6 (46.2%) 20:26:04 INFO - TinderboxPrint: CPU system
969.9 (20.0%) 20:26:04 INFO - TinderboxPrint: CPU user
1,638.1 (33.8%) 20:26:04 INFO - TinderboxPrint: Swap in / out
435,273,728 / 0 20:26:04 INFO - install - Wall time: 35s; CPU: 55.0%; Read bytes: 397349376; Write bytes: 391931904; Read time: 29472; Write time: 712 20:26:04 INFO - run-tests - Wall time: 1178s; CPU: 54.0%; Read bytes: 30800896; Write bytes: 297406976; Read time: 291; Write time: 1267 20:26:04 INFO - Running post-run listener: _upload_blobber_files 20:26:04 INFO - Blob upload gear active. 20:26:04 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 20:26:04 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 20:26:04 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'] 20:26:04 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 20:26:05 INFO - (blobuploader) - INFO - Open directory for files ... 20:26:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 20:26:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:26:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:26:08 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 20:26:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:26:08 INFO - (blobuploader) - INFO - Done attempting. 20:26:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 20:26:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:26:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:26:09 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 20:26:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:26:09 INFO - (blobuploader) - INFO - Done attempting. 20:26:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 20:26:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:26:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:26:12 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 20:26:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:26:12 INFO - (blobuploader) - INFO - Done attempting. 20:26:12 INFO - (blobuploader) - INFO - Iteration through files over. 20:26:12 INFO - Return code: 0 20:26:12 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 20:26:12 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 20:26:12 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/1937725a5f1444fad88ff4aad818cf5c0add53485410b73eea16496cc93a386be34ff00912c25b571d309c4cc822b9e429e5d5708366cd55bde1f05a8176d5d5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/ae8ad8800cddc729c3fec88058f6ebe24f996c3449202837705a27375bb8dd1df322874287209e077d7eaa1d95ec749989ac9ed42b1b31fc1ee6b610fa1eaf62", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/c1815402d3f6a3555e0e0232e354eeb4fb4283a7227e90b486e4ff6c059f18095fb1bdd8d7ac9a14db97cb23e08f272c40135b64901575197121b26f761d7372"} 20:26:12 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 20:26:12 INFO - Writing to file /builds/slave/test/properties/blobber_files 20:26:12 INFO - Contents: 20:26:12 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/1937725a5f1444fad88ff4aad818cf5c0add53485410b73eea16496cc93a386be34ff00912c25b571d309c4cc822b9e429e5d5708366cd55bde1f05a8176d5d5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/ae8ad8800cddc729c3fec88058f6ebe24f996c3449202837705a27375bb8dd1df322874287209e077d7eaa1d95ec749989ac9ed42b1b31fc1ee6b610fa1eaf62", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/c1815402d3f6a3555e0e0232e354eeb4fb4283a7227e90b486e4ff6c059f18095fb1bdd8d7ac9a14db97cb23e08f272c40135b64901575197121b26f761d7372"} 20:26:12 INFO - Running post-run listener: copy_logs_to_upload_dir 20:26:12 INFO - Copying logs to upload dir... 20:26:12 INFO - mkdir: /builds/slave/test/build/upload/logs 20:26:12 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1281.303427 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 21 secs) (at 2016-09-26 20:26:12.410093) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-26 20:26:12.413468) ========= 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.ElAHZnOdet/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.jsZHGJwj8v/Listeners TMPDIR=/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/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/1937725a5f1444fad88ff4aad818cf5c0add53485410b73eea16496cc93a386be34ff00912c25b571d309c4cc822b9e429e5d5708366cd55bde1f05a8176d5d5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/ae8ad8800cddc729c3fec88058f6ebe24f996c3449202837705a27375bb8dd1df322874287209e077d7eaa1d95ec749989ac9ed42b1b31fc1ee6b610fa1eaf62", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/c1815402d3f6a3555e0e0232e354eeb4fb4283a7227e90b486e4ff6c059f18095fb1bdd8d7ac9a14db97cb23e08f272c40135b64901575197121b26f761d7372"} build_url:https://queue.taskcluster.net/v1/task/PIrAxiWaSum_14VKJH53CQ/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011094 build_url: 'https://queue.taskcluster.net/v1/task/PIrAxiWaSum_14VKJH53CQ/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/1937725a5f1444fad88ff4aad818cf5c0add53485410b73eea16496cc93a386be34ff00912c25b571d309c4cc822b9e429e5d5708366cd55bde1f05a8176d5d5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/ae8ad8800cddc729c3fec88058f6ebe24f996c3449202837705a27375bb8dd1df322874287209e077d7eaa1d95ec749989ac9ed42b1b31fc1ee6b610fa1eaf62", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/c1815402d3f6a3555e0e0232e354eeb4fb4283a7227e90b486e4ff6c059f18095fb1bdd8d7ac9a14db97cb23e08f272c40135b64901575197121b26f761d7372"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-26 20:26:12.447500) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-26 20:26:12.447878) ========= 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.ElAHZnOdet/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.jsZHGJwj8v/Listeners TMPDIR=/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/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.005171 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-26 20:26:12.497181) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-26 20:26:12.497561) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-26 20:26:12.497931) ========= ========= Total master_lag: 0.18 =========