builder: fx-team_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0082 starttime: 1474496129.8 results: success (0) buildid: 20160921125600 builduid: 9ab35d71788e47c68e04a1698c18fbda revision: e893929f7606287f3359cda18bfb29d492846643 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-09-21 15:15:29.802857) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-09-21 15:15:29.803321) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-21 15:15:29.803603) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-21 15:15:29.827555) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-21 15:15:29.827938) ========= 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.e0yMzc6dfL/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.WqaBuSGBYq/Listeners TMPDIR=/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-09-21 15:15:29-- 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% 56.5M=0s 2016-09-21 15:15:29 (56.5 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.135556 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-21 15:15:29.985888) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-21 15:15:29.986228) ========= 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.e0yMzc6dfL/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.WqaBuSGBYq/Listeners TMPDIR=/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/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.020514 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-21 15:15:30.034883) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-09-21 15:15:30.035254) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev e893929f7606287f3359cda18bfb29d492846643 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev e893929f7606287f3359cda18bfb29d492846643 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.e0yMzc6dfL/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.WqaBuSGBYq/Listeners TMPDIR=/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-09-21 15:15:30,011 truncating revision to first 12 chars 2016-09-21 15:15:30,011 Setting DEBUG logging. 2016-09-21 15:15:30,012 attempt 1/10 2016-09-21 15:15:30,012 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/e893929f7606?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-09-21 15:15:31,593 unpacking tar archive at: fx-team-e893929f7606/testing/mozharness/ program finished with exit code 0 elapsedTime=1.848269 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-09-21 15:15:31.907315) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-21 15:15:31.907830) ========= script_repo_revision: e893929f7606287f3359cda18bfb29d492846643 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-21 15:15:31.908463) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-21 15:15:31.908835) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-21 15:15:31.929030) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 9 secs) (at 2016-09-21 15:15:31.929468) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 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', 'Fx-Team', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.e0yMzc6dfL/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.WqaBuSGBYq/Listeners TMPDIR=/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/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 15:15:32 INFO - MultiFileLogger online at 20160921 15:15:32 in /builds/slave/test 15:15:32 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 15:15:32 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:15:32 INFO - {'append_to_log': False, 15:15:32 INFO - 'base_work_dir': '/builds/slave/test', 15:15:32 INFO - 'blob_upload_branch': 'Fx-Team', 15:15:32 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:15:32 INFO - 'branch': 'Fx-Team', 15:15:32 INFO - 'buildbot_json_path': 'buildprops.json', 15:15:32 INFO - 'config_files': ('talos/mac_config.py',), 15:15:32 INFO - 'default_actions': ('clobber', 15:15:32 INFO - 'read-buildbot-config', 15:15:32 INFO - 'download-and-extract', 15:15:32 INFO - 'populate-webroot', 15:15:32 INFO - 'create-virtualenv', 15:15:32 INFO - 'install', 15:15:32 INFO - 'run-tests'), 15:15:32 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:15:32 INFO - 'download_minidump_stackwalk': True, 15:15:32 INFO - 'download_symbols': 'ondemand', 15:15:32 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:15:32 INFO - 'tooltool.py': '/tools/tooltool.py', 15:15:32 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:15:32 INFO - '/tools/misc-python/virtualenv.py')}, 15:15:32 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:15:32 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:15:32 INFO - 'installer_path': 'installer.exe', 15:15:32 INFO - 'log_level': 'info', 15:15:32 INFO - 'log_name': 'talos', 15:15:32 INFO - 'log_to_console': True, 15:15:32 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 15:15:32 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 15:15:32 INFO - 'opt_config_files': (), 15:15:32 INFO - 'pip_index': False, 15:15:32 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 15:15:32 INFO - 'cmd': ('bash', 15:15:32 INFO - '-c', 15:15:32 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 15:15:32 INFO - 'enabled': True, 15:15:32 INFO - 'halt_on_failure': False, 15:15:32 INFO - 'name': 'check_screen_resolution'},), 15:15:32 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 15:15:32 INFO - 'cmd': ('bash', 15:15:32 INFO - '-c', 15:15:32 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 15:15:32 INFO - 'enabled': True, 15:15:32 INFO - 'halt_on_failure': False, 15:15:32 INFO - 'name': 'check_screen_resolution'},), 15:15:32 INFO - 'run_cmd_checks_enabled': True, 15:15:32 INFO - 'sps_profile': False, 15:15:32 INFO - 'sps_profile_interval': 0, 15:15:32 INFO - 'suite': 'dromaeojs', 15:15:32 INFO - 'system_bits': '32', 15:15:32 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:15:32 INFO - 'title': 't-yosemite-r7-0082', 15:15:32 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:15:32 INFO - 'use_talos_json': True, 15:15:32 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:15:32 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:15:32 INFO - 'work_dir': 'build'} 15:15:32 INFO - [mozharness: 2016-09-21 22:15:32.024730Z] Running clobber step. 15:15:32 INFO - Running pre-action listener: _resource_record_pre_action 15:15:32 INFO - Running main action method: clobber 15:15:32 INFO - rmtree: /builds/slave/test/build 15:15:32 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:15:32 INFO - Running post-action listener: _resource_record_post_action 15:15:32 INFO - [mozharness: 2016-09-21 22:15:32.953144Z] Finished clobber step (success) 15:15:32 INFO - [mozharness: 2016-09-21 22:15:32.953252Z] Running read-buildbot-config step. 15:15:32 INFO - Running pre-action listener: _resource_record_pre_action 15:15:32 INFO - Running main action method: read_buildbot_config 15:15:32 INFO - Using buildbot properties: 15:15:32 INFO - { 15:15:32 INFO - "project": "", 15:15:32 INFO - "product": "firefox", 15:15:32 INFO - "script_repo_revision": "production", 15:15:32 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs", 15:15:32 INFO - "repository": "", 15:15:32 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs", 15:15:32 INFO - "buildid": "20160921125600", 15:15:32 INFO - "pgo_build": "False", 15:15:32 INFO - "basedir": "/builds/slave/test", 15:15:32 INFO - "buildnumber": 836, 15:15:32 INFO - "slavename": "t-yosemite-r7-0082", 15:15:32 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 15:15:32 INFO - "platform": "yosemite_r7", 15:15:32 INFO - "scheduler": "tests-fx-team-macosx64-talos", 15:15:32 INFO - "branch": "fx-team", 15:15:32 INFO - "repo_path": "integration/fx-team", 15:15:32 INFO - "revision": "e893929f7606287f3359cda18bfb29d492846643", 15:15:32 INFO - "stage_platform": "macosx64", 15:15:32 INFO - "builduid": "9ab35d71788e47c68e04a1698c18fbda", 15:15:32 INFO - "slavebuilddir": "test" 15:15:32 INFO - } 15:15:32 INFO - Found installer url https://queue.taskcluster.net/v1/task/JKVMBgQHSSiutC1wtCFaIQ/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg. 15:15:32 INFO - Running post-action listener: _resource_record_post_action 15:15:32 INFO - [mozharness: 2016-09-21 22:15:32.956318Z] Finished read-buildbot-config step (success) 15:15:32 INFO - [mozharness: 2016-09-21 22:15:32.956429Z] Running download-and-extract step. 15:15:32 INFO - Running pre-action listener: _resource_record_pre_action 15:15:32 INFO - Running main action method: download_and_extract 15:15:32 INFO - mkdir: /builds/slave/test/build/tests 15:15: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')]} 15:15:32 INFO - trying https://queue.taskcluster.net/v1/task/JKVMBgQHSSiutC1wtCFaIQ/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json 15:15:32 INFO - Downloading https://queue.taskcluster.net/v1/task/JKVMBgQHSSiutC1wtCFaIQ/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 15:15:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/JKVMBgQHSSiutC1wtCFaIQ/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 15:15:34 INFO - Downloaded 1199 bytes. 15:15:34 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json 15:15:34 INFO - Using the following test package requirements: 15:15:34 INFO - {u'common': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 15:15:34 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 15:15:34 INFO - u'firefox-52.0a1.en-US.mac.cppunittest.tests.zip'], 15:15:34 INFO - u'gtest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 15:15:34 INFO - u'firefox-52.0a1.en-US.mac.gtest.tests.zip'], 15:15:34 INFO - u'jittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 15:15:34 INFO - u'jsshell-mac.zip'], 15:15:34 INFO - u'mochitest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 15:15:34 INFO - u'firefox-52.0a1.en-US.mac.mochitest.tests.zip'], 15:15:34 INFO - u'mozbase': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 15:15:34 INFO - u'reftest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 15:15:34 INFO - u'firefox-52.0a1.en-US.mac.reftest.tests.zip'], 15:15:34 INFO - u'talos': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 15:15:34 INFO - u'firefox-52.0a1.en-US.mac.talos.tests.zip'], 15:15:34 INFO - u'web-platform': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 15:15:34 INFO - u'firefox-52.0a1.en-US.mac.web-platform.tests.zip'], 15:15:34 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 15:15:34 INFO - u'firefox-52.0a1.en-US.mac.xpcshell.tests.zip']} 15:15:34 INFO - Downloading packages: [u'firefox-52.0a1.en-US.mac.common.tests.zip'] for test suite category: common 15:15:34 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/JKVMBgQHSSiutC1wtCFaIQ/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 15:15:34 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/JKVMBgQHSSiutC1wtCFaIQ/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 15:15:34 INFO - Fetch https://queue.taskcluster.net/v1/task/JKVMBgQHSSiutC1wtCFaIQ/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 15:15:34 INFO - Expected file size: 16432491 15:15:41 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 15:15:41 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/JKVMBgQHSSiutC1wtCFaIQ/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 15:15:41 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/JKVMBgQHSSiutC1wtCFaIQ/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 15:15:41 INFO - Fetch https://queue.taskcluster.net/v1/task/JKVMBgQHSSiutC1wtCFaIQ/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 15:15:42 INFO - Expected file size: 16432491 15:15:49 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/JKVMBgQHSSiutC1wtCFaIQ/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip 15:15:49 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/JKVMBgQHSSiutC1wtCFaIQ/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip'}, attempt #1 15:15:49 INFO - Fetch https://queue.taskcluster.net/v1/task/JKVMBgQHSSiutC1wtCFaIQ/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip into memory 15:15:50 INFO - Expected file size: 14414059 15:15: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')]} 15:15:51 INFO - trying https://queue.taskcluster.net/v1/task/JKVMBgQHSSiutC1wtCFaIQ/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 15:15:51 INFO - Downloading https://queue.taskcluster.net/v1/task/JKVMBgQHSSiutC1wtCFaIQ/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg 15:15:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/JKVMBgQHSSiutC1wtCFaIQ/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 15:15:53 INFO - Downloaded 111291065 bytes. 15:15:53 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/JKVMBgQHSSiutC1wtCFaIQ/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 15:15:53 INFO - mkdir: /builds/slave/test/properties 15:15:53 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:15:53 INFO - Writing to file /builds/slave/test/properties/build_url 15:15:53 INFO - Contents: 15:15:53 INFO - build_url:https://queue.taskcluster.net/v1/task/JKVMBgQHSSiutC1wtCFaIQ/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 15:15:54 INFO - Running post-action listener: _resource_record_post_action 15:15:54 INFO - Running post-action listener: set_extra_try_arguments 15:15:54 INFO - [mozharness: 2016-09-21 22:15:54.576253Z] Finished download-and-extract step (success) 15:15:54 INFO - [mozharness: 2016-09-21 22:15:54.576410Z] Running populate-webroot step. 15:15:54 INFO - Running pre-action listener: _resource_record_pre_action 15:15:54 INFO - Running main action method: populate_webroot 15:15:54 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 15:15:54 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 15:15:54 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 15:15:54 INFO - '--tppagecycles', 15:15:54 INFO - '7'], 15:15:54 INFO - 'tests': ['tsvgm']}}, 15:15:54 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 15:15:54 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:15:54 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 15:15:54 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 15:15:54 INFO - 'tests': ['dromaeo_css', 'kraken']}, 15:15:54 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 15:15:54 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:15:54 INFO - 'talos_options': ['--disable-e10s'], 15:15:54 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:15:54 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:15:54 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:15:54 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:15:54 INFO - 'talos_options': ['--disable-e10s'], 15:15:54 INFO - 'tests': ['damp', 'tps']}, 15:15:54 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:15:54 INFO - 'tests': ['damp', 'tps']}, 15:15:54 INFO - 'g3': {'talos_options': ['--disable-e10s'], 15:15:54 INFO - 'tests': ['dromaeo_dom']}, 15:15:54 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:15:54 INFO - 'g4': {'talos_options': ['--disable-e10s'], 15:15:54 INFO - 'tests': ['basic_compositor_video']}, 15:15:54 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 15:15:54 INFO - 'other': {'talos_options': ['--disable-e10s'], 15:15:54 INFO - 'tests': ['a11yr', 15:15:54 INFO - 'ts_paint', 15:15:54 INFO - 'tpaint', 15:15:54 INFO - 'sessionrestore', 15:15:54 INFO - 'sessionrestore_no_auto_restore', 15:15:54 INFO - 'tabpaint']}, 15:15:54 INFO - 'other-e10s': {'tests': ['a11yr', 15:15:54 INFO - 'ts_paint', 15:15:54 INFO - 'tpaint', 15:15:54 INFO - 'sessionrestore', 15:15:54 INFO - 'sessionrestore_no_auto_restore', 15:15:54 INFO - 'tabpaint']}, 15:15:54 INFO - 'other-e10s_l64': {'tests': ['a11yr', 15:15:54 INFO - 'ts_paint', 15:15:54 INFO - 'tpaint', 15:15:54 INFO - 'sessionrestore', 15:15:54 INFO - 'sessionrestore_no_auto_restore', 15:15:54 INFO - 'tabpaint']}, 15:15:54 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 15:15:54 INFO - 'ts_paint', 15:15:54 INFO - 'tpaint', 15:15:54 INFO - 'sessionrestore', 15:15:54 INFO - 'sessionrestore_no_auto_restore', 15:15:54 INFO - 'tabpaint']}, 15:15:54 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 15:15:54 INFO - 'tests': ['a11yr', 15:15:54 INFO - 'ts_paint', 15:15:54 INFO - 'tpaint', 15:15:54 INFO - 'sessionrestore', 15:15:54 INFO - 'sessionrestore_no_auto_restore', 15:15:54 INFO - 'tabpaint']}, 15:15:54 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 15:15:54 INFO - 'tests': ['a11yr', 15:15:54 INFO - 'ts_paint', 15:15:54 INFO - 'tpaint', 15:15:54 INFO - 'sessionrestore', 15:15:54 INFO - 'sessionrestore_no_auto_restore', 15:15:54 INFO - 'tabpaint']}, 15:15:54 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 15:15:54 INFO - 'tests': ['tsvgx', 15:15:54 INFO - 'tsvgr_opacity', 15:15:54 INFO - 'tart', 15:15:54 INFO - 'tscrollx', 15:15:54 INFO - 'cart']}, 15:15:54 INFO - 'svgr-e10s': {'tests': ['tsvgx', 15:15:54 INFO - 'tsvgr_opacity', 15:15:54 INFO - 'tart', 15:15:54 INFO - 'tscrollx', 15:15:54 INFO - 'cart']}, 15:15:54 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:15:54 INFO - 'talos_options': ['--disable-e10s'], 15:15:54 INFO - 'tests': ['tp5o']}, 15:15:54 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:15:54 INFO - 'tests': ['tp5o']}, 15:15:54 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:15:54 INFO - 'talos_options': ['--disable-e10s', 15:15:54 INFO - '--xperf_path', 15:15:54 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:15:54 INFO - 'tests': ['tp5n']}, 15:15:54 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:15:54 INFO - 'talos_options': ['--xperf_path', 15:15:54 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:15:54 INFO - 'tests': ['tp5n']}}, 15:15:54 INFO - 'talos.zip': {'path': '', 15:15:54 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 15:15:54 INFO - Running post-action listener: _resource_record_post_action 15:15:54 INFO - [mozharness: 2016-09-21 22:15:54.595978Z] Finished populate-webroot step (success) 15:15:54 INFO - [mozharness: 2016-09-21 22:15:54.596091Z] Running create-virtualenv step. 15:15:54 INFO - Running pre-action listener: _resource_record_pre_action 15:15:54 INFO - Running main action method: create_virtualenv 15:15:54 INFO - Creating virtualenv /builds/slave/test/build/venv 15:15:54 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 15:15:54 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 15:15:54 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:15:54 INFO - Using real prefix '/tools/python27' 15:15:54 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:15:55 INFO - Installing distribute.............................................................................................................................................................................................done. 15:15:58 INFO - Installing pip.................done. 15:15:58 INFO - Return code: 0 15:15:58 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:15:58 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')]} 15:15:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:15:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:15:58 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')]} 15:15:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:15:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:15:58 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 0x1046db490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104651570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9cabc7fa80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1044efd30>, '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 0x104315db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1044e7b20>, '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.e0yMzc6dfL/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.WqaBuSGBYq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/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 15:15:58 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 15:15:58 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 15:15:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.e0yMzc6dfL/Render', 15:15:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:15:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:15:58 INFO - 'HOME': '/Users/cltbld', 15:15:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:15:58 INFO - 'LOGNAME': 'cltbld', 15:15:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:15:58 INFO - 'MOZ_NO_REMOTE': '1', 15:15:58 INFO - 'NO_EM_RESTART': '1', 15:15:58 INFO - 'PAGER': '/bin/cat', 15:15:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:15:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:15:58 INFO - 'PWD': '/builds/slave/test', 15:15:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:15:58 INFO - 'SHELL': '/bin/bash', 15:15:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WqaBuSGBYq/Listeners', 15:15:58 INFO - 'TMPDIR': '/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/', 15:15:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:15:58 INFO - 'USER': 'cltbld', 15:15:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:15:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:15:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:15:58 INFO - 'XPC_FLAGS': '0x0', 15:15:58 INFO - 'XPC_SERVICE_NAME': '0', 15:15:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:15:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:15:58 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 15:15:58 INFO - Cleaning up... 15:15:58 INFO - Return code: 0 15:15:58 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 15:15:58 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')]} 15:15:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:15:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:15:58 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')]} 15:15:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:15:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:15:58 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 0x1046db490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104651570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9cabc7fa80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1044efd30>, '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 0x104315db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1044e7b20>, '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.e0yMzc6dfL/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.WqaBuSGBYq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/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 15:15:58 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 15:15:58 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 15:15:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.e0yMzc6dfL/Render', 15:15:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:15:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:15:58 INFO - 'HOME': '/Users/cltbld', 15:15:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:15:58 INFO - 'LOGNAME': 'cltbld', 15:15:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:15:58 INFO - 'MOZ_NO_REMOTE': '1', 15:15:58 INFO - 'NO_EM_RESTART': '1', 15:15:58 INFO - 'PAGER': '/bin/cat', 15:15:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:15:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:15:58 INFO - 'PWD': '/builds/slave/test', 15:15:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:15:58 INFO - 'SHELL': '/bin/bash', 15:15:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WqaBuSGBYq/Listeners', 15:15:58 INFO - 'TMPDIR': '/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/', 15:15:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:15:58 INFO - 'USER': 'cltbld', 15:15:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:15:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:15:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:15:58 INFO - 'XPC_FLAGS': '0x0', 15:15:58 INFO - 'XPC_SERVICE_NAME': '0', 15:15:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:15:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:15:58 INFO - Downloading/unpacking psutil>=3.1.1 15:15:58 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 15:15:58 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 15:15:58 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 15:15:58 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 15:15:58 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 15:15:58 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 15:16:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:16:02 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:16:02 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:16:02 INFO - Installing collected packages: psutil 15:16:02 INFO - Running setup.py install for psutil 15:16:02 INFO - building 'psutil._psutil_osx' extension 15:16:02 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 15:16:02 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 15:16:02 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 15:16:02 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 15:16:02 INFO - building 'psutil._psutil_posix' extension 15:16:02 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 15:16:02 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 15:16:02 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 15:16:02 INFO - ^ 15:16:02 INFO - 1 warning generated. 15:16:02 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 15:16:02 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:16:02 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:16:03 INFO - Successfully installed psutil 15:16:03 INFO - Cleaning up... 15:16:03 INFO - Return code: 0 15:16:03 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 15:16:03 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')]} 15:16:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:16:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:16:03 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')]} 15:16:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:16:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:16:03 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 0x1046db490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104651570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9cabc7fa80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1044efd30>, '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 0x104315db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1044e7b20>, '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.e0yMzc6dfL/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.WqaBuSGBYq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/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 15:16:03 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 15:16:03 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 15:16:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.e0yMzc6dfL/Render', 15:16:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:16:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:16:03 INFO - 'HOME': '/Users/cltbld', 15:16:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:16:03 INFO - 'LOGNAME': 'cltbld', 15:16:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:16:03 INFO - 'MOZ_NO_REMOTE': '1', 15:16:03 INFO - 'NO_EM_RESTART': '1', 15:16:03 INFO - 'PAGER': '/bin/cat', 15:16:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:16:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:16:03 INFO - 'PWD': '/builds/slave/test', 15:16:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:16:03 INFO - 'SHELL': '/bin/bash', 15:16:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WqaBuSGBYq/Listeners', 15:16:03 INFO - 'TMPDIR': '/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/', 15:16:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:16:03 INFO - 'USER': 'cltbld', 15:16:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:16:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:16:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:16:03 INFO - 'XPC_FLAGS': '0x0', 15:16:03 INFO - 'XPC_SERVICE_NAME': '0', 15:16:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:16:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:16:03 INFO - Downloading/unpacking mozsystemmonitor==0.3 15:16:03 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 15:16:03 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 15:16:03 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 15:16:03 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 15:16:03 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 15:16:03 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 15:16:05 INFO - Downloading mozsystemmonitor-0.3.tar.gz 15:16:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:16:05 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 15:16:05 INFO - Installing collected packages: mozsystemmonitor 15:16:05 INFO - Running setup.py install for mozsystemmonitor 15:16:06 INFO - Successfully installed mozsystemmonitor 15:16:06 INFO - Cleaning up... 15:16:06 INFO - Return code: 0 15:16:06 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 15:16:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:16:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:16:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:16:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:16:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:16:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:16:06 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 0x1046db490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104651570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9cabc7fa80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1044efd30>, '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 0x104315db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1044e7b20>, '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.e0yMzc6dfL/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.WqaBuSGBYq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/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 15:16:06 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 15:16:06 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 15:16:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.e0yMzc6dfL/Render', 15:16:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:16:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:16:06 INFO - 'HOME': '/Users/cltbld', 15:16:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:16:06 INFO - 'LOGNAME': 'cltbld', 15:16:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:16:06 INFO - 'MOZ_NO_REMOTE': '1', 15:16:06 INFO - 'NO_EM_RESTART': '1', 15:16:06 INFO - 'PAGER': '/bin/cat', 15:16:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:16:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:16:06 INFO - 'PWD': '/builds/slave/test', 15:16:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:16:06 INFO - 'SHELL': '/bin/bash', 15:16:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WqaBuSGBYq/Listeners', 15:16:06 INFO - 'TMPDIR': '/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/', 15:16:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:16:06 INFO - 'USER': 'cltbld', 15:16:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:16:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:16:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:16:06 INFO - 'XPC_FLAGS': '0x0', 15:16:06 INFO - 'XPC_SERVICE_NAME': '0', 15:16:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:16:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:16:06 INFO - Downloading/unpacking jsonschema==2.5.1 15:16:06 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 15:16:06 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 15:16:06 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 15:16:06 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 15:16:06 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 15:16:06 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 15:16:08 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:16:08 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 15:16:08 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 15:16:08 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 15:16:08 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 15:16:08 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 15:16:08 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 15:16:08 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 15:16:09 INFO - Downloading functools32-3.2.3-2.tar.gz 15:16:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 15:16:09 INFO - warning: no files found matching '*.txt' 15:16:09 INFO - no previously-included directories found matching 'build' 15:16:09 INFO - no previously-included directories found matching 'dist' 15:16:09 INFO - no previously-included directories found matching '.git*' 15:16:09 INFO - Installing collected packages: jsonschema, functools32 15:16:09 INFO - Running setup.py install for functools32 15:16:09 INFO - warning: no files found matching '*.txt' 15:16:09 INFO - no previously-included directories found matching 'build' 15:16:09 INFO - no previously-included directories found matching 'dist' 15:16:09 INFO - no previously-included directories found matching '.git*' 15:16:09 INFO - Successfully installed jsonschema functools32 15:16:09 INFO - Cleaning up... 15:16:09 INFO - Return code: 0 15:16:09 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 15:16:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:16:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:16:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:16:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:16:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:16:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:16:09 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 0x1046db490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104651570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9cabc7fa80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1044efd30>, '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 0x104315db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1044e7b20>, '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.e0yMzc6dfL/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.WqaBuSGBYq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/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 15:16:09 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 15:16:09 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 15:16:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.e0yMzc6dfL/Render', 15:16:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:16:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:16:09 INFO - 'HOME': '/Users/cltbld', 15:16:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:16:09 INFO - 'LOGNAME': 'cltbld', 15:16:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:16:09 INFO - 'MOZ_NO_REMOTE': '1', 15:16:09 INFO - 'NO_EM_RESTART': '1', 15:16:09 INFO - 'PAGER': '/bin/cat', 15:16:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:16:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:16:09 INFO - 'PWD': '/builds/slave/test', 15:16:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:16:09 INFO - 'SHELL': '/bin/bash', 15:16:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WqaBuSGBYq/Listeners', 15:16:09 INFO - 'TMPDIR': '/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/', 15:16:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:16:09 INFO - 'USER': 'cltbld', 15:16:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:16:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:16:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:16:09 INFO - 'XPC_FLAGS': '0x0', 15:16:09 INFO - 'XPC_SERVICE_NAME': '0', 15:16:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:16:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:16:09 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 15:16:09 INFO - Cleaning up... 15:16:09 INFO - Return code: 0 15:16:09 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:16:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:16:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:16:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:16:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:16:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:16:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:16:09 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 0x1046db490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104651570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9cabc7fa80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1044efd30>, '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 0x104315db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1044e7b20>, '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.e0yMzc6dfL/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.WqaBuSGBYq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/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 15:16:09 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 15:16:09 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 15:16:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.e0yMzc6dfL/Render', 15:16:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:16:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:16:09 INFO - 'HOME': '/Users/cltbld', 15:16:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:16:09 INFO - 'LOGNAME': 'cltbld', 15:16:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:16:09 INFO - 'MOZ_NO_REMOTE': '1', 15:16:09 INFO - 'NO_EM_RESTART': '1', 15:16:09 INFO - 'PAGER': '/bin/cat', 15:16:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:16:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:16:09 INFO - 'PWD': '/builds/slave/test', 15:16:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:16:09 INFO - 'SHELL': '/bin/bash', 15:16:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WqaBuSGBYq/Listeners', 15:16:09 INFO - 'TMPDIR': '/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/', 15:16:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:16:09 INFO - 'USER': 'cltbld', 15:16:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:16:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:16:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:16:09 INFO - 'XPC_FLAGS': '0x0', 15:16:09 INFO - 'XPC_SERVICE_NAME': '0', 15:16:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:16:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:16:10 INFO - Downloading/unpacking blobuploader==1.2.4 15:16:10 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 15:16:10 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 15:16:10 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 15:16:10 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 15:16:10 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 15:16:10 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 15:16:12 INFO - Downloading blobuploader-1.2.4.tar.gz 15:16:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:16:12 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:16:12 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 15:16:12 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 15:16:12 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 15:16:12 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 15:16:12 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 15:16:12 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 15:16:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:16:13 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:16:13 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 15:16:13 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 15:16:13 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 15:16:13 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 15:16:13 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 15:16:13 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 15:16:13 INFO - Downloading docopt-0.6.1.tar.gz 15:16:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:16:14 INFO - Installing collected packages: blobuploader, requests, docopt 15:16:14 INFO - Running setup.py install for blobuploader 15:16:14 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:16:14 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:16:14 INFO - Running setup.py install for requests 15:16:14 INFO - Running setup.py install for docopt 15:16:14 INFO - Successfully installed blobuploader requests docopt 15:16:14 INFO - Cleaning up... 15:16:14 INFO - Return code: 0 15:16:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:16:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:16:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:16:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:16:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:16:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:16:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:16:14 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 0x1046db490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104651570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9cabc7fa80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1044efd30>, '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 0x104315db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1044e7b20>, '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.e0yMzc6dfL/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.WqaBuSGBYq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/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 15:16:14 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 15:16:14 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 15:16:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.e0yMzc6dfL/Render', 15:16:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:16:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:16:14 INFO - 'HOME': '/Users/cltbld', 15:16:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:16:14 INFO - 'LOGNAME': 'cltbld', 15:16:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:16:14 INFO - 'MOZ_NO_REMOTE': '1', 15:16:14 INFO - 'NO_EM_RESTART': '1', 15:16:14 INFO - 'PAGER': '/bin/cat', 15:16:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:16:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:16:14 INFO - 'PWD': '/builds/slave/test', 15:16:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:16:14 INFO - 'SHELL': '/bin/bash', 15:16:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WqaBuSGBYq/Listeners', 15:16:14 INFO - 'TMPDIR': '/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/', 15:16:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:16:14 INFO - 'USER': 'cltbld', 15:16:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:16:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:16:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:16:14 INFO - 'XPC_FLAGS': '0x0', 15:16:14 INFO - 'XPC_SERVICE_NAME': '0', 15:16:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:16:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:16:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:16:15 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-zl65vm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:16:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:16:15 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-jU2yv1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:16:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:16:15 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-w15W8H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:16:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:16:15 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-aDQvlg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:16:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:16:15 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-FrnMEO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:16:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:16:15 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-rDJMna-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:16:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:16:15 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-mBJVHW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:16:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:16:15 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-kuLyrm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:16:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:16:15 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-oBfhrj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:16:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:16:16 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-nFQPLV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:16:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:16:16 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-fn48af-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:16:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:16:16 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-CrwyHQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:16:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:16:16 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-1ogvx3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:16:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:16:16 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-TBFJS6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:16:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:16:16 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-mxA2JL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:16:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:16:16 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-Eh2KOl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:16:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:16:16 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-wuZqZt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:16:16 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:16:16 INFO - Running setup.py install for manifestparser 15:16:17 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:16:17 INFO - Running setup.py install for mozcrash 15:16:17 INFO - Running setup.py install for mozdebug 15:16:17 INFO - Running setup.py install for mozdevice 15:16:17 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 15:16:17 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:16:17 INFO - Running setup.py install for mozfile 15:16:17 INFO - Running setup.py install for mozhttpd 15:16:17 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:16:17 INFO - Running setup.py install for mozinfo 15:16:17 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:16:17 INFO - Running setup.py install for mozInstall 15:16:18 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:16:18 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:16:18 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:16:18 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:16:18 INFO - Running setup.py install for mozleak 15:16:18 INFO - Running setup.py install for mozlog 15:16:18 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:16:18 INFO - Running setup.py install for moznetwork 15:16:18 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:16:18 INFO - Running setup.py install for mozprocess 15:16:18 INFO - Running setup.py install for mozprofile 15:16:18 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:16:18 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:16:18 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:16:18 INFO - Running setup.py install for mozrunner 15:16:19 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:16:19 INFO - Running setup.py install for mozscreenshot 15:16:19 INFO - Running setup.py install for moztest 15:16:19 INFO - Running setup.py install for mozversion 15:16:19 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:16:19 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:16:19 INFO - Cleaning up... 15:16:19 INFO - Return code: 0 15:16:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:16:19 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')]} 15:16:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:16:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:16:19 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')]} 15:16:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:16:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:16:19 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 0x1046db490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104651570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9cabc7fa80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1044efd30>, '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 0x104315db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1044e7b20>, '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.e0yMzc6dfL/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.WqaBuSGBYq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/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 15:16:19 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 15:16:19 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 15:16:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.e0yMzc6dfL/Render', 15:16:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:16:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:16:19 INFO - 'HOME': '/Users/cltbld', 15:16:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:16:19 INFO - 'LOGNAME': 'cltbld', 15:16:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:16:19 INFO - 'MOZ_NO_REMOTE': '1', 15:16:19 INFO - 'NO_EM_RESTART': '1', 15:16:19 INFO - 'PAGER': '/bin/cat', 15:16:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:16:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:16:19 INFO - 'PWD': '/builds/slave/test', 15:16:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:16:19 INFO - 'SHELL': '/bin/bash', 15:16:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WqaBuSGBYq/Listeners', 15:16:19 INFO - 'TMPDIR': '/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/', 15:16:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:16:19 INFO - 'USER': 'cltbld', 15:16:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:16:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:16:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:16:19 INFO - 'XPC_FLAGS': '0x0', 15:16:19 INFO - 'XPC_SERVICE_NAME': '0', 15:16:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:16:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:16:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:16:19 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-F0VHgb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:16:19 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)) 15:16:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:16:19 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-6a7fGN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:16:19 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)) 15:16:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:16:19 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-YLOl8B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:16:20 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)) 15:16:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:16:20 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-1a5dJi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:16:20 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)) 15:16:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:16:20 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-k5VawE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:16:20 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)) 15:16:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:16:20 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-omPWp8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:16:20 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)) 15:16:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:16:20 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-4qbWt0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:16:20 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)) 15:16:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:16:20 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-_vEvRm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:16:20 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)) 15:16:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:16:20 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-rpvFcT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:16:20 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)) 15:16:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:16:20 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-6bylGv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:16:20 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)) 15:16:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:16:20 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-era9eO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:16:20 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)) 15:16:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:16:20 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-mGRi9B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:16:21 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)) 15:16:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:16:21 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-unoADr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:16:21 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)) 15:16:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:16:21 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-b1Dbg_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:16:21 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)) 15:16:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:16:21 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-YbKAy9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:16:21 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)) 15:16:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:16:21 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-Wskp1j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:16:21 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)) 15:16:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:16:21 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-d7VCjo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:16:21 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)) 15:16:21 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)) 15:16:21 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)) 15:16:21 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)) 15:16:21 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)) 15:16:21 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)) 15:16:21 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:16:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:16:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:16:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:16:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:16:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:16:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:16:23 INFO - Downloading blessings-1.6.tar.gz 15:16:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:16:24 INFO - Installing collected packages: blessings 15:16:24 INFO - Running setup.py install for blessings 15:16:24 INFO - Successfully installed blessings 15:16:24 INFO - Cleaning up... 15:16:24 INFO - Return code: 0 15:16:24 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:16:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:16:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:16:24 INFO - Reading from file tmpfile_stdout 15:16:24 INFO - Current package versions: 15:16:24 INFO - blessings == 1.6 15:16:24 INFO - blobuploader == 1.2.4 15:16:24 INFO - docopt == 0.6.1 15:16:24 INFO - functools32 == 3.2.3-2 15:16:24 INFO - jsonschema == 2.5.1 15:16:24 INFO - manifestparser == 1.1 15:16:24 INFO - mozInstall == 1.12 15:16:24 INFO - mozcrash == 0.17 15:16:24 INFO - mozdebug == 0.1 15:16:24 INFO - mozdevice == 0.48 15:16:24 INFO - mozfile == 1.2 15:16:24 INFO - mozhttpd == 0.7 15:16:24 INFO - mozinfo == 0.9 15:16:24 INFO - mozleak == 0.1 15:16:24 INFO - mozlog == 3.4 15:16:24 INFO - moznetwork == 0.27 15:16:24 INFO - mozprocess == 0.23 15:16:24 INFO - mozprofile == 0.28 15:16:24 INFO - mozrunner == 6.12 15:16:24 INFO - mozscreenshot == 0.1 15:16:24 INFO - mozsystemmonitor == 0.3 15:16:24 INFO - moztest == 0.7 15:16:24 INFO - mozversion == 1.4 15:16:24 INFO - psutil == 3.1.1 15:16:24 INFO - requests == 1.2.3 15:16:24 INFO - wsgiref == 0.1.2 15:16:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:16: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')]} 15:16:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:16:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:16: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')]} 15:16:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:16:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:16:24 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 0x1046db490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104651570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9cabc7fa80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1044efd30>, '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 0x104315db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1044e7b20>, '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.e0yMzc6dfL/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.WqaBuSGBYq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/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 15:16:24 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 15:16:24 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 15:16:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.e0yMzc6dfL/Render', 15:16:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:16:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:16:24 INFO - 'HOME': '/Users/cltbld', 15:16:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:16:24 INFO - 'LOGNAME': 'cltbld', 15:16:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:16:24 INFO - 'MOZ_NO_REMOTE': '1', 15:16:24 INFO - 'NO_EM_RESTART': '1', 15:16:24 INFO - 'PAGER': '/bin/cat', 15:16:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:16:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:16:24 INFO - 'PWD': '/builds/slave/test', 15:16:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:16:24 INFO - 'SHELL': '/bin/bash', 15:16:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WqaBuSGBYq/Listeners', 15:16:24 INFO - 'TMPDIR': '/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/', 15:16:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:16:24 INFO - 'USER': 'cltbld', 15:16:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:16:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:16:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:16:24 INFO - 'XPC_FLAGS': '0x0', 15:16:24 INFO - 'XPC_SERVICE_NAME': '0', 15:16:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:16:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:16:24 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)) 15:16:24 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)) 15:16:24 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)) 15:16:24 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)) 15:16:24 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)) 15:16:24 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)) 15:16:24 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)) 15:16:24 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)) 15:16:24 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)) 15:16:24 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)) 15:16:24 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)) 15:16:24 INFO - Cleaning up... 15:16:24 INFO - Return code: 0 15:16:24 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 15:16: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')]} 15:16:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:16:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:16: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')]} 15:16:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:16:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:16: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1046db490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104651570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9cabc7fa80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1044efd30>, '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 0x104315db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1044e7b20>, '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.e0yMzc6dfL/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.WqaBuSGBYq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/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 15:16: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', 'jsonschema'] in /builds/slave/test/build 15:16: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 jsonschema 15:16:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.e0yMzc6dfL/Render', 15:16:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:16:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:16:24 INFO - 'HOME': '/Users/cltbld', 15:16:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:16:24 INFO - 'LOGNAME': 'cltbld', 15:16:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:16:24 INFO - 'MOZ_NO_REMOTE': '1', 15:16:24 INFO - 'NO_EM_RESTART': '1', 15:16:24 INFO - 'PAGER': '/bin/cat', 15:16:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:16:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:16:24 INFO - 'PWD': '/builds/slave/test', 15:16:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:16:24 INFO - 'SHELL': '/bin/bash', 15:16:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WqaBuSGBYq/Listeners', 15:16:24 INFO - 'TMPDIR': '/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/', 15:16:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:16:24 INFO - 'USER': 'cltbld', 15:16:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:16:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:16:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:16:24 INFO - 'XPC_FLAGS': '0x0', 15:16:24 INFO - 'XPC_SERVICE_NAME': '0', 15:16:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:16:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:16:25 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 15:16:25 INFO - Cleaning up... 15:16:25 INFO - Return code: 0 15:16:25 INFO - Running post-action listener: _resource_record_post_action 15:16:25 INFO - Running post-action listener: _start_resource_monitoring 15:16:25 INFO - Starting resource monitoring. 15:16:25 INFO - [mozharness: 2016-09-21 22:16:25.252645Z] Finished create-virtualenv step (success) 15:16:25 INFO - [mozharness: 2016-09-21 22:16:25.253676Z] Running install step. 15:16:25 INFO - Running pre-action listener: _resource_record_pre_action 15:16:25 INFO - Running main action method: install 15:16:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:16:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:16:25 INFO - Reading from file tmpfile_stdout 15:16:25 INFO - Detecting whether we're running mozinstall >=1.0... 15:16:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:16:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:16:25 INFO - Reading from file tmpfile_stdout 15:16:25 INFO - Output received: 15:16:25 INFO - Usage: mozinstall [options] installer 15:16:25 INFO - Options: 15:16:25 INFO - -h, --help show this help message and exit 15:16:25 INFO - -d DEST, --destination=DEST 15:16:25 INFO - Directory to install application into. [default: 15:16:25 INFO - "/builds/slave/test"] 15:16:25 INFO - --app=APP Application being installed. [default: firefox] 15:16:25 INFO - mkdir: /builds/slave/test/build/application 15:16:25 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'] 15:16:25 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 15:16:59 INFO - Reading from file tmpfile_stdout 15:16:59 INFO - Output received: 15:16:59 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 15:16:59 INFO - Running post-action listener: _resource_record_post_action 15:16:59 INFO - [mozharness: 2016-09-21 22:16:59.632807Z] Finished install step (success) 15:16:59 INFO - [mozharness: 2016-09-21 22:16:59.633021Z] Running run-tests step. 15:16:59 INFO - Running pre-action listener: _resource_record_pre_action 15:16:59 INFO - Running main action method: run_tests 15:16:59 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 15:16:59 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 15:16:59 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 15:16:59 INFO - 2016-09-21 15:16:59.647 screenresolution[2248:20192] starting screenresolution argv=screenresolution get 15:16:59 INFO - 2016-09-21 15:16:59.650 screenresolution[2248:20192] Display 0: 1600x1200x32@60 15:16:59 INFO - 2016-09-21 15:16:59.656 screenresolution[2249:20194] starting screenresolution argv=screenresolution list 15:16:59 INFO - Available Modes on Display 0 15:16:59 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 15:16:59 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 15:16:59 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 15:16:59 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 15:16:59 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 15:16:59 INFO - Intel Iris: 15:16:59 INFO - Chipset Model: Intel Iris 15:16:59 INFO - Type: GPU 15:16:59 INFO - Bus: Built-In 15:16:59 INFO - VRAM (Dynamic, Max): 1536 MB 15:16:59 INFO - Vendor: Intel (0x8086) 15:16:59 INFO - Device ID: 0x0a2e 15:16:59 INFO - Revision ID: 0x0009 15:16:59 INFO - Displays: 15:16:59 INFO - Display: 15:16:59 INFO - Resolution: 1600 x 1200 @ 60 Hz 15:16:59 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 15:16:59 INFO - Display Serial Number: 1600x1200 60 15:16:59 INFO - Main Display: Yes 15:16:59 INFO - Mirror: Off 15:16:59 INFO - Online: Yes 15:16:59 INFO - Rotation: Supported 15:16:59 INFO - Return code: 0 15:16:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:16:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:16:59 INFO - Python 2.7.3 15:16:59 INFO - Return code: 0 15:16:59 INFO - grabbing minidump binary from tooltool 15:16:59 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')]} 15:16:59 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 0x1044efd30>, '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 0x104315db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1044e7b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:16:59 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 15:16:59 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 15:16:59 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 15:16:59 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:17:00 INFO - Return code: 0 15:17:00 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 15:17:00 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:17:00 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:17:00 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 15:17:00 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:17:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/JKVMBgQHSSiutC1wtCFaIQ/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0082', '--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 15:17:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/JKVMBgQHSSiutC1wtCFaIQ/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0082 --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 15:17:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.e0yMzc6dfL/Render', 15:17:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:17:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:17:00 INFO - 'HOME': '/Users/cltbld', 15:17:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:17:00 INFO - 'LOGNAME': 'cltbld', 15:17:00 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:17:00 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 15:17:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:17:00 INFO - 'MOZ_NO_REMOTE': '1', 15:17:00 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:17:00 INFO - 'NO_EM_RESTART': '1', 15:17:00 INFO - 'PAGER': '/bin/cat', 15:17:00 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:17:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:17:00 INFO - 'PWD': '/builds/slave/test', 15:17:00 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:17:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:17:00 INFO - 'SHELL': '/bin/bash', 15:17:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WqaBuSGBYq/Listeners', 15:17:00 INFO - 'TMPDIR': '/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/', 15:17:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:17:00 INFO - 'USER': 'cltbld', 15:17:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:17:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:17:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:17:00 INFO - 'XPC_FLAGS': '0x0', 15:17:00 INFO - 'XPC_SERVICE_NAME': '0', 15:17:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:17:00 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/JKVMBgQHSSiutC1wtCFaIQ/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0082', '--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 15:17:00 INFO - mozversion application_buildid: 20160921125600 15:17:00 INFO - mozversion application_changeset: e893929f7606287f3359cda18bfb29d492846643 15:17:00 INFO - mozversion application_display_name: Nightly 15:17:00 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:17:00 INFO - mozversion application_name: Firefox 15:17:00 INFO - mozversion application_remotingname: firefox 15:17:00 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 15:17:00 INFO - mozversion application_vendor: Mozilla 15:17:00 INFO - mozversion application_version: 52.0a1 15:17:00 INFO - mozversion platform_buildid: 20160921125600 15:17:00 INFO - mozversion platform_changeset: e893929f7606287f3359cda18bfb29d492846643 15:17:00 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 15:17:00 INFO - mozversion platform_version: 52.0a1 15:17:00 INFO - using testdate: 1474496220 15:17:00 INFO - actual date: 1474496220 15:17:00 INFO - starting webserver on 'localhost:52137' 15:17:00 INFO - SUITE-START | Running 2 tests 15:17:00 INFO - TEST-START | dromaeo_css 15:17:00 INFO - operating with platform_type : mac_ 15:17:00 INFO - Initialising browser for dromaeo_css test... 15:17:00 INFO - TEST-INFO | started process 2259 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/tmpq1ojwj/profile http://localhost:52137/getInfo.html) 15:17:02 INFO - PROCESS | 2259 | __metrics Screen width/height:1600/1200 15:17:02 INFO - PROCESS | 2259 | colorDepth:24 15:17:02 INFO - PROCESS | 2259 | Browser inner width/height: 1024/689 15:17:02 INFO - PROCESS | 2259 | __metrics 15:17:02 INFO - PROCESS | 2259 | 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" 15:17:02 INFO - PROCESS | 2259 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 15:17:03 INFO - TEST-INFO | 2259: exit 0 15:17:03 INFO - Browser initialized. 15:17:03 INFO - Running cycle 1/1 for dromaeo_css test... 15:17:03 INFO - TEST-INFO | started process 2261 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/tmpq1ojwj/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:17:15 INFO - PROCESS | 2261 | RSS: Main: 235307008 15:17:15 INFO - PROCESS | 2261 | 15:18:06 INFO - PROCESS | 2261 | 1474496286755 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] 15:20:18 INFO - PROCESS | 2261 | Cycle 1(1): loaded http://localhost:52137/tests/dromaeo/cssquery-dojo.html (next: http://localhost:52137/tests/dromaeo/cssquery-ext.html) 15:20:19 INFO - PROCESS | 2261 | RSS: Main: 357810176 15:20:19 INFO - PROCESS | 2261 | 15:23:22 INFO - PROCESS | 2261 | Cycle 1(1): loaded http://localhost:52137/tests/dromaeo/cssquery-ext.html (next: http://localhost:52137/tests/dromaeo/cssquery-jquery.html) 15:23:23 INFO - PROCESS | 2261 | RSS: Main: 371527680 15:23:23 INFO - PROCESS | 2261 | 15:26:25 INFO - PROCESS | 2261 | Cycle 1(1): loaded http://localhost:52137/tests/dromaeo/cssquery-jquery.html (next: http://localhost:52137/tests/dromaeo/cssquery-mootools.html) 15:26:25 INFO - PROCESS | 2261 | RSS: Main: 347189248 15:26:25 INFO - PROCESS | 2261 | 15:29:28 INFO - PROCESS | 2261 | Cycle 1(1): loaded http://localhost:52137/tests/dromaeo/cssquery-mootools.html (next: http://localhost:52137/tests/dromaeo/cssquery-prototype.html) 15:29:28 INFO - PROCESS | 2261 | RSS: Main: 356417536 15:29:28 INFO - PROCESS | 2261 | 15:32:31 INFO - PROCESS | 2261 | Cycle 1(1): loaded http://localhost:52137/tests/dromaeo/cssquery-prototype.html (next: http://localhost:52137/tests/dromaeo/cssquery-yui.html) 15:32:32 INFO - PROCESS | 2261 | RSS: Main: 331718656 15:32:32 INFO - PROCESS | 2261 | 15:35:36 INFO - PROCESS | 2261 | Cycle 1(1): loaded http://localhost:52137/tests/dromaeo/cssquery-yui.html (next: http://localhost:52137/tests/dromaeo/cssquery-dojo.html) 15:35:36 INFO - PROCESS | 2261 | RSS: Main: 377069568 15:35:36 INFO - PROCESS | 2261 | 15:35:36 INFO - PROCESS | 2261 | __start_tp_report 15:35:36 INFO - PROCESS | 2261 | _x_x_mozilla_page_load 15:35:36 INFO - PROCESS | 2261 | _x_x_mozilla_page_load_details 15:35:36 INFO - PROCESS | 2261 | |i|pagename|runs| 15:35:36 INFO - PROCESS | 2261 | |0;dojo.html;2494.4262819551504;3277.9016629501116;3321.916952076198;3340.766146369755;3368.764186506944;5548.112302031675;5574.303212098488;5585.944140558593;5662.6602403855795;5679.574031947605;5644.6330988485715;5646.830595082144;5661.830145095653;5720.370759216493;5787.363390027093;5097.413797413308;5104.846854594368;5142.10013247682;5142.61430392722;5211.45279745627;5198.740062996854;5249.370075590934;5272.31459910213;5281.9207711884355;5288.629795914288;5074.441811400743;5198.636095473318;5225.399079105913;5232.697373672868;5319.308489896308;5091.898162036776;5160.406553246387;5170.327857378555;5178.844634660966;5187.8184263550975;5059.013492368989;5088.956763863399;5150.896982060338;5159.638825282232;5160.509751573594;5669.036263835158;5678.687672178028;5680.744366503517;5700.030994730906;5739.827805165852;6215.28524219716;6241.531885108589;6250.187475628185;6253.812385628438;6254.186955695731;6097.936251104343;6101.035369328037;6138.265785110748;6161.7535298588;6210.937890621081;5826.883462330815;5833.82498525045;5843.065109582489;5873.765049398019;5888.735006924699;6168.1056246843955;6251.374862513712;6260.686965651699;6264.718087686065;6264.749410023548;5985.102234664835;5996.70016499182;6001.399860013964;6160.722767475474;6171.074338849119;5099.821506247264;6134.595604022517;6145.446909778141;6173.8456538586;6177.505799536027;5184.5593124584075;6137.0794380842335;6146.416090471398;6221.09794079865;6227.844303892439;6095.725692343855;6187.504999600022;6233.844153896189;6243.96878015607;6257.68711564429;4854.101991131652;4887.047025829929;4899.3385892904;4901.901961960741;4927.531884470969;4413.40419043425;4419.447569053868;4420.513743488214;4423.778811059434;4445.488768791631;5742.28221472316;5748.19525266463;5759.8560035999435;5761.107028410603;5774.133879917962;6115.179495343508;6133.457080270768;6133.723982420802;6168.290646575611;6206.913790086717;5739.13912913058;5789.623674461147;5825.79609713658;5849.356570777211;5869.8239052828485;5379.838604841861;5392.056390131711;5394.8921021579345;5406.053940560386;5417.702026388586;6144.72645121308;6224.06639004153;6238.438540531374;6291.55959082869;6296.842578935563;6148.077788331786;6158.291796443287;6187.783427580013;6200.844978875564;6280.654563999024;6249.500039996698;6268.404501572343;6276.623402595859;6285.151504546828;6300.653464059521;5987.072003839412;6137.662428566293;6145.631262124287;6168.1056246844855;6173.259208894961;6106.885399019288;6108.664023478751;6109.0403061477;6124.29570599369;6128.655903792346;6089.5432842537875;6092.664903430176;6099.481544068626;6117.510599152146;6124.663143527148;6072.301685306246;6086.087086936995;6091.604045737013;6093.969530152321;6097.420745029215;4636.420447444069;5667.854540372687;5757.165211044291;5839.036558967723;5882.617629854046;6101.247350682792;6109.389061093855;6109.429011806784;6118.663473508822;6127.036821038878;5743.396943321059;5912.615679980788;5923.585349025527;5948.821535353946;5953.613015154001 15:35:36 INFO - PROCESS | 2261 | |1;ext.html;506.3569267030873;515.9819406320779;521.3665396543199;525.220048228381;531.9175527793191;30463.238419039535;39696.80151599242;40543;40789.59210407895;41938.161236775246;41666.16667666645;42180.789096054556;42185;42204.36693449601;42222.15555688884;8791.12088791119;9804.950975245149;9997.600095996188;10013.899861001406;10038.498075096253;8801.031886492512;11971.70070748234;12176.695582610462;12209.816852747215;12460.252384856893;12282.877171228263;12312.938435307811;12323.753524929496;12323.938380308085;12351.629451116482;12227.69430764229;12294.139410241287;12301.753964920741;12301.876981230163;12315.69210769729;11968.042556595452;12019.15865889388;12060.638180854588;12067.637970860887;12082;39902.60097399018;40220.79889600533;40236.39645405321;40305.79847100746;40366.9908252296;3252.9512057319157;3300.3988892697353;3439.398105331557;3550.9644903550893;3583.157957879896;29921.70078299211;30314.14973604235;30715.078547643607;31507.527387089212;31674.841625791953;3140.4975203967256;3287.7205437537837;3305.6612072110834;3309.420851351004;3374.898753037413;479188;480606;480869;481003;481759;57529.71235143798;57816.132758008665;57934.7103264481;57962.7101864488;58082.4191758077;61749.76500469966;61819;61860;61875;61948;15978.280977356048;16290.348386064661;16298.674026519404;16322.428714994918;16330.918345408198;11471.85281471846;11597.594084207012;12541.623751287476;12559.995200383948;12649.936750316374;18102.637947241245;18513.81486185148;18514.351997680016;18547.907260463882;18557.47407992477;6234.407731265523;6516.804495865132;7752.147263800977;7761.72833950809;7825.295723384923;839.9916000840036;877.5612193903048;1066.3069005146717;1080.4597701149426;1088.5210507376728;28767.99312024069;28986.550672466292;28987.275318117216;29007.603061219677;29373.85313073421;978.3347323819728;1012.4178597306578;1038.309524166436;1049.3441599000626;1068.3536460441321;14160.035190146775;14903.031302965273;15017.849821501644;15093.773593396108;15207.619809504851;680632;689718;690343;690344;691199;55878.44121558814;56418.87162256814;56440;56455.71772141113;56656.71671641615;1324.2120938041849;1340.631326385252;1373.0114317691246;1373.8351397832125;1379.2414172205447;28084.157475275773;28787.712122878504;28884.42231155407;29618.703812962456;29778.851105744332;46286.53713462822;46862.594122176386;46869.765651171525;47034.764826177015;47044.82387940329;626834;629674;630431;630475;631477.842610784;22407.327780166623;22730.43173920665;22743.203987860346;25209.369765756004;25622.487550249265;43322.78338608287;44864.8783780395;45874.311885322415;47337.28994065161;47867.28199076947;37451.43822842605;37722.679706210154;38158.23683526369;38905;39022.609773901895;37458.6254137466;37582;37594.87215383543;38586.614133858304;38897.80551097226;36759.63240367562;37476.68831590881;37704.81147594244;37736.05659858416;37866.242675146896;32009;33644.83177584096;33692.157696057795;33957;34035.4894676585;24583.89372478207;24889.751102488743;24916.501669966136;25487.87256063708;25590.87204563965 15:35:36 INFO - PROCESS | 2261 | |2;jquery.html;356.859040678932;371.11489098500067;377.4771940861906;386.2660944206009;405.64303412996577;14948.252587370642;15267.541973740777;16924.323027078903;20006;20756.377308680727;11990.640280791591;14833;19457.416277511697;20098.49753756157;20376.694349584766;5331.333583302087;5517.034518959166;5521.061419558685;5523.530499907512;5547.11246200608;5382.730863456831;5423.457654234585;5543.473370029841;5905.202797622331;6022.488088512459;6019.157317975487;6021.909671354933;6023.096535519663;6028.0957856321465;6028.397160283958;4641.280601506738;5378.327709036371;5452.209429632681;5462.508374246337;5477;5229.607779416521;5281.894362112775;5299.894002119936;5301.966116607263;5308.389535203462;12947.352632368344;13028.022898282572;13134.671633209151;13141.211527308393;13157;2112.894355282245;2218.4675677837204;2264.2527965771255;2267.5238199978025;2328.326981992066;9576.425414475154;10017.649382271586;10073.697789066266;10332.845007324897;10502.474876256232;1527.9618009549738;1864;1966.223341779989;1976.071246514136;2016.9495762605904;116441;129567.35216323953;129914.3504282482;130725.6927430723;137385.62614373828;9546.42721436716;9809.313348065567;9925;9936.453495057696;10071.532474543783;12221.511139554319;12251.754964900652;12261.509539618315;12335.198212116184;12394.566190183301;8011.879821802678;8173.117769059649;8174.877376839352;8284.917150828534;8323.458975166595;8592.49917484025;8605.526696031779;8634.611442485104;8809.691660791841;8819.294456443597;3237.2392487765355;3710.2023065041144;3760.699144068468;3825.0819803247578;3909.237698648736;1879.3328368429284;1909.8800331631878;1910.6178764247206;1912.407153782332;1942.4075656924774;825.2201669422338;839.5004972041626;883.5317281840635;894.2220268366563;896.394933419939;17778.733319000225;20371.981400929893;21471.248506302203;21957;21966.45083872916;835.9164083591713;900.2887718702283;917.5274733512247;918.9908100918905;938.6902322233647;8583.742487725378;9738.951305243429;11075.72310692223;11799.469023893773;11903.404829758478;571707;608759;622399;622424;624643;132716.33641831923;142368;142774;143341;150950;979.7501637082498;1016.761061150629;1034.813733527957;1035.77213013137;1036.79782442423;19135.61728765389;19817.306394276133;19841.80158198457;19863.900680496507;20098.78913319563;56396;58510.24469265929;59483.70258148682;60177.398226017176;60275.39724602873;85772;86280;87418.125818741;87530.56234719041;89030.66454003325;7954.761357159295;8141.959290203511;8205.671773129247;8319.292860106958;8509.574521274035;10632.936706329305;12301.876981230072;12570.680078591617;13077.346132693518;13209.471621135432;9518.000609935856;9532.904670953201;11200.935911088434;11317.434128293387;11435.942820286178;10409.375437473776;10923.672289831318;11328.546858125583;11494.310341379543;11742.530298788295;8893.822123557622;11218.66344009681;11345.829812552653;11706.180567360203;11760.294382337088;6917.481188910952;7813.335866451415;8149.388795840217;8233.970753655793;8408.789780255542;10975.890241097486;11052.447377630926;11256.324620522795;11268.605598804003;11322.547098116313 15:35:36 INFO - PROCESS | 2261 | |3;mootools.html;1349.5883755454595;1514.2353111678603;1520.9391624335026;1740.2603893345324;1911.8470522358205;7880.369570434365;8327.83344333113;8328.500289982605;8329.83340333193;8336.04135524415;8488.23605875471;8777.736667899973;8813.823723525526;8884.555772211379;8900.777480562972;2394.5091256292417;2430.1980346485707;2433.8074343571698;2436.829421940456;2438.804895608347;2387.6060450025725;2416.2026531244733;2428.2229686500327;2429.3197904586746;2436.707595088592;2317.2237300504266;2388.6058800298015;2405.494846082316;2414.263649586875;2416.5046165536023;2361.622140457536;2390.4740956989435;2399.436132508859;2399.568077745996;2403.7596240375997;2355.4817940053163;2377.037299893546;2381.714194296678;2385.5228954209056;2387.224152150558;8800.779980500474;8843.69047083349;8910.153535414125;8926.285897128215;8955.731328060168;5198.16829307309;5297.205419187114;5405.37838148614;5470.152126420371;5478;3544.9822750886083;3675.117971686803;3753.174301653632;3754.3242216401036;3761.6426439488205;949.5157469690507;1103.4703342395615;1114.1588100983786;1126.5155982927338;1130.152385710717;11575.884241157564;11642.88357116435;11776.528938842435;11810.763784724257;11815.527378904833;4497.16802391552;4534.206513860061;4691.249400096037;4694.413198350207;4704.811807527729;9229.35394522377;9234.261259099256;9243.352965292499;9246.95376523113;9247.72256832296;5260.079486089919;5276.419593844674;5318.149096144675;5327;5331.466853314638;4329.610335069859;4461.553844615512;4587.7017993830295;4602.7468489233415;4933.679310844784;3811.3520701480816;3812.7140464465274;3816.561095474056;3869.496965394537;3898.2788184186015;1016.9542370593341;1176.8764279750674;1189.8036823924128;1193.8686744458103;1198.9520419183134;744.4788647946459;835.3692961813791;900.6937641202023;900.8153328567628;941.4304345870787;5490.423505531941;5726.312842458931;5929.822105336847;6032.54755893301;6135.263768347827;891.9241864441466;920.9585568649427;929.1173385284008;938.4088024544493;950.4297421547017;3728.440733889938;3735.9439608405896;3819.3698039823116;3942.8817135485406;4067.9389809152885;10561.260711750258;10665.786684266272;10688.839667404995;10696.251262411557;10787.137029037658;10839;10884.564617415215;10885.346879187275;10905;11021;7754.828647978575;8168;8296.796964440122;8305.211004954519;8324.375671824637;5921.230240068763;6055.909161362495;6089.208402907594;6121.755129794937;6162.722677479614;9756.951215243878;9841.409515429097;10113.29206955506;10127.341722787995;10210.948945255226;9451.716448506555;9758.707238782848;9929.205663547044;10298.22763292741;10389.272750907365;7420.220876807857;7595.3164215220895;7632.274933881273;7659.004329437137;7742.651580678996;8259.339252859876;8327.791805204919;8393.706220282262;8440.915590844259;8451.83096338082;7400.777976660709;7436.814079648052;7527.8118047049265;7620.047494063242;7650;7308.8538229234055;7367.594782287026;7373.8525229494035;7377.4098072155175;7402.518836275625;6918.411934985583;6977.7208911642965;7043.542169759155;7068.29317068289;7068.469864760061;5002.17464118431;5026.899462010812;5058.342415485963;5076.670016448919;5138.588912887035;4092.2633925893624;4971.254311853107;5088.7201203932655;5098.490150984871;5195.402528709247 15:35:36 INFO - PROCESS | 2261 | |4;prototype.html;277.3413143783514;291.3982625877564;308.8702744847164;312.4064277872043;316.28361760612233;4293.914121717564;4478.888027799307;4762.7618619069035;5256.947430525694;5273.6572122811995;5024.196128619422;5161.354830646169;5169.353830771153;5191.273221748958;5222.362706833044;3979.363301871701;3983.2033593281385;3984.8406063757416;3987.98006009971;4007.759534427929;3627.3470775260444;3702.8889133326043;3997.6601988830985;4022.3162062449455;4033.455483509718;3762.4603392709946;3904.1801221743467;3950.518555541672;3968.285708572456;3989.840406383741;3574.428091505373;3628.274345130958;3929.842806287745;3939.1924655445564;3961.861334853281;3085.6142982127235;3229.6931791479774;3243.2054146733967;3463.79217246966;3464.3071385722956;4158.276329004507;4219.852305169335;4972.55795819212;5117.897642047175;5185.637005409623;3901.6293452122004;4386.605205531486;4559.791655211372;4576.908461830745;4588.26587745959;4536.387587675655;4839.782209800567;5048.29323894655;5501.697406642633;5516.889662206733;3173.6826317368077;3175.714185723296;3822.80795535728;3823.5985221551614;3833.4249862520564;5018.673786203922;5460.017196904556;5591.916121258185;5674.219632380104;5861.501772349356;3591.7428899885354;3619.583747868976;3800.5439347278502;3840.2319536092336;3843.423486477051;3217.501287300472;3339.53246545479;3796.7532110412735;3849.88353377523;3942.605739426092;4358.433403657505;4570.588647021784;4578.519255478127;4578.542145785462;4582;4558.49856515783;4800.551718623527;5487.972560137174;5526.032944234743;5526.392096869341;1178.6051672689746;1309.109805332383;1340.987554396444;1341.745068436994;1344.88568471681;744.5421066044344;770.5530792140545;825.7357645553366;831.6174559702483;836.6402446947749;4124.546299907008;4165.312723400665;4302.698811083257;4340.327249276367;4359.062801497693;4209.842293369286;4444.599986001275;4498.605432315992;4758.333833263277;4795.640326975491;3649.5620525537106;4344.804483798173;4368.4321038264825;4393.868183954486;4413.757243351646;2130.7975742304457;2260.4687898343877;2272.397959438625;2376.691030166102;2480.4823104548896;4240.936385954213;4487;4561.452625684939;4748.26401907698;4765.809367625326;4788.760561971957;4829.541193586604;4845.63657725672;4872.4153101628035;5476.91784623231;4190.937135942963;5611.551075913917;5698.4871361576825;5820.970895145497;5843.474087332075;4943.752812359296;5018.1432869836935;5671.546276297969;5700.857478562903;5768.7404066817935;4681.391419115494;4756.500567440507;5629.099344104923;5631.9443403158375;5675.290588676416;5259.921101183561;5671.943280567141;5741.397153299011;5745.023346031101;5800.361960184292;3055.090568394753;3496.5454490916018;3725.906852328605;3832.7961422182916;3848.7690738555775;5323.6273460857365;5738.49951529575;5743.639970617236;5753.8561535961935;5766;4616.330632058266;5046.873828154326;5447.400785913625;5540.63985840919;5575.609707320448;5195.882885179704;5239.685618862881;5547.750351234124;5555.666660000413;5559.471850174389;4696.8978512066415;5088.160453525127;5295.9610549939325;5337.57299416038;5362.981033603603;5323.467653234646;5502.202180683698;5535.529479994246;5555.416681248411;5563.332400112013;5426.941746359422;5443.7822487100075;5456.7544460498575;5468.617196796186;5482.945170548243 15:35:36 INFO - PROCESS | 2261 | |5;yui.html;719.8913672943663;724.6521669598593;774.7714424244847;814.5804910471105;816.8652172391555;15338.23308834558;16563.585910352216;16577.58556036098;16581.088040157785;16597;13646.590602281947;13708.383122759475;13742.793858092136;13743.93128034361;13757;675.2167485716569;698.4307789151825;700.7932659865352;841.3563623827746;867.7440155154213;826.1862065865118;840.932725381968;842.3724325377572;842.7134774176778;846.9788255293605;748.8315129095964;895.7268033249857;901.9188273055423;902.1024081039375;903.3541018172006;726.8146622611254;747.0475144191146;751.9511231769917;890.7773056735816;897.995510022449;553.4935533986438;554.7836343825911;656.0814859197114;672.7611697847292;680.6528670378093;15054.849451505565;15094.320755566026;15110.773338399933;15114.470993515175;15136.243187840564;13963.65090872726;14220.786688199685;14307.356168972317;14594;14660.41358345665;12800.48798048077;12960.48158073676;13024.218546887218;13160.27618480983;13553.661158471117;4172.582741725833;4518.570735780096;4623.144718227139;4672.462666793294;4743.454502732196;111840.4407977963;116153.41923290414;116725.41637291844;116959;117553;10954.123670106372;11309.660710178709;11502.712432189095;11536.596219132458;11757.118216133824;23118.768812312;23122.190723324602;23129.88435057814;23167.189148379726;23179;7972.080814508473;7997.960010200029;8096.7166149184495;8128.105908350077;8129.75610731679;4260.829566817292;4401.273789824643;4434.645228381722;4440.866773996785;4531.456225252925;3483;3624.184558474375;3632.3461776880417;3634.0914771307175;3635.5637323521346;625.8404106952698;650.9609423434609;653.7254353171679;654.7708302094229;663.6316844151446;575.7409165875373;589.4223660812343;603.7102190948369;609.7530500147448;647.7797548833325;8404.579771011426;9338.766530836783;9474.052245142573;9556.283278754121;9698.854517182248;568.9260396148475;611.6421893192444;653.3988730368072;664.4285914113955;678.915135608049;4135.511215962251;4391.956080439155;4687.835925742583;4752.809887604457;4767.809287628525;126284;128474.35762821126;159934.2003289976;160678;163529;138171;141936.29031854775;142849.28575357056;145073.27463362616;145528;111512;113106;114214;114364.98890155385;117311;7594.734184303523;9057.230135438298;9126.589303481227;9126.634934602542;9189.679942533525;65649.67175164094;65667;65714;66916.33083669296;67687.66156169187;95940;102579.487102564;102895.53671412538;102909.48545257226;103009.45485817868;12034.939825300817;12058.871969935268;12314.384280785745;12478.064145188966;12738.68153296175;13125.803112953505;13388.665283367603;13392.196468211938;13427.865721343052;14064.929675351557;12267.631971040882;12356.135070544975;12393.566225182076;12423.19249248832;12649.430775615303;12056.336901470504;12296.262224266573;12335.814962775745;12812.295323757282;12868.549600763929;11819.881801181878;11922.463489142836;11959.103067270164;12026.037916966447;12796.744065118459;9790.657326993522;11118.833217501906;11328.093752499615;11483.94258028738;11898.702532436759;11329.490172942073;11426;11555.88444115548;11711.531538738696;11715.707107322385 15:35:36 INFO - PROCESS | 2261 | __end_tp_report 15:35:36 INFO - PROCESS | 2261 | __start_cc_report 15:35:36 INFO - PROCESS | 2261 | _x_x_mozilla_cycle_collect,1233 15:35:36 INFO - PROCESS | 2261 | __end_cc_report 15:35:36 INFO - PROCESS | 2261 | __startTimestamp1474497336301__endTimestamp 15:35:36 INFO - PROCESS | 2261 | 15:35:36 INFO - PROCESS | 2261 | ------- Summary: start ------- 15:35:36 INFO - PROCESS | 2261 | Number of tests: 6 15:35:36 INFO - PROCESS | 2261 | 15:35:36 INFO - PROCESS | 2261 | [#0] dojo.html Cycles:165 Average:5693.04 Median:5888.74 stddev:658.83 (11.2%) stddev-sans-first:611.21 15:35:36 INFO - PROCESS | 2261 | Values: 2494.4 3277.9 3321.9 3340.8 3368.8 5548.1 5574.3 5585.9 5662.7 5679.6 5644.6 5646.8 5661.8 5720.4 5787.4 5097.4 5104.8 5142.1 5142.6 5211.5 5198.7 5249.4 5272.3 5281.9 5288.6 5074.4 5198.6 5225.4 5232.7 5319.3 5091.9 5160.4 5170.3 5178.8 5187.8 5059.0 5089.0 5150.9 5159.6 5160.5 5669.0 5678.7 5680.7 5700.0 5739.8 6215.3 6241.5 6250.2 6253.8 6254.2 6097.9 6101.0 6138.3 6161.8 6210.9 5826.9 5833.8 5843.1 5873.8 5888.7 6168.1 6251.4 6260.7 6264.7 6264.7 5985.1 5996.7 6001.4 6160.7 6171.1 5099.8 6134.6 6145.4 6173.8 6177.5 5184.6 6137.1 6146.4 6221.1 6227.8 6095.7 6187.5 6233.8 6244.0 6257.7 4854.1 4887.0 4899.3 4901.9 4927.5 4413.4 4419.4 4420.5 4423.8 4445.5 5742.3 5748.2 5759.9 5761.1 5774.1 6115.2 6133.5 6133.7 6168.3 6206.9 5739.1 5789.6 5825.8 5849.4 5869.8 5379.8 5392.1 5394.9 5406.1 5417.7 6144.7 6224.1 6238.4 6291.6 6296.8 6148.1 6158.3 6187.8 6200.8 6280.7 6249.5 6268.4 6276.6 6285.2 6300.7 5987.1 6137.7 6145.6 6168.1 6173.3 6106.9 6108.7 6109.0 6124.3 6128.7 6089.5 6092.7 6099.5 6117.5 6124.7 6072.3 6086.1 6091.6 6094.0 6097.4 4636.4 5667.9 5757.2 5839.0 5882.6 6101.2 6109.4 6109.4 6118.7 6127.0 5743.4 5912.6 5923.6 5948.8 5953.6 15:35:36 INFO - PROCESS | 2261 | 15:35:36 INFO - PROCESS | 2261 | [#1] ext.html Cycles:180 Average:72530.04 Median:18737.44 stddev:162283.49 (866.1%) stddev-sans-first:162648.64 15:35:36 INFO - PROCESS | 2261 | Values: 506.4 516.0 521.4 525.2 531.9 30463.2 39696.8 40543.0 40789.6 41938.2 41666.2 42180.8 42185.0 42204.4 42222.2 8791.1 9805.0 9997.6 10013.9 10038.5 8801.0 11971.7 12176.7 12209.8 12460.3 12282.9 12312.9 12323.8 12323.9 12351.6 12227.7 12294.1 12301.8 12301.9 12315.7 11968.0 12019.2 12060.6 12067.6 12082.0 39902.6 40220.8 40236.4 40305.8 40367.0 3253.0 3300.4 3439.4 3551.0 3583.2 29921.7 30314.1 30715.1 31507.5 31674.8 3140.5 3287.7 3305.7 3309.4 3374.9 479188.0 480606.0 480869.0 481003.0 481759.0 57529.7 57816.1 57934.7 57962.7 58082.4 61749.8 61819.0 61860.0 61875.0 61948.0 15978.3 16290.3 16298.7 16322.4 16330.9 11471.9 11597.6 12541.6 12560.0 12649.9 18102.6 18513.8 18514.4 18547.9 18557.5 6234.4 6516.8 7752.1 7761.7 7825.3 840.0 877.6 1066.3 1080.5 1088.5 28768.0 28986.6 28987.3 29007.6 29373.9 978.3 1012.4 1038.3 1049.3 1068.4 14160.0 14903.0 15017.8 15093.8 15207.6 680632.0 689718.0 690343.0 690344.0 691199.0 55878.4 56418.9 56440.0 56455.7 56656.7 1324.2 1340.6 1373.0 1373.8 1379.2 28084.2 28787.7 28884.4 29618.7 29778.9 46286.5 46862.6 46869.8 47034.8 47044.8 626834.0 629674.0 630431.0 630475.0 631477.8 22407.3 22730.4 22743.2 25209.4 25622.5 43322.8 44864.9 45874.3 47337.3 47867.3 37451.4 37722.7 38158.2 38905.0 39022.6 37458.6 37582.0 37594.9 38586.6 38897.8 36759.6 37476.7 37704.8 37736.1 37866.2 32009.0 33644.8 33692.2 33957.0 34035.5 24583.9 24889.8 24916.5 25487.9 25590.9 15:35:36 INFO - PROCESS | 2261 | 15:35:36 INFO - PROCESS | 2261 | [#2] jquery.html Cycles:180 Average:35796.44 Median:363.99 stddev:102697.44 (28214.6%) stddev-sans-first:102951.06 15:35:36 INFO - PROCESS | 2261 | Values: 356.9 371.1 377.5 386.3 405.6 14948.3 15267.5 16924.3 20006.0 20756.4 11990.6 14833.0 19457.4 20098.5 20376.7 5331.3 5517.0 5521.1 5523.5 5547.1 5382.7 5423.5 5543.5 5905.2 6022.5 6019.2 6021.9 6023.1 6028.1 6028.4 4641.3 5378.3 5452.2 5462.5 5477.0 5229.6 5281.9 5299.9 5302.0 5308.4 12947.4 13028.0 13134.7 13141.2 13157.0 2112.9 2218.5 2264.3 2267.5 2328.3 9576.4 10017.6 10073.7 10332.8 10502.5 1528.0 1864.0 1966.2 1976.1 2016.9 116441.0 129567.4 129914.4 130725.7 137385.6 9546.4 9809.3 9925.0 9936.5 10071.5 12221.5 12251.8 12261.5 12335.2 12394.6 8011.9 8173.1 8174.9 8284.9 8323.5 8592.5 8605.5 8634.6 8809.7 8819.3 3237.2 3710.2 3760.7 3825.1 3909.2 1879.3 1909.9 1910.6 1912.4 1942.4 825.2 839.5 883.5 894.2 896.4 17778.7 20372.0 21471.2 21957.0 21966.5 835.9 900.3 917.5 919.0 938.7 8583.7 9739.0 11075.7 11799.5 11903.4 571707.0 608759.0 622399.0 622424.0 624643.0 132716.3 142368.0 142774.0 143341.0 150950.0 979.8 1016.8 1034.8 1035.8 1036.8 19135.6 19817.3 19841.8 19863.9 20098.8 56396.0 58510.2 59483.7 60177.4 60275.4 85772.0 86280.0 87418.1 87530.6 89030.7 7954.8 8142.0 8205.7 8319.3 8509.6 10632.9 12301.9 12570.7 13077.3 13209.5 9518.0 9532.9 11200.9 11317.4 11435.9 10409.4 10923.7 11328.5 11494.3 11742.5 8893.8 11218.7 11345.8 11706.2 11760.3 6917.5 7813.3 8149.4 8234.0 8408.8 10975.9 11052.4 11256.3 11268.6 11322.5 15:35:36 INFO - PROCESS | 2261 | 15:35:36 INFO - PROCESS | 2261 | [#3] mootools.html Cycles:180 Average:5702.59 Median:5093.61 stddev:3184.46 (62.5%) stddev-sans-first:3176.59 15:35:36 INFO - PROCESS | 2261 | Values: 1349.6 1514.2 1520.9 1740.3 1911.8 7880.4 8327.8 8328.5 8329.8 8336.0 8488.2 8777.7 8813.8 8884.6 8900.8 2394.5 2430.2 2433.8 2436.8 2438.8 2387.6 2416.2 2428.2 2429.3 2436.7 2317.2 2388.6 2405.5 2414.3 2416.5 2361.6 2390.5 2399.4 2399.6 2403.8 2355.5 2377.0 2381.7 2385.5 2387.2 8800.8 8843.7 8910.2 8926.3 8955.7 5198.2 5297.2 5405.4 5470.2 5478.0 3545.0 3675.1 3753.2 3754.3 3761.6 949.5 1103.5 1114.2 1126.5 1130.2 11575.9 11642.9 11776.5 11810.8 11815.5 4497.2 4534.2 4691.2 4694.4 4704.8 9229.4 9234.3 9243.4 9247.0 9247.7 5260.1 5276.4 5318.1 5327.0 5331.5 4329.6 4461.6 4587.7 4602.7 4933.7 3811.4 3812.7 3816.6 3869.5 3898.3 1017.0 1176.9 1189.8 1193.9 1199.0 744.5 835.4 900.7 900.8 941.4 5490.4 5726.3 5929.8 6032.5 6135.3 891.9 921.0 929.1 938.4 950.4 3728.4 3735.9 3819.4 3942.9 4067.9 10561.3 10665.8 10688.8 10696.3 10787.1 10839.0 10884.6 10885.3 10905.0 11021.0 7754.8 8168.0 8296.8 8305.2 8324.4 5921.2 6055.9 6089.2 6121.8 6162.7 9757.0 9841.4 10113.3 10127.3 10210.9 9451.7 9758.7 9929.2 10298.2 10389.3 7420.2 7595.3 7632.3 7659.0 7742.7 8259.3 8327.8 8393.7 8440.9 8451.8 7400.8 7436.8 7527.8 7620.0 7650.0 7308.9 7367.6 7373.9 7377.4 7402.5 6918.4 6977.7 7043.5 7068.3 7068.5 5002.2 5026.9 5058.3 5076.7 5138.6 4092.3 4971.3 5088.7 5098.5 5195.4 15:35:36 INFO - PROCESS | 2261 | 15:35:36 INFO - PROCESS | 2261 | [#4] prototype.html Cycles:180 Average:4286.46 Median:4580.27 stddev:1344.13 (29.3%) stddev-sans-first:1313.78 15:35:36 INFO - PROCESS | 2261 | Values: 277.3 291.4 308.9 312.4 316.3 4293.9 4478.9 4762.8 5256.9 5273.7 5024.2 5161.4 5169.4 5191.3 5222.4 3979.4 3983.2 3984.8 3988.0 4007.8 3627.3 3702.9 3997.7 4022.3 4033.5 3762.5 3904.2 3950.5 3968.3 3989.8 3574.4 3628.3 3929.8 3939.2 3961.9 3085.6 3229.7 3243.2 3463.8 3464.3 4158.3 4219.9 4972.6 5117.9 5185.6 3901.6 4386.6 4559.8 4576.9 4588.3 4536.4 4839.8 5048.3 5501.7 5516.9 3173.7 3175.7 3822.8 3823.6 3833.4 5018.7 5460.0 5591.9 5674.2 5861.5 3591.7 3619.6 3800.5 3840.2 3843.4 3217.5 3339.5 3796.8 3849.9 3942.6 4358.4 4570.6 4578.5 4578.5 4582.0 4558.5 4800.6 5488.0 5526.0 5526.4 1178.6 1309.1 1341.0 1341.7 1344.9 744.5 770.6 825.7 831.6 836.6 4124.5 4165.3 4302.7 4340.3 4359.1 4209.8 4444.6 4498.6 4758.3 4795.6 3649.6 4344.8 4368.4 4393.9 4413.8 2130.8 2260.5 2272.4 2376.7 2480.5 4240.9 4487.0 4561.5 4748.3 4765.8 4788.8 4829.5 4845.6 4872.4 5476.9 4190.9 5611.6 5698.5 5821.0 5843.5 4943.8 5018.1 5671.5 5700.9 5768.7 4681.4 4756.5 5629.1 5631.9 5675.3 5259.9 5671.9 5741.4 5745.0 5800.4 3055.1 3496.5 3725.9 3832.8 3848.8 5323.6 5738.5 5743.6 5753.9 5766.0 4616.3 5046.9 5447.4 5540.6 5575.6 5195.9 5239.7 5547.8 5555.7 5559.5 4696.9 5088.2 5296.0 5337.6 5363.0 5323.5 5502.2 5535.5 5555.4 5563.3 5426.9 5443.8 5456.8 5468.6 5482.9 15:35:36 INFO - PROCESS | 2261 | 15:35:36 INFO - PROCESS | 2261 | [#5] yui.html Cycles:180 Average:25852.93 Median:23148.54 stddev:41837.75 (180.7%) stddev-sans-first:41912.56 15:35:36 INFO - PROCESS | 2261 | Values: 719.9 724.7 774.8 814.6 816.9 15338.2 16563.6 16577.6 16581.1 16597.0 13646.6 13708.4 13742.8 13743.9 13757.0 675.2 698.4 700.8 841.4 867.7 826.2 840.9 842.4 842.7 847.0 748.8 895.7 901.9 902.1 903.4 726.8 747.0 752.0 890.8 898.0 553.5 554.8 656.1 672.8 680.7 15054.8 15094.3 15110.8 15114.5 15136.2 13963.7 14220.8 14307.4 14594.0 14660.4 12800.5 12960.5 13024.2 13160.3 13553.7 4172.6 4518.6 4623.1 4672.5 4743.5 111840.4 116153.4 116725.4 116959.0 117553.0 10954.1 11309.7 11502.7 11536.6 11757.1 23118.8 23122.2 23129.9 23167.2 23179.0 7972.1 7998.0 8096.7 8128.1 8129.8 4260.8 4401.3 4434.6 4440.9 4531.5 3483.0 3624.2 3632.3 3634.1 3635.6 625.8 651.0 653.7 654.8 663.6 575.7 589.4 603.7 609.8 647.8 8404.6 9338.8 9474.1 9556.3 9698.9 568.9 611.6 653.4 664.4 678.9 4135.5 4392.0 4687.8 4752.8 4767.8 126284.0 128474.4 159934.2 160678.0 163529.0 138171.0 141936.3 142849.3 145073.3 145528.0 111512.0 113106.0 114214.0 114365.0 117311.0 7594.7 9057.2 9126.6 9126.6 9189.7 65649.7 65667.0 65714.0 66916.3 67687.7 95940.0 102579.5 102895.5 102909.5 103009.5 12034.9 12058.9 12314.4 12478.1 12738.7 13125.8 13388.7 13392.2 13427.9 14064.9 12267.6 12356.1 12393.6 12423.2 12649.4 12056.3 12296.3 12335.8 12812.3 12868.5 11819.9 11922.5 11959.1 12026.0 12796.7 9790.7 11118.8 11328.1 11483.9 11898.7 11329.5 11426.0 11555.9 11711.5 11715.7 15:35:36 INFO - PROCESS | 2261 | -------- Summary: end -------- 15:35:36 INFO - PROCESS | 2261 | 15:35:36 INFO - TEST-INFO | 2261: exit 0 15:35:36 INFO - TEST-OK | dromaeo_css | took 1116723ms 15:35:36 INFO - TEST-START | kraken 15:35:36 INFO - operating with platform_type : mac_ 15:35:36 INFO - Initialising browser for kraken test... 15:35:36 INFO - TEST-INFO | started process 2264 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/tmpswiZil/profile http://localhost:52137/getInfo.html) 15:35:39 INFO - PROCESS | 2264 | __metrics Screen width/height:1600/1200 15:35:39 INFO - PROCESS | 2264 | colorDepth:24 15:35:39 INFO - PROCESS | 2264 | Browser inner width/height: 1024/689 15:35:39 INFO - PROCESS | 2264 | __metrics 15:35:39 INFO - PROCESS | 2264 | 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" 15:35:39 INFO - PROCESS | 2264 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 15:35:40 INFO - TEST-INFO | 2264: exit 0 15:35:40 INFO - Browser initialized. 15:35:40 INFO - Running cycle 1/1 for kraken test... 15:35:40 INFO - TEST-INFO | started process 2265 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/tmpswiZil/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:35:52 INFO - PROCESS | 2265 | RSS: Main: 235712512 15:35:52 INFO - PROCESS | 2265 | 15:35:54 INFO - PROCESS | 2265 | Cycle 1(1): loaded http://localhost:52137/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:52137/tests/kraken/driver.html?testName=audio-beat-detection) 15:35:55 INFO - PROCESS | 2265 | RSS: Main: 294854656 15:35:55 INFO - PROCESS | 2265 | 15:35:58 INFO - PROCESS | 2265 | Cycle 1(1): loaded http://localhost:52137/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:52137/tests/kraken/driver.html?testName=audio-dft) 15:35:59 INFO - PROCESS | 2265 | RSS: Main: 293117952 15:35:59 INFO - PROCESS | 2265 | 15:36:02 INFO - PROCESS | 2265 | Cycle 1(1): loaded http://localhost:52137/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:52137/tests/kraken/driver.html?testName=audio-fft) 15:36:03 INFO - PROCESS | 2265 | RSS: Main: 384864256 15:36:03 INFO - PROCESS | 2265 | 15:36:05 INFO - PROCESS | 2265 | Cycle 1(1): loaded http://localhost:52137/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:52137/tests/kraken/driver.html?testName=audio-oscillator) 15:36:05 INFO - PROCESS | 2265 | RSS: Main: 283951104 15:36:05 INFO - PROCESS | 2265 | 15:36:07 INFO - PROCESS | 2265 | Cycle 1(1): loaded http://localhost:52137/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:52137/tests/kraken/driver.html?testName=imaging-gaussian-blur) 15:36:08 INFO - PROCESS | 2265 | RSS: Main: 288104448 15:36:08 INFO - PROCESS | 2265 | 15:36:11 INFO - PROCESS | 2265 | Cycle 1(1): loaded http://localhost:52137/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:52137/tests/kraken/driver.html?testName=imaging-darkroom) 15:36:11 INFO - PROCESS | 2265 | RSS: Main: 326991872 15:36:11 INFO - PROCESS | 2265 | 15:36:14 INFO - PROCESS | 2265 | Cycle 1(1): loaded http://localhost:52137/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:52137/tests/kraken/driver.html?testName=imaging-desaturate) 15:36:15 INFO - PROCESS | 2265 | RSS: Main: 328871936 15:36:15 INFO - PROCESS | 2265 | 15:36:18 INFO - PROCESS | 2265 | Cycle 1(1): loaded http://localhost:52137/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:52137/tests/kraken/driver.html?testName=json-parse-financial) 15:36:18 INFO - PROCESS | 2265 | RSS: Main: 326352896 15:36:18 INFO - PROCESS | 2265 | 15:36:20 INFO - PROCESS | 2265 | Cycle 1(1): loaded http://localhost:52137/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:52137/tests/kraken/driver.html?testName=json-stringify-tinderbox) 15:36:20 INFO - PROCESS | 2265 | RSS: Main: 305004544 15:36:20 INFO - PROCESS | 2265 | 15:36:22 INFO - PROCESS | 2265 | Cycle 1(1): loaded http://localhost:52137/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:52137/tests/kraken/driver.html?testName=stanford-crypto-aes) 15:36:23 INFO - PROCESS | 2265 | RSS: Main: 304406528 15:36:23 INFO - PROCESS | 2265 | 15:36:25 INFO - PROCESS | 2265 | Cycle 1(1): loaded http://localhost:52137/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:52137/tests/kraken/driver.html?testName=stanford-crypto-ccm) 15:36:26 INFO - PROCESS | 2265 | RSS: Main: 306569216 15:36:26 INFO - PROCESS | 2265 | 15:36:29 INFO - PROCESS | 2265 | Cycle 1(1): loaded http://localhost:52137/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:52137/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 15:36:29 INFO - PROCESS | 2265 | RSS: Main: 316796928 15:36:29 INFO - PROCESS | 2265 | 15:36:32 INFO - PROCESS | 2265 | Cycle 1(1): loaded http://localhost:52137/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:52137/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 15:36:33 INFO - PROCESS | 2265 | RSS: Main: 318951424 15:36:33 INFO - PROCESS | 2265 | 15:36:35 INFO - PROCESS | 2265 | Cycle 1(1): loaded http://localhost:52137/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:52137/tests/kraken/driver.html?testName=ai-astar) 15:36:35 INFO - PROCESS | 2265 | RSS: Main: 362307584 15:36:35 INFO - PROCESS | 2265 | 15:36:35 INFO - PROCESS | 2265 | __start_tp_report 15:36:35 INFO - PROCESS | 2265 | _x_x_mozilla_page_load 15:36:35 INFO - PROCESS | 2265 | _x_x_mozilla_page_load_details 15:36:35 INFO - PROCESS | 2265 | |i|pagename|runs| 15:36:35 INFO - PROCESS | 2265 | |0;ai-astar;112;112;112;117;111;112;113;111;112;112 15:36:35 INFO - PROCESS | 2265 | |1;audio-beat-detection;149;110;115;180;140;132;109;109;149;139 15:36:35 INFO - PROCESS | 2265 | |2;audio-dft;191;185;184;183;185;182;182;183;183;183 15:36:35 INFO - PROCESS | 2265 | |3;audio-fft;80;59;60;92;62;58;59;58;82;58 15:36:35 INFO - PROCESS | 2265 | |4;audio-oscillator;86;71;92;70;70;69;93;68;68;88 15:36:35 INFO - PROCESS | 2265 | |5;imaging-gaussian-blur;88;85;87;84;90;85;89;85;87;84 15:36:35 INFO - PROCESS | 2265 | |6;imaging-darkroom;96;95;96;96;97;95;95;95;96;96 15:36:35 INFO - PROCESS | 2265 | |7;imaging-desaturate;85;84;86;85;87;86;86;84;87;84 15:36:35 INFO - PROCESS | 2265 | |8;json-parse-financial;56;53;55;53;54;55;55;54;55;54 15:36:35 INFO - PROCESS | 2265 | |9;json-stringify-tinderbox;66;77;72;77;74;74;73;72;71;75 15:36:35 INFO - PROCESS | 2265 | |10;stanford-crypto-aes;97;95;105;82;84;97;87;85;86;87 15:36:35 INFO - PROCESS | 2265 | |11;stanford-crypto-ccm;140;138;137;141;137;141;139;138;222;138 15:36:35 INFO - PROCESS | 2265 | |12;stanford-crypto-pbkdf2;173;167;166;170;171;169;167;168;168;170 15:36:35 INFO - PROCESS | 2265 | |13;stanford-crypto-sha256-iterative;66;68;69;69;67;76;81;87;84;65 15:36:35 INFO - PROCESS | 2265 | __end_tp_report 15:36:35 INFO - PROCESS | 2265 | __start_cc_report 15:36:35 INFO - PROCESS | 2265 | _x_x_mozilla_cycle_collect,1981 15:36:35 INFO - PROCESS | 2265 | __end_cc_report 15:36:35 INFO - PROCESS | 2265 | __startTimestamp1474497395399__endTimestamp 15:36:35 INFO - PROCESS | 2265 | 15:36:35 INFO - PROCESS | 2265 | ------- Summary: start ------- 15:36:35 INFO - PROCESS | 2265 | Number of tests: 14 15:36:35 INFO - PROCESS | 2265 | 15:36:35 INFO - PROCESS | 2265 | [#0] ai-astar Cycles:10 Average:112.40 Median:112.00 stddev:1.71 (1.5%) stddev-sans-first:1.81 15:36:35 INFO - PROCESS | 2265 | Values: 112.0 112.0 112.0 117.0 111.0 112.0 113.0 111.0 112.0 112.0 15:36:35 INFO - PROCESS | 2265 | 15:36:35 INFO - PROCESS | 2265 | [#1] audio-beat-detection Cycles:10 Average:133.20 Median:139.50 stddev:23.12 (16.6%) stddev-sans-first:23.81 15:36:35 INFO - PROCESS | 2265 | Values: 149.0 110.0 115.0 180.0 140.0 132.0 109.0 109.0 149.0 139.0 15:36:35 INFO - PROCESS | 2265 | 15:36:35 INFO - PROCESS | 2265 | [#2] audio-dft Cycles:10 Average:184.10 Median:183.50 stddev:2.64 (1.4%) stddev-sans-first:1.12 15:36:35 INFO - PROCESS | 2265 | Values: 191.0 185.0 184.0 183.0 185.0 182.0 182.0 183.0 183.0 183.0 15:36:35 INFO - PROCESS | 2265 | 15:36:35 INFO - PROCESS | 2265 | [#3] audio-fft Cycles:10 Average:66.80 Median:61.00 stddev:12.75 (20.9%) stddev-sans-first:12.60 15:36:35 INFO - PROCESS | 2265 | Values: 80.0 59.0 60.0 92.0 62.0 58.0 59.0 58.0 82.0 58.0 15:36:35 INFO - PROCESS | 2265 | 15:36:35 INFO - PROCESS | 2265 | [#4] audio-oscillator Cycles:10 Average:77.50 Median:78.50 stddev:10.75 (13.7%) stddev-sans-first:10.96 15:36:35 INFO - PROCESS | 2265 | Values: 86.0 71.0 92.0 70.0 70.0 69.0 93.0 68.0 68.0 88.0 15:36:35 INFO - PROCESS | 2265 | 15:36:35 INFO - PROCESS | 2265 | [#5] imaging-gaussian-blur Cycles:10 Average:86.40 Median:87.00 stddev:2.12 (2.4%) stddev-sans-first:2.17 15:36:35 INFO - PROCESS | 2265 | Values: 88.0 85.0 87.0 84.0 90.0 85.0 89.0 85.0 87.0 84.0 15:36:35 INFO - PROCESS | 2265 | 15:36:35 INFO - PROCESS | 2265 | [#6] imaging-darkroom Cycles:10 Average:95.70 Median:96.00 stddev:0.67 (0.7%) stddev-sans-first:0.71 15:36:35 INFO - PROCESS | 2265 | Values: 96.0 95.0 96.0 96.0 97.0 95.0 95.0 95.0 96.0 96.0 15:36:35 INFO - PROCESS | 2265 | 15:36:35 INFO - PROCESS | 2265 | [#7] imaging-desaturate Cycles:10 Average:85.40 Median:86.00 stddev:1.17 (1.4%) stddev-sans-first:1.24 15:36:35 INFO - PROCESS | 2265 | Values: 85.0 84.0 86.0 85.0 87.0 86.0 86.0 84.0 87.0 84.0 15:36:35 INFO - PROCESS | 2265 | 15:36:35 INFO - PROCESS | 2265 | [#8] json-parse-financial Cycles:10 Average:54.40 Median:55.00 stddev:0.97 (1.8%) stddev-sans-first:0.83 15:36:35 INFO - PROCESS | 2265 | Values: 56.0 53.0 55.0 53.0 54.0 55.0 55.0 54.0 55.0 54.0 15:36:35 INFO - PROCESS | 2265 | 15:36:35 INFO - PROCESS | 2265 | [#9] json-stringify-tinderbox Cycles:10 Average:73.10 Median:74.00 stddev:3.21 (4.3%) stddev-sans-first:2.15 15:36:35 INFO - PROCESS | 2265 | Values: 66.0 77.0 72.0 77.0 74.0 74.0 73.0 72.0 71.0 75.0 15:36:35 INFO - PROCESS | 2265 | 15:36:35 INFO - PROCESS | 2265 | [#10] stanford-crypto-aes Cycles:10 Average:90.50 Median:87.00 stddev:7.49 (8.6%) stddev-sans-first:7.56 15:36:35 INFO - PROCESS | 2265 | Values: 97.0 95.0 105.0 82.0 84.0 97.0 87.0 85.0 86.0 87.0 15:36:35 INFO - PROCESS | 2265 | 15:36:35 INFO - PROCESS | 2265 | [#11] stanford-crypto-ccm Cycles:10 Average:147.10 Median:139.50 stddev:26.36 (18.9%) stddev-sans-first:27.83 15:36:35 INFO - PROCESS | 2265 | Values: 140.0 138.0 137.0 141.0 137.0 141.0 139.0 138.0 222.0 138.0 15:36:35 INFO - PROCESS | 2265 | 15:36:35 INFO - PROCESS | 2265 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:168.90 Median:169.50 stddev:2.13 (1.3%) stddev-sans-first:1.67 15:36:35 INFO - PROCESS | 2265 | Values: 173.0 167.0 166.0 170.0 171.0 169.0 167.0 168.0 168.0 170.0 15:36:35 INFO - PROCESS | 2265 | 15:36:35 INFO - PROCESS | 2265 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:73.20 Median:72.50 stddev:8.13 (11.2%) stddev-sans-first:8.20 15:36:35 INFO - PROCESS | 2265 | Values: 66.0 68.0 69.0 69.0 67.0 76.0 81.0 87.0 84.0 65.0 15:36:35 INFO - PROCESS | 2265 | -------- Summary: end -------- 15:36:35 INFO - PROCESS | 2265 | 15:36:36 INFO - TEST-INFO | 2265: exit 0 15:36:36 INFO - TEST-OK | kraken | took 59317ms 15:36:36 INFO - SUITE-END | took 1176s 15:36:36 INFO - Completed test suite (00:19:36) 15:36:36 INFO - javascript benchmark 15:36:36 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2494.4262819551504, 3277.9016629501116, 3321.916952076198, 3340.766146369755, 3368.764186506944, 5548.112302031675, 5574.303212098488, 5585.944140558593, 5662.6602403855795, 5679.574031947605, 5644.6330988485715, 5646.830595082144, 5661.830145095653, 5720.370759216493, 5787.363390027093, 5097.413797413308, 5104.846854594368, 5142.10013247682, 5142.61430392722, 5211.45279745627, 5198.740062996854, 5249.370075590934, 5272.31459910213, 5281.9207711884355, 5288.629795914288, 5074.441811400743, 5198.636095473318, 5225.399079105913, 5232.697373672868, 5319.308489896308, 5091.898162036776, 5160.406553246387, 5170.327857378555, 5178.844634660966, 5187.8184263550975, 5059.013492368989, 5088.956763863399, 5150.896982060338, 5159.638825282232, 5160.509751573594, 5669.036263835158, 5678.687672178028, 5680.744366503517, 5700.030994730906, 5739.827805165852, 6215.28524219716, 6241.531885108589, 6250.187475628185, 6253.812385628438, 6254.186955695731, 6097.936251104343, 6101.035369328037, 6138.265785110748, 6161.7535298588, 6210.937890621081, 5826.883462330815, 5833.82498525045, 5843.065109582489, 5873.765049398019, 5888.735006924699, 6168.1056246843955, 6251.374862513712, 6260.686965651699, 6264.718087686065, 6264.749410023548, 5985.102234664835, 5996.70016499182, 6001.399860013964, 6160.722767475474, 6171.074338849119, 5099.821506247264, 6134.595604022517, 6145.446909778141, 6173.8456538586, 6177.505799536027, 5184.5593124584075, 6137.0794380842335, 6146.416090471398, 6221.09794079865, 6227.844303892439, 6095.725692343855, 6187.504999600022, 6233.844153896189, 6243.96878015607, 6257.68711564429, 4854.101991131652, 4887.047025829929, 4899.3385892904, 4901.901961960741, 4927.531884470969, 4413.40419043425, 4419.447569053868, 4420.513743488214, 4423.778811059434, 4445.488768791631, 5742.28221472316, 5748.19525266463, 5759.8560035999435, 5761.107028410603, 5774.133879917962, 6115.179495343508, 6133.457080270768, 6133.723982420802, 6168.290646575611, 6206.913790086717, 5739.13912913058, 5789.623674461147, 5825.79609713658, 5849.356570777211, 5869.8239052828485, 5379.838604841861, 5392.056390131711, 5394.8921021579345, 5406.053940560386, 5417.702026388586, 6144.72645121308, 6224.06639004153, 6238.438540531374, 6291.55959082869, 6296.842578935563, 6148.077788331786, 6158.291796443287, 6187.783427580013, 6200.844978875564, 6280.654563999024, 6249.500039996698, 6268.404501572343, 6276.623402595859, 6285.151504546828, 6300.653464059521, 5987.072003839412, 6137.662428566293, 6145.631262124287, 6168.1056246844855, 6173.259208894961, 6106.885399019288, 6108.664023478751, 6109.0403061477, 6124.29570599369, 6128.655903792346, 6089.5432842537875, 6092.664903430176, 6099.481544068626, 6117.510599152146, 6124.663143527148, 6072.301685306246, 6086.087086936995, 6091.604045737013, 6093.969530152321, 6097.420745029215, 4636.420447444069, 5667.854540372687, 5757.165211044291, 5839.036558967723, 5882.617629854046, 6101.247350682792, 6109.389061093855, 6109.429011806784, 6118.663473508822, 6127.036821038878, 5743.396943321059, 5912.615679980788, 5923.585349025527, 5948.821535353946, 5953.613015154001], "value": 5648.825905471123, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [506.3569267030873, 515.9819406320779, 521.3665396543199, 525.220048228381, 531.9175527793191, 30463.238419039535, 39696.80151599242, 40543.0, 40789.59210407895, 41938.161236775246, 41666.16667666645, 42180.789096054556, 42185.0, 42204.36693449601, 42222.15555688884, 8791.12088791119, 9804.950975245149, 9997.600095996188, 10013.899861001406, 10038.498075096253, 8801.031886492512, 11971.70070748234, 12176.695582610462, 12209.816852747215, 12460.252384856893, 12282.877171228263, 12312.938435307811, 12323.753524929496, 12323.938380308085, 12351.629451116482, 12227.69430764229, 12294.139410241287, 12301.753964920741, 12301.876981230163, 12315.69210769729, 11968.042556595452, 12019.15865889388, 12060.638180854588, 12067.637970860887, 12082.0, 39902.60097399018, 40220.79889600533, 40236.39645405321, 40305.79847100746, 40366.9908252296, 3252.9512057319157, 3300.3988892697353, 3439.398105331557, 3550.9644903550893, 3583.157957879896, 29921.70078299211, 30314.14973604235, 30715.078547643607, 31507.527387089212, 31674.841625791953, 3140.4975203967256, 3287.7205437537837, 3305.6612072110834, 3309.420851351004, 3374.898753037413, 479188.0, 480606.0, 480869.0, 481003.0, 481759.0, 57529.71235143798, 57816.132758008665, 57934.7103264481, 57962.7101864488, 58082.4191758077, 61749.76500469966, 61819.0, 61860.0, 61875.0, 61948.0, 15978.280977356048, 16290.348386064661, 16298.674026519404, 16322.428714994918, 16330.918345408198, 11471.85281471846, 11597.594084207012, 12541.623751287476, 12559.995200383948, 12649.936750316374, 18102.637947241245, 18513.81486185148, 18514.351997680016, 18547.907260463882, 18557.47407992477, 6234.407731265523, 6516.804495865132, 7752.147263800977, 7761.72833950809, 7825.295723384923, 839.9916000840036, 877.5612193903048, 1066.3069005146717, 1080.4597701149426, 1088.5210507376728, 28767.99312024069, 28986.550672466292, 28987.275318117216, 29007.603061219677, 29373.85313073421, 978.3347323819728, 1012.4178597306578, 1038.309524166436, 1049.3441599000626, 1068.3536460441321, 14160.035190146775, 14903.031302965273, 15017.849821501644, 15093.773593396108, 15207.619809504851, 680632.0, 689718.0, 690343.0, 690344.0, 691199.0, 55878.44121558814, 56418.87162256814, 56440.0, 56455.71772141113, 56656.71671641615, 1324.2120938041849, 1340.631326385252, 1373.0114317691246, 1373.8351397832125, 1379.2414172205447, 28084.157475275773, 28787.712122878504, 28884.42231155407, 29618.703812962456, 29778.851105744332, 46286.53713462822, 46862.594122176386, 46869.765651171525, 47034.764826177015, 47044.82387940329, 626834.0, 629674.0, 630431.0, 630475.0, 631477.842610784, 22407.327780166623, 22730.43173920665, 22743.203987860346, 25209.369765756004, 25622.487550249265, 43322.78338608287, 44864.8783780395, 45874.311885322415, 47337.28994065161, 47867.28199076947, 37451.43822842605, 37722.679706210154, 38158.23683526369, 38905.0, 39022.609773901895, 37458.6254137466, 37582.0, 37594.87215383543, 38586.614133858304, 38897.80551097226, 36759.63240367562, 37476.68831590881, 37704.81147594244, 37736.05659858416, 37866.242675146896, 32009.0, 33644.83177584096, 33692.157696057795, 33957.0, 34035.4894676585, 24583.89372478207, 24889.751102488743, 24916.501669966136, 25487.87256063708, 25590.87204563965], "value": 20256.547490749883, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [356.859040678932, 371.11489098500067, 377.4771940861906, 386.2660944206009, 405.64303412996577, 14948.252587370642, 15267.541973740777, 16924.323027078903, 20006.0, 20756.377308680727, 11990.640280791591, 14833.0, 19457.416277511697, 20098.49753756157, 20376.694349584766, 5331.333583302087, 5517.034518959166, 5521.061419558685, 5523.530499907512, 5547.11246200608, 5382.730863456831, 5423.457654234585, 5543.473370029841, 5905.202797622331, 6022.488088512459, 6019.157317975487, 6021.909671354933, 6023.096535519663, 6028.0957856321465, 6028.397160283958, 4641.280601506738, 5378.327709036371, 5452.209429632681, 5462.508374246337, 5477.0, 5229.607779416521, 5281.894362112775, 5299.894002119936, 5301.966116607263, 5308.389535203462, 12947.352632368344, 13028.022898282572, 13134.671633209151, 13141.211527308393, 13157.0, 2112.894355282245, 2218.4675677837204, 2264.2527965771255, 2267.5238199978025, 2328.326981992066, 9576.425414475154, 10017.649382271586, 10073.697789066266, 10332.845007324897, 10502.474876256232, 1527.9618009549738, 1864.0, 1966.223341779989, 1976.071246514136, 2016.9495762605904, 116441.0, 129567.35216323953, 129914.3504282482, 130725.6927430723, 137385.62614373828, 9546.42721436716, 9809.313348065567, 9925.0, 9936.453495057696, 10071.532474543783, 12221.511139554319, 12251.754964900652, 12261.509539618315, 12335.198212116184, 12394.566190183301, 8011.879821802678, 8173.117769059649, 8174.877376839352, 8284.917150828534, 8323.458975166595, 8592.49917484025, 8605.526696031779, 8634.611442485104, 8809.691660791841, 8819.294456443597, 3237.2392487765355, 3710.2023065041144, 3760.699144068468, 3825.0819803247578, 3909.237698648736, 1879.3328368429284, 1909.8800331631878, 1910.6178764247206, 1912.407153782332, 1942.4075656924774, 825.2201669422338, 839.5004972041626, 883.5317281840635, 894.2220268366563, 896.394933419939, 17778.733319000225, 20371.981400929893, 21471.248506302203, 21957.0, 21966.45083872916, 835.9164083591713, 900.2887718702283, 917.5274733512247, 918.9908100918905, 938.6902322233647, 8583.742487725378, 9738.951305243429, 11075.72310692223, 11799.469023893773, 11903.404829758478, 571707.0, 608759.0, 622399.0, 622424.0, 624643.0, 132716.33641831923, 142368.0, 142774.0, 143341.0, 150950.0, 979.7501637082498, 1016.761061150629, 1034.813733527957, 1035.77213013137, 1036.79782442423, 19135.61728765389, 19817.306394276133, 19841.80158198457, 19863.900680496507, 20098.78913319563, 56396.0, 58510.24469265929, 59483.70258148682, 60177.398226017176, 60275.39724602873, 85772.0, 86280.0, 87418.125818741, 87530.56234719041, 89030.66454003325, 7954.761357159295, 8141.959290203511, 8205.671773129247, 8319.292860106958, 8509.574521274035, 10632.936706329305, 12301.876981230072, 12570.680078591617, 13077.346132693518, 13209.471621135432, 9518.000609935856, 9532.904670953201, 11200.935911088434, 11317.434128293387, 11435.942820286178, 10409.375437473776, 10923.672289831318, 11328.546858125583, 11494.310341379543, 11742.530298788295, 8893.822123557622, 11218.66344009681, 11345.829812552653, 11706.180567360203, 11760.294382337088, 6917.481188910952, 7813.335866451415, 8149.388795840217, 8233.970753655793, 8408.789780255542, 10975.890241097486, 11052.447377630926, 11256.324620522795, 11268.605598804003, 11322.547098116313], "value": 9189.966725726015, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1349.5883755454595, 1514.2353111678603, 1520.9391624335026, 1740.2603893345324, 1911.8470522358205, 7880.369570434365, 8327.83344333113, 8328.500289982605, 8329.83340333193, 8336.04135524415, 8488.23605875471, 8777.736667899973, 8813.823723525526, 8884.555772211379, 8900.777480562972, 2394.5091256292417, 2430.1980346485707, 2433.8074343571698, 2436.829421940456, 2438.804895608347, 2387.6060450025725, 2416.2026531244733, 2428.2229686500327, 2429.3197904586746, 2436.707595088592, 2317.2237300504266, 2388.6058800298015, 2405.494846082316, 2414.263649586875, 2416.5046165536023, 2361.622140457536, 2390.4740956989435, 2399.436132508859, 2399.568077745996, 2403.7596240375997, 2355.4817940053163, 2377.037299893546, 2381.714194296678, 2385.5228954209056, 2387.224152150558, 8800.779980500474, 8843.69047083349, 8910.153535414125, 8926.285897128215, 8955.731328060168, 5198.16829307309, 5297.205419187114, 5405.37838148614, 5470.152126420371, 5478.0, 3544.9822750886083, 3675.117971686803, 3753.174301653632, 3754.3242216401036, 3761.6426439488205, 949.5157469690507, 1103.4703342395615, 1114.1588100983786, 1126.5155982927338, 1130.152385710717, 11575.884241157564, 11642.88357116435, 11776.528938842435, 11810.763784724257, 11815.527378904833, 4497.16802391552, 4534.206513860061, 4691.249400096037, 4694.413198350207, 4704.811807527729, 9229.35394522377, 9234.261259099256, 9243.352965292499, 9246.95376523113, 9247.72256832296, 5260.079486089919, 5276.419593844674, 5318.149096144675, 5327.0, 5331.466853314638, 4329.610335069859, 4461.553844615512, 4587.7017993830295, 4602.7468489233415, 4933.679310844784, 3811.3520701480816, 3812.7140464465274, 3816.561095474056, 3869.496965394537, 3898.2788184186015, 1016.9542370593341, 1176.8764279750674, 1189.8036823924128, 1193.8686744458103, 1198.9520419183134, 744.4788647946459, 835.3692961813791, 900.6937641202023, 900.8153328567628, 941.4304345870787, 5490.423505531941, 5726.312842458931, 5929.822105336847, 6032.54755893301, 6135.263768347827, 891.9241864441466, 920.9585568649427, 929.1173385284008, 938.4088024544493, 950.4297421547017, 3728.440733889938, 3735.9439608405896, 3819.3698039823116, 3942.8817135485406, 4067.9389809152885, 10561.260711750258, 10665.786684266272, 10688.839667404995, 10696.251262411557, 10787.137029037658, 10839.0, 10884.564617415215, 10885.346879187275, 10905.0, 11021.0, 7754.828647978575, 8168.0, 8296.796964440122, 8305.211004954519, 8324.375671824637, 5921.230240068763, 6055.909161362495, 6089.208402907594, 6121.755129794937, 6162.722677479614, 9756.951215243878, 9841.409515429097, 10113.29206955506, 10127.341722787995, 10210.948945255226, 9451.716448506555, 9758.707238782848, 9929.205663547044, 10298.22763292741, 10389.272750907365, 7420.220876807857, 7595.3164215220895, 7632.274933881273, 7659.004329437137, 7742.651580678996, 8259.339252859876, 8327.791805204919, 8393.706220282262, 8440.915590844259, 8451.83096338082, 7400.777976660709, 7436.814079648052, 7527.8118047049265, 7620.047494063242, 7650.0, 7308.8538229234055, 7367.594782287026, 7373.8525229494035, 7377.4098072155175, 7402.518836275625, 6918.411934985583, 6977.7208911642965, 7043.542169759155, 7068.29317068289, 7068.469864760061, 5002.17464118431, 5026.899462010812, 5058.342415485963, 5076.670016448919, 5138.588912887035, 4092.2633925893624, 4971.254311853107, 5088.7201203932655, 5098.490150984871, 5195.402528709247], "value": 4579.4034364242025, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [277.3413143783514, 291.3982625877564, 308.8702744847164, 312.4064277872043, 316.28361760612233, 4293.914121717564, 4478.888027799307, 4762.7618619069035, 5256.947430525694, 5273.6572122811995, 5024.196128619422, 5161.354830646169, 5169.353830771153, 5191.273221748958, 5222.362706833044, 3979.363301871701, 3983.2033593281385, 3984.8406063757416, 3987.98006009971, 4007.759534427929, 3627.3470775260444, 3702.8889133326043, 3997.6601988830985, 4022.3162062449455, 4033.455483509718, 3762.4603392709946, 3904.1801221743467, 3950.518555541672, 3968.285708572456, 3989.840406383741, 3574.428091505373, 3628.274345130958, 3929.842806287745, 3939.1924655445564, 3961.861334853281, 3085.6142982127235, 3229.6931791479774, 3243.2054146733967, 3463.79217246966, 3464.3071385722956, 4158.276329004507, 4219.852305169335, 4972.55795819212, 5117.897642047175, 5185.637005409623, 3901.6293452122004, 4386.605205531486, 4559.791655211372, 4576.908461830745, 4588.26587745959, 4536.387587675655, 4839.782209800567, 5048.29323894655, 5501.697406642633, 5516.889662206733, 3173.6826317368077, 3175.714185723296, 3822.80795535728, 3823.5985221551614, 3833.4249862520564, 5018.673786203922, 5460.017196904556, 5591.916121258185, 5674.219632380104, 5861.501772349356, 3591.7428899885354, 3619.583747868976, 3800.5439347278502, 3840.2319536092336, 3843.423486477051, 3217.501287300472, 3339.53246545479, 3796.7532110412735, 3849.88353377523, 3942.605739426092, 4358.433403657505, 4570.588647021784, 4578.519255478127, 4578.542145785462, 4582.0, 4558.49856515783, 4800.551718623527, 5487.972560137174, 5526.032944234743, 5526.392096869341, 1178.6051672689746, 1309.109805332383, 1340.987554396444, 1341.745068436994, 1344.88568471681, 744.5421066044344, 770.5530792140545, 825.7357645553366, 831.6174559702483, 836.6402446947749, 4124.546299907008, 4165.312723400665, 4302.698811083257, 4340.327249276367, 4359.062801497693, 4209.842293369286, 4444.599986001275, 4498.605432315992, 4758.333833263277, 4795.640326975491, 3649.5620525537106, 4344.804483798173, 4368.4321038264825, 4393.868183954486, 4413.757243351646, 2130.7975742304457, 2260.4687898343877, 2272.397959438625, 2376.691030166102, 2480.4823104548896, 4240.936385954213, 4487.0, 4561.452625684939, 4748.26401907698, 4765.809367625326, 4788.760561971957, 4829.541193586604, 4845.63657725672, 4872.4153101628035, 5476.91784623231, 4190.937135942963, 5611.551075913917, 5698.4871361576825, 5820.970895145497, 5843.474087332075, 4943.752812359296, 5018.1432869836935, 5671.546276297969, 5700.857478562903, 5768.7404066817935, 4681.391419115494, 4756.500567440507, 5629.099344104923, 5631.9443403158375, 5675.290588676416, 5259.921101183561, 5671.943280567141, 5741.397153299011, 5745.023346031101, 5800.361960184292, 3055.090568394753, 3496.5454490916018, 3725.906852328605, 3832.7961422182916, 3848.7690738555775, 5323.6273460857365, 5738.49951529575, 5743.639970617236, 5753.8561535961935, 5766.0, 4616.330632058266, 5046.873828154326, 5447.400785913625, 5540.63985840919, 5575.609707320448, 5195.882885179704, 5239.685618862881, 5547.750351234124, 5555.666660000413, 5559.471850174389, 4696.8978512066415, 5088.160453525127, 5295.9610549939325, 5337.57299416038, 5362.981033603603, 5323.467653234646, 5502.202180683698, 5535.529479994246, 5555.416681248411, 5563.332400112013, 5426.941746359422, 5443.7822487100075, 5456.7544460498575, 5468.617196796186, 5482.945170548243], "value": 3861.3054439105526, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [719.8913672943663, 724.6521669598593, 774.7714424244847, 814.5804910471105, 816.8652172391555, 15338.23308834558, 16563.585910352216, 16577.58556036098, 16581.088040157785, 16597.0, 13646.590602281947, 13708.383122759475, 13742.793858092136, 13743.93128034361, 13757.0, 675.2167485716569, 698.4307789151825, 700.7932659865352, 841.3563623827746, 867.7440155154213, 826.1862065865118, 840.932725381968, 842.3724325377572, 842.7134774176778, 846.9788255293605, 748.8315129095964, 895.7268033249857, 901.9188273055423, 902.1024081039375, 903.3541018172006, 726.8146622611254, 747.0475144191146, 751.9511231769917, 890.7773056735816, 897.995510022449, 553.4935533986438, 554.7836343825911, 656.0814859197114, 672.7611697847292, 680.6528670378093, 15054.849451505565, 15094.320755566026, 15110.773338399933, 15114.470993515175, 15136.243187840564, 13963.65090872726, 14220.786688199685, 14307.356168972317, 14594.0, 14660.41358345665, 12800.48798048077, 12960.48158073676, 13024.218546887218, 13160.27618480983, 13553.661158471117, 4172.582741725833, 4518.570735780096, 4623.144718227139, 4672.462666793294, 4743.454502732196, 111840.4407977963, 116153.41923290414, 116725.41637291844, 116959.0, 117553.0, 10954.123670106372, 11309.660710178709, 11502.712432189095, 11536.596219132458, 11757.118216133824, 23118.768812312, 23122.190723324602, 23129.88435057814, 23167.189148379726, 23179.0, 7972.080814508473, 7997.960010200029, 8096.7166149184495, 8128.105908350077, 8129.75610731679, 4260.829566817292, 4401.273789824643, 4434.645228381722, 4440.866773996785, 4531.456225252925, 3483.0, 3624.184558474375, 3632.3461776880417, 3634.0914771307175, 3635.5637323521346, 625.8404106952698, 650.9609423434609, 653.7254353171679, 654.7708302094229, 663.6316844151446, 575.7409165875373, 589.4223660812343, 603.7102190948369, 609.7530500147448, 647.7797548833325, 8404.579771011426, 9338.766530836783, 9474.052245142573, 9556.283278754121, 9698.854517182248, 568.9260396148475, 611.6421893192444, 653.3988730368072, 664.4285914113955, 678.915135608049, 4135.511215962251, 4391.956080439155, 4687.835925742583, 4752.809887604457, 4767.809287628525, 126284.0, 128474.35762821126, 159934.2003289976, 160678.0, 163529.0, 138171.0, 141936.29031854775, 142849.28575357056, 145073.27463362616, 145528.0, 111512.0, 113106.0, 114214.0, 114364.98890155385, 117311.0, 7594.734184303523, 9057.230135438298, 9126.589303481227, 9126.634934602542, 9189.679942533525, 65649.67175164094, 65667.0, 65714.0, 66916.33083669296, 67687.66156169187, 95940.0, 102579.487102564, 102895.53671412538, 102909.48545257226, 103009.45485817868, 12034.939825300817, 12058.871969935268, 12314.384280785745, 12478.064145188966, 12738.68153296175, 13125.803112953505, 13388.665283367603, 13392.196468211938, 13427.865721343052, 14064.929675351557, 12267.631971040882, 12356.135070544975, 12393.566225182076, 12423.19249248832, 12649.430775615303, 12056.336901470504, 12296.262224266573, 12335.814962775745, 12812.295323757282, 12868.549600763929, 11819.881801181878, 11922.463489142836, 11959.103067270164, 12026.037916966447, 12796.744065118459, 9790.657326993522, 11118.833217501906, 11328.093752499615, 11483.94258028738, 11898.702532436759, 11329.490172942073, 11426.0, 11555.88444115548, 11711.531538738696, 11715.707107322385], "value": 7826.801023238268, "unit": "score"}], "name": "dromaeo_css", "value": 7252.743735161281, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 112.0, 112.0, 117.0, 111.0, 112.0, 113.0, 111.0, 112.0, 112.0], "value": 112.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 110.0, 115.0, 180.0, 140.0, 132.0, 109.0, 109.0, 149.0, 139.0], "value": 133.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [191.0, 185.0, 184.0, 183.0, 185.0, 182.0, 182.0, 183.0, 183.0, 183.0], "value": 184.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 59.0, 60.0, 92.0, 62.0, 58.0, 59.0, 58.0, 82.0, 58.0], "value": 66.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 71.0, 92.0, 70.0, 70.0, 69.0, 93.0, 68.0, 68.0, 88.0], "value": 77.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 85.0, 87.0, 84.0, 90.0, 85.0, 89.0, 85.0, 87.0, 84.0], "value": 86.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 96.0, 96.0, 97.0, 95.0, 95.0, 95.0, 96.0, 96.0], "value": 95.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 84.0, 86.0, 85.0, 87.0, 86.0, 86.0, 84.0, 87.0, 84.0], "value": 85.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 53.0, 55.0, 53.0, 54.0, 55.0, 55.0, 54.0, 55.0, 54.0], "value": 54.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 77.0, 72.0, 77.0, 74.0, 74.0, 73.0, 72.0, 71.0, 75.0], "value": 73.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 95.0, 105.0, 82.0, 84.0, 97.0, 87.0, 85.0, 86.0, 87.0], "value": 90.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 138.0, 137.0, 141.0, 137.0, 141.0, 139.0, 138.0, 222.0, 138.0], "value": 147.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [173.0, 167.0, 166.0, 170.0, 171.0, 169.0, 167.0, 168.0, 168.0, 170.0], "value": 168.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 68.0, 69.0, 69.0, 67.0, 76.0, 81.0, 87.0, 84.0, 65.0], "value": 73.2, "unit": "score"}], "name": "kraken", "value": 1448.7, "alertThreshold": 2.0}]} 15:36:36 INFO - Return code: 0 15:36:36 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 15:36:36 INFO - # TBPL SUCCESS # 15:36:36 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 15:36:36 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 15:36:36 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 15:36:36 INFO - 2016-09-21 15:36:36.722 screenresolution[2269:22192] starting screenresolution argv=screenresolution get 15:36:36 INFO - 2016-09-21 15:36:36.725 screenresolution[2269:22192] Display 0: 1600x1200x32@60 15:36:36 INFO - 2016-09-21 15:36:36.731 screenresolution[2270:22195] starting screenresolution argv=screenresolution list 15:36:36 INFO - Available Modes on Display 0 15:36:36 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 15:36:36 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 15:36:36 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 15:36:36 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 15:36:36 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 15:36:36 INFO - Intel Iris: 15:36:36 INFO - Chipset Model: Intel Iris 15:36:36 INFO - Type: GPU 15:36:36 INFO - Bus: Built-In 15:36:36 INFO - VRAM (Dynamic, Max): 1536 MB 15:36:36 INFO - Vendor: Intel (0x8086) 15:36:36 INFO - Device ID: 0x0a2e 15:36:36 INFO - Revision ID: 0x0009 15:36:36 INFO - Displays: 15:36:36 INFO - Display: 15:36:36 INFO - Resolution: 1600 x 1200 @ 60 Hz 15:36:36 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 15:36:36 INFO - Display Serial Number: 1600x1200 60 15:36:36 INFO - Main Display: Yes 15:36:36 INFO - Mirror: Off 15:36:36 INFO - Online: Yes 15:36:36 INFO - Rotation: Supported 15:36:36 INFO - Return code: 0 15:36:36 INFO - Running post-action listener: _resource_record_post_action 15:36:36 INFO - [mozharness: 2016-09-21 22:36:36.972851Z] Finished run-tests step (success) 15:36:36 INFO - Running post-run listener: _resource_record_post_run 15:36:37 INFO - Total resource usage - Wall time: 1211s; CPU: 54.0%; Read bytes: 614400; Write bytes: 707174400; Read time: 5; Write time: 1968 15:36:37 INFO - TinderboxPrint: CPU usage
53.5% 15:36:37 INFO - TinderboxPrint: I/O read bytes / time
614,400 / 5 15:36:37 INFO - TinderboxPrint: I/O write bytes / time
707,174,400 / 1,968 15:36:37 INFO - TinderboxPrint: CPU idle
2,252.6 (46.5%) 15:36:37 INFO - TinderboxPrint: CPU system
968.8 (20.0%) 15:36:37 INFO - TinderboxPrint: CPU user
1,624.4 (33.5%) 15:36:37 INFO - TinderboxPrint: Swap in / out
404,959,232 / 0 15:36:37 INFO - install - Wall time: 34s; CPU: 55.0%; Read bytes: 399649280; Write bytes: 396133888; Read time: 29813; Write time: 701 15:36:37 INFO - run-tests - Wall time: 1177s; CPU: 53.0%; Read bytes: 614400; Write bytes: 294756864; Read time: 5; Write time: 1222 15:36:37 INFO - Running post-run listener: _upload_blobber_files 15:36:37 INFO - Blob upload gear active. 15:36:37 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 15:36:37 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 15:36:37 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', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 15:36:37 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 Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 15:36:37 INFO - (blobuploader) - INFO - Open directory for files ... 15:36:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 15:36:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:36:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:36:38 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 15:36:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:36:38 INFO - (blobuploader) - INFO - Done attempting. 15:36:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 15:36:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:36:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:36:39 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 15:36:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:36:39 INFO - (blobuploader) - INFO - Done attempting. 15:36:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 15:36:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:36:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:36:41 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 15:36:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:36:41 INFO - (blobuploader) - INFO - Done attempting. 15:36:41 INFO - (blobuploader) - INFO - Iteration through files over. 15:36:41 INFO - Return code: 0 15:36:41 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 15:36:41 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 15:36:41 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/06dcb9fd09e88e43eb70f4b4c4b6acbcef8de204ecb34b118d1b27c6b358033f2fb13af85723decaab929cf4e20ab8a0a0a69382aac6422a4e4b07e3b3a0bea1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/cd194b653c296fe1adec1042da9c08ff1de343e4fd585a94ddef4af672ce667dcbee56e46995261f88b18b9ca29c458ad236b119ce53c85862d9341a7d470671", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b1de458252dddf6dff3325e4dedc0bd2e226f83884c356f0a3dd8956d886c3edf248fcb4839325ed3196b28d3beeed6ef57b86e5af0800cbfdc5b305e2bed7c0"} 15:36:41 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 15:36:41 INFO - Writing to file /builds/slave/test/properties/blobber_files 15:36:41 INFO - Contents: 15:36:41 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/06dcb9fd09e88e43eb70f4b4c4b6acbcef8de204ecb34b118d1b27c6b358033f2fb13af85723decaab929cf4e20ab8a0a0a69382aac6422a4e4b07e3b3a0bea1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/cd194b653c296fe1adec1042da9c08ff1de343e4fd585a94ddef4af672ce667dcbee56e46995261f88b18b9ca29c458ad236b119ce53c85862d9341a7d470671", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b1de458252dddf6dff3325e4dedc0bd2e226f83884c356f0a3dd8956d886c3edf248fcb4839325ed3196b28d3beeed6ef57b86e5af0800cbfdc5b305e2bed7c0"} 15:36:41 INFO - Running post-run listener: copy_logs_to_upload_dir 15:36:41 INFO - Copying logs to upload dir... 15:36:41 INFO - mkdir: /builds/slave/test/build/upload/logs 15:36:41 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1269.829740 ========= master_lag: 0.11 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 9 secs) (at 2016-09-21 15:36:41.869565) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-21 15:36:41.874183) ========= 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.e0yMzc6dfL/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.WqaBuSGBYq/Listeners TMPDIR=/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/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/Fx-Team/sha512/06dcb9fd09e88e43eb70f4b4c4b6acbcef8de204ecb34b118d1b27c6b358033f2fb13af85723decaab929cf4e20ab8a0a0a69382aac6422a4e4b07e3b3a0bea1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/cd194b653c296fe1adec1042da9c08ff1de343e4fd585a94ddef4af672ce667dcbee56e46995261f88b18b9ca29c458ad236b119ce53c85862d9341a7d470671", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b1de458252dddf6dff3325e4dedc0bd2e226f83884c356f0a3dd8956d886c3edf248fcb4839325ed3196b28d3beeed6ef57b86e5af0800cbfdc5b305e2bed7c0"} build_url:https://queue.taskcluster.net/v1/task/JKVMBgQHSSiutC1wtCFaIQ/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010721 build_url: 'https://queue.taskcluster.net/v1/task/JKVMBgQHSSiutC1wtCFaIQ/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/06dcb9fd09e88e43eb70f4b4c4b6acbcef8de204ecb34b118d1b27c6b358033f2fb13af85723decaab929cf4e20ab8a0a0a69382aac6422a4e4b07e3b3a0bea1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/cd194b653c296fe1adec1042da9c08ff1de343e4fd585a94ddef4af672ce667dcbee56e46995261f88b18b9ca29c458ad236b119ce53c85862d9341a7d470671", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b1de458252dddf6dff3325e4dedc0bd2e226f83884c356f0a3dd8956d886c3edf248fcb4839325ed3196b28d3beeed6ef57b86e5af0800cbfdc5b305e2bed7c0"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-21 15:36:41.911492) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 3 secs) (at 2016-09-21 15:36:41.911826) ========= 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.e0yMzc6dfL/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.WqaBuSGBYq/Listeners TMPDIR=/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/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.005332 ========= master_lag: 3.52 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 3 secs) (at 2016-09-21 15:36:45.439780) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-21 15:36:45.440192) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-21 15:36:45.444765) ========= ========= Total master_lag: 3.73 =========