builder: mozilla-beta_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0244 starttime: 1490112876.24 results: success (0) buildid: 20170321075929 builduid: b28f4fd7aca34ed3bd5ff4308e06797f revision: c2041273fcc493191a5358f39e7030a5b3278d9f ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-03-21 09:14:36.240090) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-03-21 09:14:36.240539) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-21 09:14:36.240830) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-21 09:14:36.268189) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-21 09:14:36.268447) ========= 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.p5WIUVMJeJ/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.Iodrzj126C/Listeners TMPDIR=/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/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 --2017-03-21 09:14:36-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 151M=0s 2017-03-21 09:14:36 (151 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.132244 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-21 09:14:36.435430) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-21 09:14:36.436202) ========= 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.p5WIUVMJeJ/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.Iodrzj126C/Listeners TMPDIR=/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/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.025163 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-21 09:14:36.487510) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-03-21 09:14:36.488006) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev c2041273fcc493191a5358f39e7030a5b3278d9f --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-beta --rev c2041273fcc493191a5358f39e7030a5b3278d9f --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.p5WIUVMJeJ/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.Iodrzj126C/Listeners TMPDIR=/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/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 2017-03-21 09:14:37,141 truncating revision to first 12 chars 2017-03-21 09:14:37,141 Setting DEBUG logging. 2017-03-21 09:14:37,141 attempt 1/10 2017-03-21 09:14:37,141 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/c2041273fcc4?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-03-21 09:14:38,924 unpacking tar archive at: mozilla-beta-c2041273fcc4/testing/mozharness/ program finished with exit code 0 elapsedTime=2.047645 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-03-21 09:14:38.562759) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-21 09:14:38.563489) ========= script_repo_revision: c2041273fcc493191a5358f39e7030a5b3278d9f ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-21 09:14:38.563933) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-21 09:14:38.564235) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-21 09:14:38.584766) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 20 mins, 53 secs) (at 2017-03-21 09:14:38.585467) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Beta', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.p5WIUVMJeJ/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.Iodrzj126C/Listeners TMPDIR=/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/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 09:14:39 INFO - MultiFileLogger online at 20170321 09:14:39 in /builds/slave/test 09:14:39 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 09:14:39 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:14:39 INFO - {'append_to_log': False, 09:14:39 INFO - 'base_work_dir': '/builds/slave/test', 09:14:39 INFO - 'blob_upload_branch': 'Mozilla-Beta', 09:14:39 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:14:39 INFO - 'branch': 'Mozilla-Beta', 09:14:39 INFO - 'buildbot_json_path': 'buildprops.json', 09:14:39 INFO - 'config_files': ('talos/mac_config.py',), 09:14:39 INFO - 'default_actions': ('clobber', 09:14:39 INFO - 'read-buildbot-config', 09:14:39 INFO - 'download-and-extract', 09:14:39 INFO - 'populate-webroot', 09:14:39 INFO - 'create-virtualenv', 09:14:39 INFO - 'install', 09:14:39 INFO - 'run-tests'), 09:14:39 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:14:39 INFO - 'download_minidump_stackwalk': True, 09:14:39 INFO - 'download_symbols': 'ondemand', 09:14:39 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:14:39 INFO - 'tooltool.py': '/tools/tooltool.py', 09:14:39 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:14:39 INFO - '/tools/misc-python/virtualenv.py')}, 09:14:39 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:14:39 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:14:39 INFO - 'installer_path': 'installer.exe', 09:14:39 INFO - 'log_level': 'info', 09:14:39 INFO - 'log_name': 'talos', 09:14:39 INFO - 'log_to_console': True, 09:14:39 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 09:14:39 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 09:14:39 INFO - 'opt_config_files': (), 09:14:39 INFO - 'pip_index': False, 09:14:39 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 09:14:39 INFO - 'cmd': ('bash', 09:14:39 INFO - '-c', 09:14:39 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 09:14:39 INFO - 'enabled': True, 09:14:39 INFO - 'halt_on_failure': False, 09:14:39 INFO - 'name': 'check_screen_resolution'},), 09:14:39 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 09:14:39 INFO - 'cmd': ('bash', 09:14:39 INFO - '-c', 09:14:39 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 09:14:39 INFO - 'enabled': True, 09:14:39 INFO - 'halt_on_failure': False, 09:14:39 INFO - 'name': 'check_screen_resolution'},), 09:14:39 INFO - 'run_cmd_checks_enabled': True, 09:14:39 INFO - 'sps_profile': False, 09:14:39 INFO - 'sps_profile_interval': 0, 09:14:39 INFO - 'suite': 'dromaeojs', 09:14:39 INFO - 'system_bits': '32', 09:14:39 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:14:39 INFO - 'title': 't-yosemite-r7-0244', 09:14:39 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:14:39 INFO - 'use_talos_json': True, 09:14:39 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:14:39 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:14:39 INFO - 'work_dir': 'build'} 09:14:39 INFO - [mozharness: 2017-03-21 16:14:39.347491Z] Running clobber step. 09:14:39 INFO - Running pre-action listener: _resource_record_pre_action 09:14:39 INFO - Running main action method: clobber 09:14:39 INFO - rmtree: /builds/slave/test/build 09:14:39 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:14:41 INFO - Running post-action listener: _resource_record_post_action 09:14:41 INFO - [mozharness: 2017-03-21 16:14:41.916949Z] Finished clobber step (success) 09:14:41 INFO - [mozharness: 2017-03-21 16:14:41.917073Z] Running read-buildbot-config step. 09:14:41 INFO - Running pre-action listener: _resource_record_pre_action 09:14:41 INFO - Running main action method: read_buildbot_config 09:14:41 INFO - Using buildbot properties: 09:14:41 INFO - { 09:14:41 INFO - "project": "", 09:14:41 INFO - "product": "firefox", 09:14:41 INFO - "script_repo_revision": "production", 09:14:41 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs", 09:14:41 INFO - "repository": "", 09:14:41 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs", 09:14:41 INFO - "buildid": "20170321075929", 09:14:41 INFO - "pgo_build": "False", 09:14:41 INFO - "basedir": "/builds/slave/test", 09:14:41 INFO - "buildnumber": 2, 09:14:41 INFO - "slavename": "t-yosemite-r7-0244", 09:14:41 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 09:14:41 INFO - "platform": "yosemite_r7", 09:14:41 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 09:14:41 INFO - "branch": "mozilla-beta", 09:14:41 INFO - "repo_path": "releases/mozilla-beta", 09:14:41 INFO - "revision": "c2041273fcc493191a5358f39e7030a5b3278d9f", 09:14:41 INFO - "stage_platform": "macosx64", 09:14:41 INFO - "builduid": "b28f4fd7aca34ed3bd5ff4308e06797f", 09:14:41 INFO - "slavebuilddir": "test" 09:14:41 INFO - } 09:14:41 INFO - Found installer url https://queue.taskcluster.net/v1/task/JtmctiQNQl6AaKwXy0sI1Q/artifacts/public/build/firefox-53.0.en-US.mac.dmg. 09:14:41 INFO - Running post-action listener: _resource_record_post_action 09:14:41 INFO - [mozharness: 2017-03-21 16:14:41.920400Z] Finished read-buildbot-config step (success) 09:14:41 INFO - [mozharness: 2017-03-21 16:14:41.920535Z] Running download-and-extract step. 09:14:41 INFO - Running pre-action listener: _resource_record_pre_action 09:14:41 INFO - Running main action method: download_and_extract 09:14:41 INFO - mkdir: /builds/slave/test/build/tests 09:14:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:14:41 INFO - trying https://queue.taskcluster.net/v1/task/JtmctiQNQl6AaKwXy0sI1Q/artifacts/public/build/firefox-53.0.en-US.mac.test_packages.json 09:14:41 INFO - Downloading https://queue.taskcluster.net/v1/task/JtmctiQNQl6AaKwXy0sI1Q/artifacts/public/build/firefox-53.0.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-53.0.en-US.mac.test_packages.json 09:14:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/JtmctiQNQl6AaKwXy0sI1Q/artifacts/public/build/firefox-53.0.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0.en-US.mac.test_packages.json'}, attempt #1 09:14:43 INFO - Downloaded 1165 bytes. 09:14:43 INFO - Reading from file /builds/slave/test/build/firefox-53.0.en-US.mac.test_packages.json 09:14:43 INFO - Using the following test package requirements: 09:14:43 INFO - {u'common': [u'firefox-53.0.en-US.mac.common.tests.zip'], 09:14:43 INFO - u'cppunittest': [u'firefox-53.0.en-US.mac.common.tests.zip', 09:14:43 INFO - u'firefox-53.0.en-US.mac.cppunittest.tests.zip'], 09:14:43 INFO - u'gtest': [u'firefox-53.0.en-US.mac.common.tests.zip', 09:14:43 INFO - u'firefox-53.0.en-US.mac.gtest.tests.zip'], 09:14:43 INFO - u'jittest': [u'firefox-53.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 09:14:43 INFO - u'mochitest': [u'firefox-53.0.en-US.mac.common.tests.zip', 09:14:43 INFO - u'firefox-53.0.en-US.mac.mochitest.tests.zip'], 09:14:43 INFO - u'mozbase': [u'firefox-53.0.en-US.mac.common.tests.zip'], 09:14:43 INFO - u'reftest': [u'firefox-53.0.en-US.mac.common.tests.zip', 09:14:43 INFO - u'firefox-53.0.en-US.mac.reftest.tests.zip'], 09:14:43 INFO - u'talos': [u'firefox-53.0.en-US.mac.common.tests.zip', 09:14:43 INFO - u'firefox-53.0.en-US.mac.talos.tests.zip'], 09:14:43 INFO - u'web-platform': [u'firefox-53.0.en-US.mac.common.tests.zip', 09:14:43 INFO - u'firefox-53.0.en-US.mac.web-platform.tests.zip'], 09:14:43 INFO - u'xpcshell': [u'firefox-53.0.en-US.mac.common.tests.zip', 09:14:43 INFO - u'firefox-53.0.en-US.mac.xpcshell.tests.zip']} 09:14:43 INFO - Downloading packages: [u'firefox-53.0.en-US.mac.common.tests.zip'] for test suite category: common 09:14:43 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/JtmctiQNQl6AaKwXy0sI1Q/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip 09:14:43 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/JtmctiQNQl6AaKwXy0sI1Q/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip'}, attempt #1 09:14:43 INFO - Fetch https://queue.taskcluster.net/v1/task/JtmctiQNQl6AaKwXy0sI1Q/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip into memory 09:14:44 INFO - Expected file size: 16108166 09:14:44 INFO - Obtained file size: 16108166 09:14:50 INFO - Downloading packages: [u'firefox-53.0.en-US.mac.common.tests.zip', u'firefox-53.0.en-US.mac.talos.tests.zip'] for test suite category: talos 09:14:50 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/JtmctiQNQl6AaKwXy0sI1Q/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip 09:14:50 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/JtmctiQNQl6AaKwXy0sI1Q/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip'}, attempt #1 09:14:50 INFO - Fetch https://queue.taskcluster.net/v1/task/JtmctiQNQl6AaKwXy0sI1Q/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip into memory 09:14:51 INFO - Expected file size: 16108166 09:14:51 INFO - Obtained file size: 16108166 09:14:57 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/JtmctiQNQl6AaKwXy0sI1Q/artifacts/public/build/firefox-53.0.en-US.mac.talos.tests.zip 09:14:57 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/JtmctiQNQl6AaKwXy0sI1Q/artifacts/public/build/firefox-53.0.en-US.mac.talos.tests.zip'}, attempt #1 09:14:57 INFO - Fetch https://queue.taskcluster.net/v1/task/JtmctiQNQl6AaKwXy0sI1Q/artifacts/public/build/firefox-53.0.en-US.mac.talos.tests.zip into memory 09:14:59 INFO - Expected file size: 14403663 09:14:59 INFO - Obtained file size: 14403663 09:14: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')]} 09:14:59 INFO - trying https://queue.taskcluster.net/v1/task/JtmctiQNQl6AaKwXy0sI1Q/artifacts/public/build/firefox-53.0.en-US.mac.dmg 09:14:59 INFO - Downloading https://queue.taskcluster.net/v1/task/JtmctiQNQl6AaKwXy0sI1Q/artifacts/public/build/firefox-53.0.en-US.mac.dmg to /builds/slave/test/build/firefox-53.0.en-US.mac.dmg 09:14:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/JtmctiQNQl6AaKwXy0sI1Q/artifacts/public/build/firefox-53.0.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-53.0.en-US.mac.dmg'}, attempt #1 09:15:01 INFO - Downloaded 58737629 bytes. 09:15:01 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/JtmctiQNQl6AaKwXy0sI1Q/artifacts/public/build/firefox-53.0.en-US.mac.dmg 09:15:01 INFO - mkdir: /builds/slave/test/properties 09:15:01 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:15:01 INFO - Writing to file /builds/slave/test/properties/build_url 09:15:01 INFO - Contents: 09:15:01 INFO - build_url:https://queue.taskcluster.net/v1/task/JtmctiQNQl6AaKwXy0sI1Q/artifacts/public/build/firefox-53.0.en-US.mac.dmg 09:15:01 INFO - Running post-action listener: _resource_record_post_action 09:15:01 INFO - Running post-action listener: set_extra_try_arguments 09:15:01 INFO - [mozharness: 2017-03-21 16:15:01.888034Z] Finished download-and-extract step (success) 09:15:01 INFO - [mozharness: 2017-03-21 16:15:01.888180Z] Running populate-webroot step. 09:15:01 INFO - Running pre-action listener: _resource_record_pre_action 09:15:01 INFO - Running main action method: populate_webroot 09:15:01 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:15:01 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:15:01 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:15:01 INFO - '--tppagecycles', 09:15:01 INFO - '7'], 09:15:01 INFO - 'tests': ['tsvgm']}}, 09:15:01 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 09:15:01 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:15:01 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:15:01 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:15:01 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:15:01 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:15:01 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 09:15:01 INFO - 'talos_options': ['--disable-e10s'], 09:15:01 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:15:01 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 09:15:01 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:15:01 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 09:15:01 INFO - 'talos_options': ['--disable-e10s'], 09:15:01 INFO - 'tests': ['damp', 'tps']}, 09:15:01 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 09:15:01 INFO - 'tests': ['damp', 'tps']}, 09:15:01 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:15:01 INFO - 'tests': ['dromaeo_dom']}, 09:15:01 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:15:01 INFO - 'g4': {'talos_options': ['--disable-e10s'], 09:15:01 INFO - 'tests': ['basic_compositor_video']}, 09:15:01 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 09:15:01 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:15:01 INFO - 'tests': ['a11yr', 09:15:01 INFO - 'ts_paint', 09:15:01 INFO - 'tpaint', 09:15:01 INFO - 'sessionrestore', 09:15:01 INFO - 'sessionrestore_no_auto_restore', 09:15:01 INFO - 'tabpaint']}, 09:15:01 INFO - 'other-e10s': {'tests': ['a11yr', 09:15:01 INFO - 'ts_paint', 09:15:01 INFO - 'tpaint', 09:15:01 INFO - 'sessionrestore', 09:15:01 INFO - 'sessionrestore_no_auto_restore', 09:15:01 INFO - 'tabpaint']}, 09:15:01 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:15:01 INFO - 'ts_paint', 09:15:01 INFO - 'tpaint', 09:15:01 INFO - 'sessionrestore', 09:15:01 INFO - 'sessionrestore_no_auto_restore', 09:15:01 INFO - 'tabpaint']}, 09:15:01 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:15:01 INFO - 'ts_paint', 09:15:01 INFO - 'tpaint', 09:15:01 INFO - 'sessionrestore', 09:15:01 INFO - 'sessionrestore_no_auto_restore', 09:15:01 INFO - 'tabpaint']}, 09:15:01 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:15:01 INFO - 'tests': ['a11yr', 09:15:01 INFO - 'ts_paint', 09:15:01 INFO - 'tpaint', 09:15:01 INFO - 'sessionrestore', 09:15:01 INFO - 'sessionrestore_no_auto_restore', 09:15:01 INFO - 'tabpaint']}, 09:15:01 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:15:01 INFO - 'tests': ['a11yr', 09:15:01 INFO - 'ts_paint', 09:15:01 INFO - 'tpaint', 09:15:01 INFO - 'sessionrestore', 09:15:01 INFO - 'sessionrestore_no_auto_restore', 09:15:01 INFO - 'tabpaint']}, 09:15:01 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:15:01 INFO - 'tests': ['tsvgx', 09:15:01 INFO - 'tsvgr_opacity', 09:15:01 INFO - 'tart', 09:15:01 INFO - 'tscrollx', 09:15:01 INFO - 'cart', 09:15:01 INFO - 'tsvg_static']}, 09:15:01 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:15:01 INFO - 'tsvgr_opacity', 09:15:01 INFO - 'tart', 09:15:01 INFO - 'tscrollx', 09:15:01 INFO - 'cart', 09:15:01 INFO - 'tsvg_static']}, 09:15:01 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 09:15:01 INFO - 'talos_options': ['--disable-e10s'], 09:15:01 INFO - 'tests': ['tp5o']}, 09:15:01 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 09:15:01 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 09:15:01 INFO - 'talos_options': ['--disable-e10s', 09:15:01 INFO - '--xperf_path', 09:15:01 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:15:01 INFO - 'tests': ['tp5n']}, 09:15:01 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 09:15:01 INFO - 'talos_options': ['--xperf_path', 09:15:01 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:15:01 INFO - 'tests': ['tp5n']}}, 09:15:01 INFO - 'talos.zip': {'path': '', 09:15:01 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:15:01 INFO - Running post-action listener: _resource_record_post_action 09:15:01 INFO - [mozharness: 2017-03-21 16:15:01.906599Z] Finished populate-webroot step (success) 09:15:01 INFO - [mozharness: 2017-03-21 16:15:01.906703Z] Running create-virtualenv step. 09:15:01 INFO - Running pre-action listener: _resource_record_pre_action 09:15:01 INFO - Running main action method: create_virtualenv 09:15:01 INFO - Creating virtualenv /builds/slave/test/build/venv 09:15:01 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 09:15:01 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:15:02 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:15:02 INFO - Using real prefix '/tools/python27' 09:15:02 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:15:02 INFO - Installing distribute.............................................................................................................................................................................................done. 09:15:05 INFO - Installing pip.................done. 09:15:05 INFO - Return code: 0 09:15:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 09:15:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 09:15:06 INFO - Reading from file tmpfile_stdout 09:15:06 INFO - Output received: 09:15:06 INFO - pip 1.5.5 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 09:15:06 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:15: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')]} 09:15:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:15:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:15: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')]} 09:15:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:15:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:15: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x108e38b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108e3b768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8141c6d020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108c16d30>, '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 0x108b3ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108c0bbe8>, '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.p5WIUVMJeJ/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.Iodrzj126C/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/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 09:15: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', 'pip>=1.5'] in /builds/slave/test/build 09:15: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 pip>=1.5 09:15:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.p5WIUVMJeJ/Render', 09:15:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:15:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:15:06 INFO - 'HOME': '/Users/cltbld', 09:15:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:15:06 INFO - 'LOGNAME': 'cltbld', 09:15:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:15:06 INFO - 'MOZ_NO_REMOTE': '1', 09:15:06 INFO - 'NO_EM_RESTART': '1', 09:15:06 INFO - 'PAGER': '/bin/cat', 09:15:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:15:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:15:06 INFO - 'PWD': '/builds/slave/test', 09:15:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:15:06 INFO - 'SHELL': '/bin/bash', 09:15:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Iodrzj126C/Listeners', 09:15:06 INFO - 'TMPDIR': '/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/', 09:15:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:15:06 INFO - 'USER': 'cltbld', 09:15:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:15:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:15:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:15:06 INFO - 'XPC_FLAGS': '0x0', 09:15:06 INFO - 'XPC_SERVICE_NAME': '0', 09:15:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:15:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:15:06 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 09:15:06 INFO - Cleaning up... 09:15:06 INFO - Return code: 0 09:15:06 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 09:15: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')]} 09:15:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:15:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:15: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')]} 09:15:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:15:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:15: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', '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 0x108e38b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108e3b768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8141c6d020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108c16d30>, '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 0x108b3ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108c0bbe8>, '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.p5WIUVMJeJ/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.Iodrzj126C/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/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 09:15: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', 'psutil>=3.1.1'] in /builds/slave/test/build 09:15: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 psutil>=3.1.1 09:15:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.p5WIUVMJeJ/Render', 09:15:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:15:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:15:06 INFO - 'HOME': '/Users/cltbld', 09:15:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:15:06 INFO - 'LOGNAME': 'cltbld', 09:15:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:15:06 INFO - 'MOZ_NO_REMOTE': '1', 09:15:06 INFO - 'NO_EM_RESTART': '1', 09:15:06 INFO - 'PAGER': '/bin/cat', 09:15:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:15:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:15:06 INFO - 'PWD': '/builds/slave/test', 09:15:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:15:06 INFO - 'SHELL': '/bin/bash', 09:15:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Iodrzj126C/Listeners', 09:15:06 INFO - 'TMPDIR': '/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/', 09:15:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:15:06 INFO - 'USER': 'cltbld', 09:15:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:15:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:15:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:15:06 INFO - 'XPC_FLAGS': '0x0', 09:15:06 INFO - 'XPC_SERVICE_NAME': '0', 09:15:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:15:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:15:06 INFO - Downloading/unpacking psutil>=3.1.1 09:15: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 09:15: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 09:15: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 09:15: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 09:15: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 09:15: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 09:15:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:15:10 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:15:10 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:15:10 INFO - Installing collected packages: psutil 09:15:10 INFO - Running setup.py install for psutil 09:15:10 INFO - building 'psutil._psutil_osx' extension 09:15:10 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 09:15:11 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 09:15:11 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 09:15:11 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 09:15:11 INFO - building 'psutil._psutil_posix' extension 09:15:11 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 09:15:11 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 09:15:11 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 09:15:11 INFO - ^ 09:15:11 INFO - 1 warning generated. 09:15:11 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 09:15:11 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:15:11 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:15:11 INFO - Successfully installed psutil 09:15:11 INFO - Cleaning up... 09:15:11 INFO - Return code: 0 09:15:11 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 09:15:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:15:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:15:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:15:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:15:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:15:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:15:11 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 0x108e38b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108e3b768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8141c6d020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108c16d30>, '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 0x108b3ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108c0bbe8>, '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.p5WIUVMJeJ/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.Iodrzj126C/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/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 09:15:11 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 09:15:11 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 09:15:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.p5WIUVMJeJ/Render', 09:15:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:15:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:15:11 INFO - 'HOME': '/Users/cltbld', 09:15:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:15:11 INFO - 'LOGNAME': 'cltbld', 09:15:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:15:11 INFO - 'MOZ_NO_REMOTE': '1', 09:15:11 INFO - 'NO_EM_RESTART': '1', 09:15:11 INFO - 'PAGER': '/bin/cat', 09:15:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:15:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:15:11 INFO - 'PWD': '/builds/slave/test', 09:15:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:15:11 INFO - 'SHELL': '/bin/bash', 09:15:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Iodrzj126C/Listeners', 09:15:11 INFO - 'TMPDIR': '/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/', 09:15:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:15:11 INFO - 'USER': 'cltbld', 09:15:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:15:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:15:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:15:11 INFO - 'XPC_FLAGS': '0x0', 09:15:11 INFO - 'XPC_SERVICE_NAME': '0', 09:15:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:15:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:15:11 INFO - Downloading/unpacking mozsystemmonitor==0.3 09:15:11 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 09:15:11 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 09:15:11 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 09:15:11 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 09:15:11 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 09:15:11 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 09:15:14 INFO - Downloading mozsystemmonitor-0.3.tar.gz 09:15:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:15:14 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 09:15:14 INFO - Installing collected packages: mozsystemmonitor 09:15:14 INFO - Running setup.py install for mozsystemmonitor 09:15:14 INFO - Successfully installed mozsystemmonitor 09:15:14 INFO - Cleaning up... 09:15:14 INFO - Return code: 0 09:15:14 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 09:15: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')]} 09:15:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:15:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:15: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')]} 09:15:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:15:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:15:14 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 0x108e38b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108e3b768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8141c6d020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108c16d30>, '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 0x108b3ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108c0bbe8>, '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.p5WIUVMJeJ/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.Iodrzj126C/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/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 09:15:14 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 09:15:14 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 09:15:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.p5WIUVMJeJ/Render', 09:15:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:15:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:15:14 INFO - 'HOME': '/Users/cltbld', 09:15:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:15:14 INFO - 'LOGNAME': 'cltbld', 09:15:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:15:14 INFO - 'MOZ_NO_REMOTE': '1', 09:15:14 INFO - 'NO_EM_RESTART': '1', 09:15:14 INFO - 'PAGER': '/bin/cat', 09:15:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:15:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:15:14 INFO - 'PWD': '/builds/slave/test', 09:15:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:15:14 INFO - 'SHELL': '/bin/bash', 09:15:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Iodrzj126C/Listeners', 09:15:14 INFO - 'TMPDIR': '/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/', 09:15:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:15:14 INFO - 'USER': 'cltbld', 09:15:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:15:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:15:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:15:14 INFO - 'XPC_FLAGS': '0x0', 09:15:14 INFO - 'XPC_SERVICE_NAME': '0', 09:15:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:15:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:15:15 INFO - Downloading/unpacking jsonschema==2.5.1 09:15:15 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 09:15:15 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 09:15:15 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 09:15:15 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 09:15:15 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 09:15:15 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 09:15:17 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:15:17 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 09:15:17 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 09:15:17 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 09:15:17 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 09:15:17 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 09:15:17 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 09:15:17 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 09:15:18 INFO - Downloading functools32-3.2.3-2.tar.gz 09:15:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:15:18 INFO - warning: no files found matching '*.txt' 09:15:18 INFO - no previously-included directories found matching 'build' 09:15:18 INFO - no previously-included directories found matching 'dist' 09:15:18 INFO - no previously-included directories found matching '.git*' 09:15:18 INFO - Installing collected packages: jsonschema, functools32 09:15:18 INFO - Running setup.py install for functools32 09:15:18 INFO - warning: no files found matching '*.txt' 09:15:18 INFO - no previously-included directories found matching 'build' 09:15:18 INFO - no previously-included directories found matching 'dist' 09:15:18 INFO - no previously-included directories found matching '.git*' 09:15:18 INFO - Successfully installed jsonschema functools32 09:15:18 INFO - Cleaning up... 09:15:18 INFO - Return code: 0 09:15:18 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 09:15:18 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')]} 09:15:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:15:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:15:18 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')]} 09:15:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:15:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:15:18 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 0x108e38b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108e3b768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8141c6d020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108c16d30>, '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 0x108b3ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108c0bbe8>, '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.p5WIUVMJeJ/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.Iodrzj126C/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/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 09:15:18 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 09:15:18 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 09:15:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.p5WIUVMJeJ/Render', 09:15:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:15:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:15:18 INFO - 'HOME': '/Users/cltbld', 09:15:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:15:18 INFO - 'LOGNAME': 'cltbld', 09:15:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:15:18 INFO - 'MOZ_NO_REMOTE': '1', 09:15:18 INFO - 'NO_EM_RESTART': '1', 09:15:18 INFO - 'PAGER': '/bin/cat', 09:15:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:15:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:15:18 INFO - 'PWD': '/builds/slave/test', 09:15:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:15:18 INFO - 'SHELL': '/bin/bash', 09:15:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Iodrzj126C/Listeners', 09:15:18 INFO - 'TMPDIR': '/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/', 09:15:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:15:18 INFO - 'USER': 'cltbld', 09:15:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:15:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:15:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:15:18 INFO - 'XPC_FLAGS': '0x0', 09:15:18 INFO - 'XPC_SERVICE_NAME': '0', 09:15:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:15:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:15:18 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 09:15:18 INFO - Cleaning up... 09:15:18 INFO - Return code: 0 09:15:18 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:15:18 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')]} 09:15:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:15:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:15:18 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')]} 09:15:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:15:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:15:18 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 0x108e38b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108e3b768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8141c6d020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108c16d30>, '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 0x108b3ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108c0bbe8>, '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.p5WIUVMJeJ/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.Iodrzj126C/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/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 09:15:18 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 09:15:18 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 09:15:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.p5WIUVMJeJ/Render', 09:15:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:15:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:15:18 INFO - 'HOME': '/Users/cltbld', 09:15:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:15:18 INFO - 'LOGNAME': 'cltbld', 09:15:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:15:18 INFO - 'MOZ_NO_REMOTE': '1', 09:15:18 INFO - 'NO_EM_RESTART': '1', 09:15:18 INFO - 'PAGER': '/bin/cat', 09:15:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:15:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:15:18 INFO - 'PWD': '/builds/slave/test', 09:15:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:15:18 INFO - 'SHELL': '/bin/bash', 09:15:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Iodrzj126C/Listeners', 09:15:18 INFO - 'TMPDIR': '/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/', 09:15:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:15:18 INFO - 'USER': 'cltbld', 09:15:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:15:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:15:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:15:18 INFO - 'XPC_FLAGS': '0x0', 09:15:18 INFO - 'XPC_SERVICE_NAME': '0', 09:15:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:15:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:15:19 INFO - Downloading/unpacking blobuploader==1.2.4 09:15:19 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 09:15:19 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 09:15:19 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 09:15:19 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 09:15:19 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 09:15:19 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 09:15:21 INFO - Downloading blobuploader-1.2.4.tar.gz 09:15:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:15:21 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:15: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 09:15: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 09:15: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 09:15: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 09:15: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 09:15: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 09:15:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:15:22 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:15:22 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 09:15:22 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 09:15:22 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 09:15:22 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 09:15:22 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 09:15:22 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 09:15:22 INFO - Downloading docopt-0.6.1.tar.gz 09:15:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:15:23 INFO - Installing collected packages: blobuploader, requests, docopt 09:15:23 INFO - Running setup.py install for blobuploader 09:15:23 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:15:23 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:15:23 INFO - Running setup.py install for requests 09:15:23 INFO - Running setup.py install for docopt 09:15:23 INFO - Successfully installed blobuploader requests docopt 09:15:23 INFO - Cleaning up... 09:15:23 INFO - Return code: 0 09:15:23 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:15:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:15:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:15:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:15:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:15:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:15:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:15:23 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 0x108e38b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108e3b768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8141c6d020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108c16d30>, '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 0x108b3ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108c0bbe8>, '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.p5WIUVMJeJ/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.Iodrzj126C/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/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 09:15:23 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 09:15:23 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 09:15:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.p5WIUVMJeJ/Render', 09:15:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:15:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:15:23 INFO - 'HOME': '/Users/cltbld', 09:15:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:15:23 INFO - 'LOGNAME': 'cltbld', 09:15:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:15:23 INFO - 'MOZ_NO_REMOTE': '1', 09:15:23 INFO - 'NO_EM_RESTART': '1', 09:15:23 INFO - 'PAGER': '/bin/cat', 09:15:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:15:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:15:23 INFO - 'PWD': '/builds/slave/test', 09:15:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:15:23 INFO - 'SHELL': '/bin/bash', 09:15:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Iodrzj126C/Listeners', 09:15:23 INFO - 'TMPDIR': '/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/', 09:15:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:15:23 INFO - 'USER': 'cltbld', 09:15:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:15:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:15:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:15:23 INFO - 'XPC_FLAGS': '0x0', 09:15:23 INFO - 'XPC_SERVICE_NAME': '0', 09:15:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:15:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:15:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:15:24 INFO - Running setup.py (path:/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/pip-VQvI4A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:15:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:15:24 INFO - Running setup.py (path:/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/pip-WVaRIJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:15:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:15:24 INFO - Running setup.py (path:/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/pip-SXRr7f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:15:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:15:24 INFO - Running setup.py (path:/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/pip-QCsCSm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:15:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:15:24 INFO - Running setup.py (path:/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/pip-vSML9w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:15:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:15:24 INFO - Running setup.py (path:/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/pip-aRZHeG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:15:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:15:24 INFO - Running setup.py (path:/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/pip-ZS9_0m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:15:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:15:24 INFO - Running setup.py (path:/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/pip-7d71T8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:15:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:15:25 INFO - Running setup.py (path:/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/pip-uF2fcK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:15:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:15:25 INFO - Running setup.py (path:/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/pip-tgLCpq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:15:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:15:25 INFO - Running setup.py (path:/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/pip-FAnVvZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:15:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:15:25 INFO - Running setup.py (path:/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/pip-b10mLP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:15:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:15:25 INFO - Running setup.py (path:/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/pip-ZXsQ5m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:15:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:15:25 INFO - Running setup.py (path:/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/pip-_OI7eM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:15:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:15:25 INFO - Running setup.py (path:/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/pip-pynOnN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:15:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:15:25 INFO - Running setup.py (path:/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/pip-Q68yhp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:15:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:15:25 INFO - Running setup.py (path:/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/pip-V5YcQC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:15:26 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:15:26 INFO - Running setup.py install for manifestparser 09:15:26 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:15:26 INFO - Running setup.py install for mozcrash 09:15:26 INFO - Running setup.py install for mozdebug 09:15:26 INFO - Running setup.py install for mozdevice 09:15:26 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:15:26 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:15:26 INFO - Running setup.py install for mozfile 09:15:26 INFO - Running setup.py install for mozhttpd 09:15:26 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:15:26 INFO - Running setup.py install for mozinfo 09:15:27 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:15:27 INFO - Running setup.py install for mozInstall 09:15:27 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:15:27 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:15:27 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:15:27 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:15:27 INFO - Running setup.py install for mozleak 09:15:27 INFO - Running setup.py install for mozlog 09:15:27 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:15:27 INFO - Running setup.py install for moznetwork 09:15:27 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:15:27 INFO - Running setup.py install for mozprocess 09:15:27 INFO - Running setup.py install for mozprofile 09:15:27 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:15:27 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:15:27 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:15:27 INFO - Running setup.py install for mozrunner 09:15:28 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:15:28 INFO - Running setup.py install for mozscreenshot 09:15:28 INFO - Running setup.py install for moztest 09:15:28 INFO - Running setup.py install for mozversion 09:15:28 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:15:28 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:15:28 INFO - Cleaning up... 09:15:28 INFO - Return code: 0 09:15:28 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:15:28 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')]} 09:15:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:15:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:15:28 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')]} 09:15:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:15:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:15:28 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 0x108e38b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108e3b768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8141c6d020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108c16d30>, '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 0x108b3ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108c0bbe8>, '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.p5WIUVMJeJ/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.Iodrzj126C/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/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 09:15:28 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 09:15:28 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 09:15:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.p5WIUVMJeJ/Render', 09:15:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:15:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:15:28 INFO - 'HOME': '/Users/cltbld', 09:15:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:15:28 INFO - 'LOGNAME': 'cltbld', 09:15:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:15:28 INFO - 'MOZ_NO_REMOTE': '1', 09:15:28 INFO - 'NO_EM_RESTART': '1', 09:15:28 INFO - 'PAGER': '/bin/cat', 09:15:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:15:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:15:28 INFO - 'PWD': '/builds/slave/test', 09:15:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:15:28 INFO - 'SHELL': '/bin/bash', 09:15:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Iodrzj126C/Listeners', 09:15:28 INFO - 'TMPDIR': '/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/', 09:15:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:15:28 INFO - 'USER': 'cltbld', 09:15:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:15:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:15:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:15:28 INFO - 'XPC_FLAGS': '0x0', 09:15:28 INFO - 'XPC_SERVICE_NAME': '0', 09:15:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:15:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:15:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:15:28 INFO - Running setup.py (path:/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/pip-a0kyiV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:15:28 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)) 09:15:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:15:28 INFO - Running setup.py (path:/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/pip-mCKgn9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:15:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 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)) 09:15:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:15:29 INFO - Running setup.py (path:/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/pip-AFY6LL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:15:29 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)) 09:15:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:15:29 INFO - Running setup.py (path:/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/pip-JtwlWP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:15:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 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)) 09:15:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:15:29 INFO - Running setup.py (path:/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/pip-LcVkx2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:15:29 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)) 09:15:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:15:29 INFO - Running setup.py (path:/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/pip-kDsqM4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:15:29 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)) 09:15:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:15:29 INFO - Running setup.py (path:/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/pip-d9cOOY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:15:29 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)) 09:15:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:15:29 INFO - Running setup.py (path:/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/pip-242wLI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:15:29 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)) 09:15:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:15:29 INFO - Running setup.py (path:/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/pip-lYtIRi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:15:29 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)) 09:15:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:15:29 INFO - Running setup.py (path:/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/pip-2CQN02-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:15:29 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)) 09:15:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:15:29 INFO - Running setup.py (path:/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/pip-zFZIlV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:15:30 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)) 09:15:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:15:30 INFO - Running setup.py (path:/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/pip-MuQlzO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:15:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.24 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)) 09:15:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:15:30 INFO - Running setup.py (path:/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/pip-YDAjYC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:15:30 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)) 09:15:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:15:30 INFO - Running setup.py (path:/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/pip-qmRxev-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:15:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 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)) 09:15:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:15:30 INFO - Running setup.py (path:/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/pip-7c6LQc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:15:30 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)) 09:15:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:15:30 INFO - Running setup.py (path:/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/pip-MiUF7_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:15:30 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 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)) 09:15:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:15:30 INFO - Running setup.py (path:/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/pip-o4g8s3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:15:30 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)) 09:15:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:15:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:15:30 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)) 09:15:30 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.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:15:30 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.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:15:30 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:15:30 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 09:15:30 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 09:15:30 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 09:15:30 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 09:15:30 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 09:15:30 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 09:15:33 INFO - Downloading blessings-1.6.tar.gz 09:15:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:15:33 INFO - Installing collected packages: blessings 09:15:33 INFO - Running setup.py install for blessings 09:15:33 INFO - Successfully installed blessings 09:15:33 INFO - Cleaning up... 09:15:33 INFO - Return code: 0 09:15:33 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:15:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:15:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:15:33 INFO - Reading from file tmpfile_stdout 09:15:33 INFO - Current package versions: 09:15:33 INFO - blessings == 1.6 09:15:33 INFO - blobuploader == 1.2.4 09:15:33 INFO - docopt == 0.6.1 09:15:33 INFO - functools32 == 3.2.3-2 09:15:33 INFO - jsonschema == 2.5.1 09:15:33 INFO - manifestparser == 1.1 09:15:33 INFO - mozInstall == 1.12 09:15:33 INFO - mozcrash == 1.0 09:15:33 INFO - mozdebug == 0.1 09:15:33 INFO - mozdevice == 0.49 09:15:33 INFO - mozfile == 1.2 09:15:33 INFO - mozhttpd == 0.7 09:15:33 INFO - mozinfo == 0.9 09:15:33 INFO - mozleak == 0.1 09:15:33 INFO - mozlog == 3.4 09:15:33 INFO - moznetwork == 0.27 09:15:33 INFO - mozprocess == 0.24 09:15:33 INFO - mozprofile == 0.28 09:15:33 INFO - mozrunner == 6.13 09:15:33 INFO - mozscreenshot == 0.1 09:15:33 INFO - mozsystemmonitor == 0.3 09:15:33 INFO - moztest == 0.8 09:15:33 INFO - mozversion == 1.4 09:15:33 INFO - psutil == 3.1.1 09:15:33 INFO - requests == 1.2.3 09:15:33 INFO - wsgiref == 0.1.2 09:15:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:15:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:15:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:15:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:15:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:15:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:15:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:15:34 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 0x108e38b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108e3b768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8141c6d020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108c16d30>, '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 0x108b3ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108c0bbe8>, '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.p5WIUVMJeJ/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.Iodrzj126C/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/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 09:15:34 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 09:15:34 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 09:15:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.p5WIUVMJeJ/Render', 09:15:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:15:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:15:34 INFO - 'HOME': '/Users/cltbld', 09:15:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:15:34 INFO - 'LOGNAME': 'cltbld', 09:15:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:15:34 INFO - 'MOZ_NO_REMOTE': '1', 09:15:34 INFO - 'NO_EM_RESTART': '1', 09:15:34 INFO - 'PAGER': '/bin/cat', 09:15:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:15:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:15:34 INFO - 'PWD': '/builds/slave/test', 09:15:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:15:34 INFO - 'SHELL': '/bin/bash', 09:15:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Iodrzj126C/Listeners', 09:15:34 INFO - 'TMPDIR': '/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/', 09:15:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:15:34 INFO - 'USER': 'cltbld', 09:15:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:15:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:15:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:15:34 INFO - 'XPC_FLAGS': '0x0', 09:15:34 INFO - 'XPC_SERVICE_NAME': '0', 09:15:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:15:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:15:35 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)) 09:15:35 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)) 09:15:35 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)) 09:15:35 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)) 09:15:35 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)) 09:15:35 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)) 09:15:35 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)) 09:15:35 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)) 09:15:35 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)) 09:15:35 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)) 09:15:35 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)) 09:15:35 INFO - Cleaning up... 09:15:35 INFO - Return code: 0 09:15:35 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:15:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:15:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:15:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:15:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:15:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:15:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:15:35 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x108e38b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108e3b768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8141c6d020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108c16d30>, '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 0x108b3ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108c0bbe8>, '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.p5WIUVMJeJ/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.Iodrzj126C/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/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 09:15:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 09:15:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 09:15:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.p5WIUVMJeJ/Render', 09:15:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:15:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:15:35 INFO - 'HOME': '/Users/cltbld', 09:15:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:15:35 INFO - 'LOGNAME': 'cltbld', 09:15:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:15:35 INFO - 'MOZ_NO_REMOTE': '1', 09:15:35 INFO - 'NO_EM_RESTART': '1', 09:15:35 INFO - 'PAGER': '/bin/cat', 09:15:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:15:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:15:35 INFO - 'PWD': '/builds/slave/test', 09:15:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:15:35 INFO - 'SHELL': '/bin/bash', 09:15:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Iodrzj126C/Listeners', 09:15:35 INFO - 'TMPDIR': '/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/', 09:15:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:15:35 INFO - 'USER': 'cltbld', 09:15:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:15:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:15:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:15:35 INFO - 'XPC_FLAGS': '0x0', 09:15:35 INFO - 'XPC_SERVICE_NAME': '0', 09:15:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:15:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:15:35 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 09:15:35 INFO - Cleaning up... 09:15:35 INFO - Return code: 0 09:15:35 INFO - Running post-action listener: _resource_record_post_action 09:15:35 INFO - Running post-action listener: _start_resource_monitoring 09:15:35 INFO - Starting resource monitoring. 09:15:35 INFO - [mozharness: 2017-03-21 16:15:35.738905Z] Finished create-virtualenv step (success) 09:15:35 INFO - [mozharness: 2017-03-21 16:15:35.739810Z] Running install step. 09:15:35 INFO - Running pre-action listener: _resource_record_pre_action 09:15:35 INFO - Running main action method: install 09:15:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:15:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:15:36 INFO - Reading from file tmpfile_stdout 09:15:36 INFO - Detecting whether we're running mozinstall >=1.0... 09:15:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:15:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:15:36 INFO - Reading from file tmpfile_stdout 09:15:36 INFO - Output received: 09:15:36 INFO - Usage: mozinstall [options] installer 09:15:36 INFO - Options: 09:15:36 INFO - -h, --help show this help message and exit 09:15:36 INFO - -d DEST, --destination=DEST 09:15:36 INFO - Directory to install application into. [default: 09:15:36 INFO - "/builds/slave/test"] 09:15:36 INFO - --app=APP Application being installed. [default: firefox] 09:15:36 INFO - mkdir: /builds/slave/test/build/application 09:15:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 09:15:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0.en-US.mac.dmg --destination /builds/slave/test/build/application 09:15:50 INFO - Reading from file tmpfile_stdout 09:15:50 INFO - Output received: 09:15:50 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 09:15:50 INFO - Running post-action listener: _resource_record_post_action 09:15:50 INFO - [mozharness: 2017-03-21 16:15:50.849074Z] Finished install step (success) 09:15:50 INFO - [mozharness: 2017-03-21 16:15:50.849206Z] Running run-tests step. 09:15:50 INFO - Running pre-action listener: _resource_record_pre_action 09:15:50 INFO - Running main action method: run_tests 09:15:50 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 09:15:50 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 09:15:50 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 09:15:50 INFO - 2017-03-21 09:15:50.864 screenresolution[1624:7299] starting screenresolution argv=screenresolution get 09:15:50 INFO - 2017-03-21 09:15:50.866 screenresolution[1624:7299] Display 0: 1600x1200x32@60 09:15:50 INFO - 2017-03-21 09:15:50.872 screenresolution[1625:7301] starting screenresolution argv=screenresolution list 09:15:50 INFO - Available Modes on Display 0 09:15:50 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 09:15:50 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 09:15:50 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 09:15:50 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 09:15:51 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 09:15:51 INFO - Intel Iris: 09:15:51 INFO - Chipset Model: Intel Iris 09:15:51 INFO - Type: GPU 09:15:51 INFO - Bus: Built-In 09:15:51 INFO - VRAM (Dynamic, Max): 1536 MB 09:15:51 INFO - Vendor: Intel (0x8086) 09:15:51 INFO - Device ID: 0x0a2e 09:15:51 INFO - Revision ID: 0x0009 09:15:51 INFO - Displays: 09:15:51 INFO - Display: 09:15:51 INFO - Resolution: 1600 x 1200 @ 60 Hz 09:15:51 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 09:15:51 INFO - Display Serial Number: 1600x1200 60 09:15:51 INFO - Main Display: Yes 09:15:51 INFO - Mirror: Off 09:15:51 INFO - Online: Yes 09:15:51 INFO - Rotation: Supported 09:15:51 INFO - Return code: 0 09:15:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:15:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:15:51 INFO - Python 2.7.3 09:15:51 INFO - Return code: 0 09:15:51 INFO - grabbing minidump binary from tooltool 09: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')]} 09:15:51 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 0x108c16d30>, '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 0x108b3ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108c0bbe8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:15:51 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 09:15:51 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 09:15:51 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 09:15:51 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:15:51 INFO - Return code: 0 09:15:51 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 09:15:51 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:15:51 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:15:51 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 09:15:51 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:15:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/JtmctiQNQl6AaKwXy0sI1Q/artifacts/public/build/firefox-53.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0244', '--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 09:15:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs --executablePath /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/JtmctiQNQl6AaKwXy0sI1Q/artifacts/public/build/firefox-53.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0244 --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 09:15:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.p5WIUVMJeJ/Render', 09:15:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:15:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:15:51 INFO - 'HOME': '/Users/cltbld', 09:15:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:15:51 INFO - 'LOGNAME': 'cltbld', 09:15:51 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:15:51 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 09:15:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:15:51 INFO - 'MOZ_NO_REMOTE': '1', 09:15:51 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:15:51 INFO - 'NO_EM_RESTART': '1', 09:15:51 INFO - 'PAGER': '/bin/cat', 09:15:51 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:15:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:15:51 INFO - 'PWD': '/builds/slave/test', 09:15:51 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:15:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:15:51 INFO - 'SHELL': '/bin/bash', 09:15:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Iodrzj126C/Listeners', 09:15:51 INFO - 'TMPDIR': '/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/', 09:15:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:15:51 INFO - 'USER': 'cltbld', 09:15:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:15:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:15:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:15:51 INFO - 'XPC_FLAGS': '0x0', 09:15:51 INFO - 'XPC_SERVICE_NAME': '0', 09:15:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:15:51 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/JtmctiQNQl6AaKwXy0sI1Q/artifacts/public/build/firefox-53.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0244', '--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 09:15:51 INFO - mozversion application_buildid: 20170321075929 09:15:51 INFO - mozversion application_changeset: c2041273fcc493191a5358f39e7030a5b3278d9f 09:15:51 INFO - mozversion application_display_name: Firefox 09:15:51 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:15:51 INFO - mozversion application_name: Firefox 09:15:51 INFO - mozversion application_remotingname: firefox 09:15:51 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 09:15:51 INFO - mozversion application_vendor: Mozilla 09:15:51 INFO - mozversion application_version: 53.0 09:15:51 INFO - mozversion platform_buildid: 20170321075929 09:15:51 INFO - mozversion platform_changeset: c2041273fcc493191a5358f39e7030a5b3278d9f 09:15:51 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 09:15:51 INFO - mozversion platform_version: 53.0 09:15:51 INFO - using testdate: 1490112951 09:15:51 INFO - actual date: 1490112951 09:15:51 INFO - starting webserver on 'localhost:49245' 09:15:51 INFO - SUITE-START | Running 2 tests 09:15:51 INFO - TEST-START | dromaeo_css 09:15:51 INFO - operating with platform_type : mac_ 09:15:51 INFO - Initialising browser for dromaeo_css test... 09:15:51 INFO - TEST-INFO | started process 1635 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/tmpxjgxgD/profile http://localhost:49245/getInfo.html) 09:15:53 INFO - PROCESS | 1635 | __metrics Screen width/height:1600/1200 09:15:53 INFO - PROCESS | 1635 | colorDepth:24 09:15:53 INFO - PROCESS | 1635 | Browser inner width/height: 1024/689 09:15:53 INFO - PROCESS | 1635 | __metrics 09:15:53 INFO - PROCESS | 1635 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 09:15:53 INFO - PROCESS | 1635 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:15:54 INFO - TEST-INFO | 1635: exit 0 09:15:54 INFO - Browser initialized. 09:15:54 INFO - Running cycle 1/1 for dromaeo_css test... 09:15:54 INFO - TEST-INFO | started process 1638 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/tmpxjgxgD/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:16:06 INFO - PROCESS | 1638 | RSS: Main: 167718912 09:16:06 INFO - PROCESS | 1638 | 09:19:09 INFO - PROCESS | 1638 | Cycle 1(1): loaded http://localhost:49245/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49245/tests/dromaeo/cssquery-ext.html) 09:19:10 INFO - PROCESS | 1638 | RSS: Main: 318967808 09:19:10 INFO - PROCESS | 1638 | 09:22:13 INFO - PROCESS | 1638 | Cycle 1(1): loaded http://localhost:49245/tests/dromaeo/cssquery-ext.html (next: http://localhost:49245/tests/dromaeo/cssquery-jquery.html) 09:22:14 INFO - PROCESS | 1638 | RSS: Main: 307834880 09:22:14 INFO - PROCESS | 1638 | 09:25:16 INFO - PROCESS | 1638 | Cycle 1(1): loaded http://localhost:49245/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49245/tests/dromaeo/cssquery-mootools.html) 09:25:17 INFO - PROCESS | 1638 | RSS: Main: 279298048 09:25:17 INFO - PROCESS | 1638 | 09:28:19 INFO - PROCESS | 1638 | Cycle 1(1): loaded http://localhost:49245/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49245/tests/dromaeo/cssquery-prototype.html) 09:28:20 INFO - PROCESS | 1638 | RSS: Main: 285716480 09:28:20 INFO - PROCESS | 1638 | 09:31:23 INFO - PROCESS | 1638 | Cycle 1(1): loaded http://localhost:49245/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49245/tests/dromaeo/cssquery-yui.html) 09:31:24 INFO - PROCESS | 1638 | RSS: Main: 268681216 09:31:24 INFO - PROCESS | 1638 | 09:34:27 INFO - PROCESS | 1638 | Cycle 1(1): loaded http://localhost:49245/tests/dromaeo/cssquery-yui.html (next: http://localhost:49245/tests/dromaeo/cssquery-dojo.html) 09:34:27 INFO - PROCESS | 1638 | RSS: Main: 383533056 09:34:27 INFO - PROCESS | 1638 | 09:34:27 INFO - PROCESS | 1638 | __start_tp_report 09:34:27 INFO - PROCESS | 1638 | _x_x_mozilla_page_load 09:34:27 INFO - PROCESS | 1638 | _x_x_mozilla_page_load_details 09:34:27 INFO - PROCESS | 1638 | |i|pagename|runs| 09:34:27 INFO - PROCESS | 1638 | |0;dojo.html;3435.347284016036;3439.1574064354236;3449.741269404792;3452.413089774738;3490.2670439207764;5753.884922301562;5856.47291743743;5866.911996320058;5883.352831188571;5903.439173278537;5855.677937713424;5918.4081591840795;5924.200232968548;5933.970330148354;5949.375315591866;5249.1601343784905;5284.497972692588;5338.252644629755;5355.357357117151;5378.596605254602;5097.770600322994;5255.264263003182;5303.496167864047;5386.461353864622;5400.054990376688;5288.92066619001;5295.20571914214;5302.337207849019;5329.094054010828;5333.733313334337;5336.573074154077;5361.222622719683;5362.168863826113;5362.651427657229;5366.892662146754;5188.325517682715;5218.425973142951;5285.101532739443;5290.470952904717;5338.946610533883;5731.770729170828;5763.654180749127;5790.623609465413;5794.88410231793;5799.739011744482;6272.466840318579;6321.715522801485;6331.176946996861;6337.207849018872;6338.239411270631;6232.096346029845;6263.467605253559;6273.780417685405;6277.183966084425;6279.058141278799;5861.706914654335;5900.822975310747;5947.197128387699;5962.34414214436;5984.940150598525;6287.591306565058;6297.338779428185;6337.366263373626;6349.650769207646;6359.236891573041;6290.55966082379;6299.842503937347;6301.842453938597;6314.431701146918;6329.968350158219;6321.367863213642;6321.431071203614;6324.873502529924;6325.65208913505;6342.334054924258;6191.442770150618;6222.12890195373;6224.813255602339;6282.4974002079725;6283.120363149072;6295.055741638791;6295.37046295376;6300.558960872695;6329.145565348619;6333.46165575922;5064.949350506521;5070.771815268322;5075.365579302587;5086.745662716849;5106;4505.81976720934;4521.4574251089425;4525.456945166601;4538.228501154812;4556.635469162459;5926.407359264039;5950.940490595039;6009.519238461;6014.8195554133445;6020.066889632114;6268.0054122334595;6288.308286088527;6300.590461620071;6301.212348456443;6315.40003699657;4731.621470282369;5790.623609465371;5920.111983202554;5985.661835940806;5998.580099393001;5427.267318911896;5483.232347471358;5494.5054945055135;5502.58730595207;5560.777568897199;6361.9045714314325;6374.26695929974;6396.968015159894;6406.13517175194;6407.199100112486;5085;6219.689015549114;6250.281217659845;6251.78118765841;6260.436560709558;6214.8135555933395;6251.843703907439;6298.968505157445;6363.363663633785;6373.235211774617;6220.813375598739;6256.906146407717;6301.054841773771;6323.715432805443;6349.0476428536085;4902.607791376753;5232.947670523246;5237.502437268454;5275.393329767126;6295.905561416674;6118.284172697687;6208.410201030895;6234.719437625408;6274.6548939808745;6306.495480361652;5101.260317253903;6124.136831511461;6161.568690191643;6254;6273;5121.7695203715175;6162.630242185483;6181.938180618136;6183.628982261079;6191.19514463117;6074.605150665193;6265.404786545271;6272.027835685293;6285.622862628257;6300.464460520907;6056.152138700673;6107.389261073857;6128.808691620048;6132.816015519542;6169.876602468015 09:34:27 INFO - PROCESS | 1638 | |1;ext.html;471.6604045087537;531.6252042310169;531.9867003324914;534.4794060896747;549.6564647095565;32455.188620284476;33182.66817331826;34578.82710586447;42289.36565951505;44213.7789311053;45129.54870451295;45429.77285113578;45569.7721511392;45645.087098258016;45782;9526.190273826716;9733.929267780539;9734;9745.463999480025;9747.56135973883;9029.367944243906;9230.16928476437;9237.399569028024;9322.161005509503;9590.328676992613;7734.535927844319;11768.117391195652;12023.338716370596;12024.7595048099;12206.206596571194;11736.589219377367;11811.291322520634;11914.642560723149;11917.22538035025;11931.1051671125;11883.94058029713;11949.163558550905;11954.342511161884;11958.222715523463;11959.94020029903;42121.78939105316;42529.36205956913;42545;42626;42652.3602145968;4064.248114098901;4092.3043082676018;4144.48193975753;4149.398337241113;4196.328587425997;30500.69499305023;30850.845745771352;31998.20004499883;32192.468702457125;32446.188845278823;3265.151060724205;3340.2317466982486;3483.390406678821;3520.7887526748223;3523.489094081344;431053;460165;461686;463819;463994;63658.68170659117;63915.68042159759;65804.34195658079;66075.67848643;66279.66860165668;58896.11655825166;59126.40873591295;59273.110903336485;59385.812283754945;59397.70301148553;17271.65456690859;17872.731909021375;17907.73138402925;17909.552261193574;17913.10434478271;13578.932105339607;13601.727965440636;13640.454381824815;13659.521916732867;13660.65848353799;15625.296861641253;15943.123128228059;16845.989240645602;17426.21582028812;17495.825041749675;6842.7605033823575;7061.187963384174;7113.253108423644;7153.749618763422;7199.812031014929;882.8499155143512;912.926965842731;915.7207051849117;935.1443429262284;954.1317401164906;30927.84536077305;31249;32155;32279.870204543196;32328;902.3953950852945;1088.6733979806027;1099.3568762273999;1119.7200699825044;1125.8966213111196;14254.429822807178;14886.925565372321;14984.18490277931;15027.699446011018;15210.619734506727;529587;532218;533479;534012;534693;48376;49174.262386064234;55260.89478210413;55330.72334638301;56272;1467.486379767073;1487.300968544804;1500.309857465578;1510.546835949233;1515.3181068519211;22315.888420557792;28747.712522874503;30674.392676622738;30708.385832283675;31194.532082018333;48771.75614121907;55129;56460.74157033673;56628.433715662315;58490;590914;597679;627774;635016;644176;24552.386190345384;25153.365031272908;25410.364740881625;25869.353266168495;25883.611745824204;41426.585734142274;43775;43869.34195986999;43949.12101758011;44033;32793.50809737904;34840.30319393649;35588.82205589059;36140;37950.051248719006;36111.27777444489;36161.45757813688;37082.814585927976;37248.255034899696;37400;35341.46987795237;35385.938421847386;36279.63720362762;36438.81780591186;36719.449208261365;29775.851120744257;31814;32272.677273226967;32278.19304517406;32290.83854580712;24114.87942560276;24198.516029678955;24350.391240219134;24676.753232467447;24714 09:34:27 INFO - PROCESS | 1638 | |2;jquery.html;396.37175077502155;403.2076968756394;403.94142849286874;411.4856429463171;428.92064967980923;17594.82405175951;20582.794172058275;20929.267475638335;21840.126394944222;21974.01116949737;22023.559528809456;22233.666495002588;22470.438239044033;22532;22847.42881427965;5763.452472015162;6072.848178795522;6076;6082.1180928765525;6082.847928801793;5764.077747560391;5981.282246130449;5983.790567330145;6030.909536356936;6045.637261764286;5969.88060238795;5981.252343457068;5987.610805297663;5990.820275391745;5997.040473524237;5687.431256874321;5896.292444906596;5939.910901336483;5945.554083443716;5947.583669143161;5237.764300606482;5245.186996015624;5245.344331958505;5246.895062098737;5247.842564723026;26416.471670566672;26728;26799;26875.865620671968;27066.594001089998;2738.1785464360614;2762.654668166479;2779.777617790572;2809.9016534421403;2822.9435411291865;15791.447299344467;15824.44614438489;15871;15948.441804536786;16193.433229837017;1839.1447976690904;1843.6589230992308;1850.8796928199624;1851.787044489874;1863.363296215145;124140;125926.37036814849;129283;131800.6819931798;131861;9731.783527059117;11015.504302306415;11712.590059347882;11743.47154378055;11957.760844783055;12021.038316934624;14289.071210371292;14980.1011939284;14987.550373488813;14995.625109372135;8721.127887211229;8969.775755606162;8999.37004409685;9116.8632470513;9127.315451341043;8991;9010.098990100938;9020.81958360829;9025.954870225738;9205.03347148553;7132.643367831588;7270.382017528464;7270.781876543712;7283.745068922668;7288.12542494904;1793.650238203564;1902.3531999120366;1943.1637102937589;1969.5470041890446;1969.881807091579;737.8782500887294;788.909275433321;806.5241507510597;808.5068108453838;855.8844555984987;20242.89878550598;20677.438348918782;23554.411139721644;23632.7636723634;23682.81585920697;836.0510820219096;850.2645211891669;896.1128482801979;906.71891713569;917.4403613795579;11991.400429978466;12165.14843960932;12403.565875194505;12463.189892656948;12470.43883025266;790729;794067;797650;798259;811120;103758;117085.41457292659;156367;157861;158324.20837895738;1119.205364191433;1137.9487923043482;1171;1179.1569028144918;1185.519864454897;19944.50138746543;20229.19083236654;20758.58482830365;20817;20847;51772.482275176764;58954;62008.689956549926;62659.6867015662;63175;88711;91240.54379728324;93940;94465;96688;6569.343065693392;8336.87494687568;8523.786905327417;8758.167974042455;8904.86642700373;11734.295942243492;12518.687032824253;13183.40674669623;13317.334133293103;13391.330433478091;11033.834492482458;11125.388103654053;11373.090152787592;11703.531858725897;11727.706807329885;9829.557669904729;11276.154288428237;11323.716907077389;11379.658610241706;11905.583304584297;11537.884621154017;11598.18812683138;11673.241239319417;11777.352245626573;12046.638600841989;7684.272083410532;7853.096893857051;8269.131741167092;8550.358723095917;8615.8707619387;10501.31741436804;11039.834402483808;11532.88467115318;11721.472533735832;11882.524699011943 09:34:27 INFO - PROCESS | 1638 | |3;mootools.html;1466.2668665667165;1469.7574900141476;1483.0360265827214;1487.3158347160306;1493.3503925792281;8100.189981001904;8532.744017679464;8551.957240213791;8562.186592273732;8565.357598180139;7522.96238518808;7766.184550622188;7774.183710710378;8162.591870406485;8336.208060234283;2378.417287764496;2413.5293617744546;2424.612062070069;2429.307647320514;2429.3197904586655;2303.216906251874;2330.207729372013;2339.8479098858606;2340.8946597403155;2347.295811256625;2381.0475809676095;2386.844855084414;2401.5557121932497;2411.1199412214505;2415.2271273192587;2364.704411948515;2376.2039716694926;2376.4652953085592;2399.3281881073326;2401.6637670726113;2359.7876191142877;2365.219477572397;2420.5642984262827;2422.6002709552904;2427.1990243219693;8385.538795366252;8484.66061357545;8485.321174306102;8499.787505312355;8505.064442911274;5174.016936782037;5321.920171197435;5334.893302133935;5337.11937530307;5340;3511.5929508466966;3564.465330200465;3576.946345804815;3602.2435288589427;3647.76289541179;1222.2666400159922;1225.91418600698;1260.8802163794426;1273.6624794429483;1281.1608396500308;9149;10882.40146791926;10939.781204375948;10954.287971281841;10964.56141754321;4414.911701766011;4705.835295764632;4777.092352453093;4789.161896668069;4795.976020119947;9535;9543.141117299476;9552.761180970392;9553.331266811396;9561.569729362196;5352.090144675414;5354.330708661418;5356.946430535722;5358.356997160287;5375.973120134374;4128.339465685476;4351.434313539283;4457.175422546774;4828.7102773833685;4931.802727890916;3833.099221682902;3876.9418458723144;3944.092858642471;3976.8608098716404;3979.1245925896837;1073.4686330266568;1103.4813637590319;1289.7807372746656;1303.074816880007;1308.5027689478127;815.502543448496;895.5477483870734;915.3455279475207;924.6902287733684;927.4759760735163;5377.300950876439;5740.655560666373;5770.07678771403;5873.530117590582;5959.880802384015;995.8307087795092;1002.674130907458;1016.8779746430475;1018.1549314069305;1089.4988305379613;3710.703143748494;3750.6061863504483;3877.3408520551575;3881.049142959993;3883.9029024274055;9750.75623109428;10046.648367307109;10133.240006999356;10142.645007424851;10150.949245253727;9559.522023898777;9997.80004399908;10086.142677872316;10101.090901818725;10115.544800483996;6932.064171336805;7840.255175758294;7964.920350796418;8026.357891368676;8049.195080491904;5515.558755299647;5557.694326811902;5590.720463976703;5798.82603521895;5890.381509941566;9119.407238529475;9300.581473833829;9429.481378523973;9490.28822838276;9507.144357007903;9212.953935230282;9474.668386606436;9593.856092158763;9757.658481953098;9772.80454390894;7140.178879428724;7262.310080542551;7315.012473316247;7362.6686799093095;7376.96311518439;7914.485558438683;7922.881156782768;8004.039515257973;8012.559309238048;8015.118336983044;7179.605121718356;7225.855482890418;7287.307705767944;7301;7388.963055184905;7048.788536343918;7138.785836424916;7145.535540189871;7176.641167941478;7204.171520275236;6387.648679322682;6463.418292353711;6505.902411463927;6519.380658837403;6537.28089910119;4894;4947.727874966768;5023.7488125592845;5029.641996660808;5158.948410515847;4992.101421744121;5020.974895125501;5084.872878178076;5127.256547800623;5132.43543210254 09:34:27 INFO - PROCESS | 1638 | |4;prototype.html;365.7403243696975;371.78436506826046;377.1984532867655;387.268063360249;387.7421514692729;5208.531232189098;5293.364796224459;5454;5464.426235245297;5483.698396588186;4534.97732511337;5354.330708661418;5379.5427388671915;5424.376196737377;5494.911933465288;4174.872784348224;4237.749863790189;4312.74930270222;4314.4391229140165;4340.435743353375;3931.9606803932024;4106.753594784308;4325.653947684178;4331.787099612114;4352.847650332239;4095.692823038269;4115.794210289489;4119.814608342616;4121.26906699187;4160.521540022906;4083.183363327332;4093.6111069448502;4136.710430269883;4143.295639741251;4153.086321009373;3577.2130131371055;3579.8568057277676;3583.5486627915734;3598.355208921441;3600.3519366514015;4853.757312134379;5062.8608563073385;5306.8407947761625;5310.150375939831;5366.275552800361;3991.44119823225;4777.474477807438;4777.498362671939;4784.186688263004;4796.424429068499;5166.793328266865;5435.483629055233;5683.976884160849;5756.0214763489885;5792.82621521355;3522.4892390603477;3914.15845593196;3956.6834653227675;3970.602939706035;3974.960250397488;4867.70793752376;5764.16419619157;6035.517158627299;6063.242094738158;6091.390860913917;4005.7796821175116;4017.678585713136;4035.2938235808615;4046.1705350403095;4047.8785636430366;3413.4026545354463;3827.4641550182996;3845.7115716321387;4070.776107314126;4078.5317285777096;4727.881802954954;4735.857924262277;4739.559127049572;4746;4779.856604301807;5846.473817356373;5850.502707269845;5863.3257175424515;5869.501092407193;5957.672328022;1076.967690969272;1077.6120596585224;1140.3329052504212;1239.9708242159168;1248.3945286536023;746.7380127584365;753.7851712261979;793.2701914238914;798.6446031515919;893.8525143351275;4684.695494792828;5018.591076283405;5043.2687260347775;5097.923531147036;5134.640575159703;4622.306654001859;4692.507286734912;5322.308099947059;5591.384947655754;5593.188987596775;4217.936730949038;4270;4442.335073564323;4960.677555958851;5106.66806657566;2587.728288529715;2696.6089916961932;2753.7796976241852;2947.820871651357;3005.3989202159655;5078.923816142761;5205.713685747321;5274.97362513185;5847.736851841677;5858.443447872531;4449.7997590108525;5174.767135478913;5549.334079910436;5568.693721845257;5804.303483581997;4896.143174944371;5412.918806217988;6197.690115494207;6209.472194863487;6218;5183.766730497061;5800.171886554854;5825.533957283492;5980.611260268069;6046.637201767908;5177.990291893045;5222.869428264324;5873.471387575139;5894.970525147518;5938.584299099021;5682.886342273214;6171.475424588781;6179.443850053517;6186.597371445597;6238.532110091671;3660.7986560739414;3713.313037088147;4016.6987475938836;4035.7085732565297;4060.654844338146;5173.482651734947;5368.73834648865;5656.660600363992;5977.252843394575;6014.428629280212;4579.633629309581;4896.404905400143;5571.860703482445;5668.461496157858;5718.714064296852;5088.923666144937;5804.82585522435;5823.272090988627;5826.941730582809;5835.824925252249;5433.8369848904595;5592.273004509388;5687.857803554944;5708.288562932574;5748.378521531408;5133.635351058228;5769.249997500298;5779.942200577941;5783.277090363705;5824.310949824503;4495.775211239359;5641.605087643826;5687.004774164422;5722.513586345207;5765.365809761007 09:34:27 INFO - PROCESS | 1638 | |5;yui.html;742.7029188324666;753.58929383486;789.6525528767341;856.4347530629784;866.190112245051;15247.847521524782;15455.45905893294;15999.520014399572;16043.037417754913;16085.034897906135;14713.926430367834;14721.26393680317;14807.703845923075;14845.925770371134;14874.628134296649;723.1611330856208;743.9293267139614;747.1370566995103;889.230815344727;905.597009330848;885.2696525366566;911.3028533172129;916.5463095767572;916.9174774270315;917.321182325078;965.4062751407904;984;984.1831280037587;985.3792110970114;987.8666380038675;975.7267964969819;976.9560369783342;978.1929907826072;979.4025644356936;979.6130528441297;728.1735230513352;729.3180875881068;729.719058162606;730.747891977267;731.8646050480678;15824.208789560476;16057.277422516016;16121.27454264561;16183.83816161835;16415.753763693556;15079;15365.308561114665;15375.154366509838;15393.307301171475;15436.151011694352;11638.767224655545;11845.5854045108;11930.522779088826;12229.449674764657;12336.198147120409;3771.0949372150762;3834.654881060718;3956.6636835868985;4016.136530645896;4071.42999980003;107164.46417767939;109532;113173.99999999917;113337;116909;11024.779504410028;11632.360220187802;11717.355545444912;11785.233959792586;12367.62897113088;20918.58162836735;21304.934753262274;22309.77690223077;25033.87483062573;25457.490850182894;8269.338452923752;8335.458195217292;8372.958135209285;8483.533405662625;8540.530270835165;3839.404892241707;4468.821247150077;4501.414816073955;4537.802532657279;4621.861344159681;3803.4294855771304;3877.0307423144213;3894.337962546374;3896.4155376693725;3900.687944964396;716.4483347822148;719.2986837833071;720.2797202797203;732.6886073418775;735.6211551051213;697.8848489999194;711.1643818513227;730.1603156370217;739.9677449957279;781.3124450483651;10545.9472702636;10736.838947415796;10764.925928498453;11078.446077696244;11256;550.3615459616178;658.9292399850243;664.5281849886538;706.1420374245214;706.8868980963124;5124.897502049938;5225.634205605647;5276.630635855453;5278.551323137576;5280.313559237351;112370;113976.43011784888;114224.21702581365;114537.4273128629;116136.6772664542;83305.16694833095;91436;99553;102362.48818756007;104228.47885760674;82651.5867420659;85424.6868087703;86358.56820715856;88192;89275.9999999987;9899.65351212704;10230.976902309709;10237.283390162616;10262.486875656337;10267.229957753048;56661;56748.148777769195;57130;57683.4231657678;59396;61023;75688.86466702893;76729.61635192012;78916.68666506551;80238;11761.117916156494;11870.228435151688;11880;11890.940545297219;12064.215825971283;12815.487380504675;13045.608631741063;13205.471781129032;13933.372998214902;14198.503052393116;11684.240524365889;12135.878641213829;12144.089193310714;12366.938165309115;12394.3183124929;11915.702107447036;12313.815292770794;12329.938350308192;12439.253644781342;12859.421326040538;10451.425171615634;11855.466504007169;12114.273143611412;12220.694482638006;12434.253944763343;10289.485525723534;10353.275270730977;10429.26995110335;10723.785524289626;11269.985701286923;10241.897581024094;10325.63860264887;10344.896551034393;10359;10400.739981500523 09:34:27 INFO - PROCESS | 1638 | __end_tp_report 09:34:27 INFO - PROCESS | 1638 | __start_cc_report 09:34:27 INFO - PROCESS | 1638 | _x_x_mozilla_cycle_collect,1639 09:34:27 INFO - PROCESS | 1638 | __end_cc_report 09:34:27 INFO - PROCESS | 1638 | __startTimestamp1490114067383__endTimestamp 09:34:27 INFO - PROCESS | 1638 | 09:34:27 INFO - PROCESS | 1638 | ------- Summary: start ------- 09:34:27 INFO - PROCESS | 1638 | Number of tests: 6 09:34:27 INFO - PROCESS | 1638 | 09:34:27 INFO - PROCESS | 1638 | [#0] dojo.html Cycles:165 Average:5804.79 Median:6056.15 stddev:646.70 (10.7%) stddev-sans-first:621.39 09:34:27 INFO - PROCESS | 1638 | Values: 3435.3 3439.2 3449.7 3452.4 3490.3 5753.9 5856.5 5866.9 5883.4 5903.4 5855.7 5918.4 5924.2 5934.0 5949.4 5249.2 5284.5 5338.3 5355.4 5378.6 5097.8 5255.3 5303.5 5386.5 5400.1 5288.9 5295.2 5302.3 5329.1 5333.7 5336.6 5361.2 5362.2 5362.7 5366.9 5188.3 5218.4 5285.1 5290.5 5338.9 5731.8 5763.7 5790.6 5794.9 5799.7 6272.5 6321.7 6331.2 6337.2 6338.2 6232.1 6263.5 6273.8 6277.2 6279.1 5861.7 5900.8 5947.2 5962.3 5984.9 6287.6 6297.3 6337.4 6349.7 6359.2 6290.6 6299.8 6301.8 6314.4 6330.0 6321.4 6321.4 6324.9 6325.7 6342.3 6191.4 6222.1 6224.8 6282.5 6283.1 6295.1 6295.4 6300.6 6329.1 6333.5 5064.9 5070.8 5075.4 5086.7 5106.0 4505.8 4521.5 4525.5 4538.2 4556.6 5926.4 5950.9 6009.5 6014.8 6020.1 6268.0 6288.3 6300.6 6301.2 6315.4 4731.6 5790.6 5920.1 5985.7 5998.6 5427.3 5483.2 5494.5 5502.6 5560.8 6361.9 6374.3 6397.0 6406.1 6407.2 5085.0 6219.7 6250.3 6251.8 6260.4 6214.8 6251.8 6299.0 6363.4 6373.2 6220.8 6256.9 6301.1 6323.7 6349.0 4902.6 5232.9 5237.5 5275.4 6295.9 6118.3 6208.4 6234.7 6274.7 6306.5 5101.3 6124.1 6161.6 6254.0 6273.0 5121.8 6162.6 6181.9 6183.6 6191.2 6074.6 6265.4 6272.0 6285.6 6300.5 6056.2 6107.4 6128.8 6132.8 6169.9 09:34:27 INFO - PROCESS | 1638 | 09:34:27 INFO - PROCESS | 1638 | [#1] ext.html Cycles:180 Average:67404.20 Median:36579.13 stddev:144136.15 (394.0%) stddev-sans-first:144452.88 09:34:27 INFO - PROCESS | 1638 | Values: 471.7 531.6 532.0 534.5 549.7 32455.2 33182.7 34578.8 42289.4 44213.8 45129.5 45429.8 45569.8 45645.1 45782.0 9526.2 9733.9 9734.0 9745.5 9747.6 9029.4 9230.2 9237.4 9322.2 9590.3 7734.5 11768.1 12023.3 12024.8 12206.2 11736.6 11811.3 11914.6 11917.2 11931.1 11883.9 11949.2 11954.3 11958.2 11959.9 42121.8 42529.4 42545.0 42626.0 42652.4 4064.2 4092.3 4144.5 4149.4 4196.3 30500.7 30850.8 31998.2 32192.5 32446.2 3265.2 3340.2 3483.4 3520.8 3523.5 431053.0 460165.0 461686.0 463819.0 463994.0 63658.7 63915.7 65804.3 66075.7 66279.7 58896.1 59126.4 59273.1 59385.8 59397.7 17271.7 17872.7 17907.7 17909.6 17913.1 13578.9 13601.7 13640.5 13659.5 13660.7 15625.3 15943.1 16846.0 17426.2 17495.8 6842.8 7061.2 7113.3 7153.7 7199.8 882.8 912.9 915.7 935.1 954.1 30927.8 31249.0 32155.0 32279.9 32328.0 902.4 1088.7 1099.4 1119.7 1125.9 14254.4 14886.9 14984.2 15027.7 15210.6 529587.0 532218.0 533479.0 534012.0 534693.0 48376.0 49174.3 55260.9 55330.7 56272.0 1467.5 1487.3 1500.3 1510.5 1515.3 22315.9 28747.7 30674.4 30708.4 31194.5 48771.8 55129.0 56460.7 56628.4 58490.0 590914.0 597679.0 627774.0 635016.0 644176.0 24552.4 25153.4 25410.4 25869.4 25883.6 41426.6 43775.0 43869.3 43949.1 44033.0 32793.5 34840.3 35588.8 36140.0 37950.1 36111.3 36161.5 37082.8 37248.3 37400.0 35341.5 35385.9 36279.6 36438.8 36719.4 29775.9 31814.0 32272.7 32278.2 32290.8 24114.9 24198.5 24350.4 24676.8 24714.0 09:34:27 INFO - PROCESS | 1638 | 09:34:27 INFO - PROCESS | 1638 | [#2] jquery.html Cycles:180 Average:42326.49 Median:26837.43 stddev:132239.20 (492.7%) stddev-sans-first:132572.69 09:34:27 INFO - PROCESS | 1638 | Values: 396.4 403.2 403.9 411.5 428.9 17594.8 20582.8 20929.3 21840.1 21974.0 22023.6 22233.7 22470.4 22532.0 22847.4 5763.5 6072.8 6076.0 6082.1 6082.8 5764.1 5981.3 5983.8 6030.9 6045.6 5969.9 5981.3 5987.6 5990.8 5997.0 5687.4 5896.3 5939.9 5945.6 5947.6 5237.8 5245.2 5245.3 5246.9 5247.8 26416.5 26728.0 26799.0 26875.9 27066.6 2738.2 2762.7 2779.8 2809.9 2822.9 15791.4 15824.4 15871.0 15948.4 16193.4 1839.1 1843.7 1850.9 1851.8 1863.4 124140.0 125926.4 129283.0 131800.7 131861.0 9731.8 11015.5 11712.6 11743.5 11957.8 12021.0 14289.1 14980.1 14987.6 14995.6 8721.1 8969.8 8999.4 9116.9 9127.3 8991.0 9010.1 9020.8 9026.0 9205.0 7132.6 7270.4 7270.8 7283.7 7288.1 1793.7 1902.4 1943.2 1969.5 1969.9 737.9 788.9 806.5 808.5 855.9 20242.9 20677.4 23554.4 23632.8 23682.8 836.1 850.3 896.1 906.7 917.4 11991.4 12165.1 12403.6 12463.2 12470.4 790729.0 794067.0 797650.0 798259.0 811120.0 103758.0 117085.4 156367.0 157861.0 158324.2 1119.2 1137.9 1171.0 1179.2 1185.5 19944.5 20229.2 20758.6 20817.0 20847.0 51772.5 58954.0 62008.7 62659.7 63175.0 88711.0 91240.5 93940.0 94465.0 96688.0 6569.3 8336.9 8523.8 8758.2 8904.9 11734.3 12518.7 13183.4 13317.3 13391.3 11033.8 11125.4 11373.1 11703.5 11727.7 9829.6 11276.2 11323.7 11379.7 11905.6 11537.9 11598.2 11673.2 11777.4 12046.6 7684.3 7853.1 8269.1 8550.4 8615.9 10501.3 11039.8 11532.9 11721.5 11882.5 09:34:27 INFO - PROCESS | 1638 | 09:34:27 INFO - PROCESS | 1638 | [#3] mootools.html Cycles:180 Average:5510.23 Median:5247.97 stddev:2959.66 (56.4%) stddev-sans-first:2952.35 09:34:27 INFO - PROCESS | 1638 | Values: 1466.3 1469.8 1483.0 1487.3 1493.4 8100.2 8532.7 8552.0 8562.2 8565.4 7523.0 7766.2 7774.2 8162.6 8336.2 2378.4 2413.5 2424.6 2429.3 2429.3 2303.2 2330.2 2339.8 2340.9 2347.3 2381.0 2386.8 2401.6 2411.1 2415.2 2364.7 2376.2 2376.5 2399.3 2401.7 2359.8 2365.2 2420.6 2422.6 2427.2 8385.5 8484.7 8485.3 8499.8 8505.1 5174.0 5321.9 5334.9 5337.1 5340.0 3511.6 3564.5 3576.9 3602.2 3647.8 1222.3 1225.9 1260.9 1273.7 1281.2 9149.0 10882.4 10939.8 10954.3 10964.6 4414.9 4705.8 4777.1 4789.2 4796.0 9535.0 9543.1 9552.8 9553.3 9561.6 5352.1 5354.3 5356.9 5358.4 5376.0 4128.3 4351.4 4457.2 4828.7 4931.8 3833.1 3876.9 3944.1 3976.9 3979.1 1073.5 1103.5 1289.8 1303.1 1308.5 815.5 895.5 915.3 924.7 927.5 5377.3 5740.7 5770.1 5873.5 5959.9 995.8 1002.7 1016.9 1018.2 1089.5 3710.7 3750.6 3877.3 3881.0 3883.9 9750.8 10046.6 10133.2 10142.6 10150.9 9559.5 9997.8 10086.1 10101.1 10115.5 6932.1 7840.3 7964.9 8026.4 8049.2 5515.6 5557.7 5590.7 5798.8 5890.4 9119.4 9300.6 9429.5 9490.3 9507.1 9213.0 9474.7 9593.9 9757.7 9772.8 7140.2 7262.3 7315.0 7362.7 7377.0 7914.5 7922.9 8004.0 8012.6 8015.1 7179.6 7225.9 7287.3 7301.0 7389.0 7048.8 7138.8 7145.5 7176.6 7204.2 6387.6 6463.4 6505.9 6519.4 6537.3 4894.0 4947.7 5023.7 5029.6 5158.9 4992.1 5021.0 5084.9 5127.3 5132.4 09:34:27 INFO - PROCESS | 1638 | 09:34:27 INFO - PROCESS | 1638 | [#4] prototype.html Cycles:180 Average:4600.43 Median:5102.30 stddev:1422.24 (27.9%) stddev-sans-first:1390.26 09:34:27 INFO - PROCESS | 1638 | Values: 365.7 371.8 377.2 387.3 387.7 5208.5 5293.4 5454.0 5464.4 5483.7 4535.0 5354.3 5379.5 5424.4 5494.9 4174.9 4237.7 4312.7 4314.4 4340.4 3932.0 4106.8 4325.7 4331.8 4352.8 4095.7 4115.8 4119.8 4121.3 4160.5 4083.2 4093.6 4136.7 4143.3 4153.1 3577.2 3579.9 3583.5 3598.4 3600.4 4853.8 5062.9 5306.8 5310.2 5366.3 3991.4 4777.5 4777.5 4784.2 4796.4 5166.8 5435.5 5684.0 5756.0 5792.8 3522.5 3914.2 3956.7 3970.6 3975.0 4867.7 5764.2 6035.5 6063.2 6091.4 4005.8 4017.7 4035.3 4046.2 4047.9 3413.4 3827.5 3845.7 4070.8 4078.5 4727.9 4735.9 4739.6 4746.0 4779.9 5846.5 5850.5 5863.3 5869.5 5957.7 1077.0 1077.6 1140.3 1240.0 1248.4 746.7 753.8 793.3 798.6 893.9 4684.7 5018.6 5043.3 5097.9 5134.6 4622.3 4692.5 5322.3 5591.4 5593.2 4217.9 4270.0 4442.3 4960.7 5106.7 2587.7 2696.6 2753.8 2947.8 3005.4 5078.9 5205.7 5275.0 5847.7 5858.4 4449.8 5174.8 5549.3 5568.7 5804.3 4896.1 5412.9 6197.7 6209.5 6218.0 5183.8 5800.2 5825.5 5980.6 6046.6 5178.0 5222.9 5873.5 5895.0 5938.6 5682.9 6171.5 6179.4 6186.6 6238.5 3660.8 3713.3 4016.7 4035.7 4060.7 5173.5 5368.7 5656.7 5977.3 6014.4 4579.6 4896.4 5571.9 5668.5 5718.7 5088.9 5804.8 5823.3 5826.9 5835.8 5433.8 5592.3 5687.9 5708.3 5748.4 5133.6 5769.2 5779.9 5783.3 5824.3 4495.8 5641.6 5687.0 5722.5 5765.4 09:34:27 INFO - PROCESS | 1638 | 09:34:27 INFO - PROCESS | 1638 | [#5] yui.html Cycles:180 Average:21844.70 Median:14614.29 stddev:32261.03 (220.7%) stddev-sans-first:32312.62 09:34:27 INFO - PROCESS | 1638 | Values: 742.7 753.6 789.7 856.4 866.2 15247.8 15455.5 15999.5 16043.0 16085.0 14713.9 14721.3 14807.7 14845.9 14874.6 723.2 743.9 747.1 889.2 905.6 885.3 911.3 916.5 916.9 917.3 965.4 984.0 984.2 985.4 987.9 975.7 977.0 978.2 979.4 979.6 728.2 729.3 729.7 730.7 731.9 15824.2 16057.3 16121.3 16183.8 16415.8 15079.0 15365.3 15375.2 15393.3 15436.2 11638.8 11845.6 11930.5 12229.4 12336.2 3771.1 3834.7 3956.7 4016.1 4071.4 107164.5 109532.0 113174.0 113337.0 116909.0 11024.8 11632.4 11717.4 11785.2 12367.6 20918.6 21304.9 22309.8 25033.9 25457.5 8269.3 8335.5 8373.0 8483.5 8540.5 3839.4 4468.8 4501.4 4537.8 4621.9 3803.4 3877.0 3894.3 3896.4 3900.7 716.4 719.3 720.3 732.7 735.6 697.9 711.2 730.2 740.0 781.3 10545.9 10736.8 10764.9 11078.4 11256.0 550.4 658.9 664.5 706.1 706.9 5124.9 5225.6 5276.6 5278.6 5280.3 112370.0 113976.4 114224.2 114537.4 116136.7 83305.2 91436.0 99553.0 102362.5 104228.5 82651.6 85424.7 86358.6 88192.0 89276.0 9899.7 10231.0 10237.3 10262.5 10267.2 56661.0 56748.1 57130.0 57683.4 59396.0 61023.0 75688.9 76729.6 78916.7 80238.0 11761.1 11870.2 11880.0 11890.9 12064.2 12815.5 13045.6 13205.5 13933.4 14198.5 11684.2 12135.9 12144.1 12366.9 12394.3 11915.7 12313.8 12329.9 12439.3 12859.4 10451.4 11855.5 12114.3 12220.7 12434.3 10289.5 10353.3 10429.3 10723.8 11270.0 10241.9 10325.6 10344.9 10359.0 10400.7 09:34:27 INFO - PROCESS | 1638 | -------- Summary: end -------- 09:34:27 INFO - PROCESS | 1638 | 09:34:27 INFO - TEST-INFO | 1638: exit 0 09:34:28 INFO - TEST-OK | dromaeo_css | took 1116558ms 09:34:28 INFO - TEST-START | kraken 09:34:28 INFO - operating with platform_type : mac_ 09:34:28 INFO - Initialising browser for kraken test... 09:34:28 INFO - TEST-INFO | started process 1648 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/tmpkU_hSd/profile http://localhost:49245/getInfo.html) 09:34:30 INFO - PROCESS | 1648 | __metrics Screen width/height:1600/1200 09:34:30 INFO - PROCESS | 1648 | colorDepth:24 09:34:30 INFO - PROCESS | 1648 | Browser inner width/height: 1024/689 09:34:30 INFO - PROCESS | 1648 | __metrics 09:34:30 INFO - PROCESS | 1648 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 09:34:30 INFO - PROCESS | 1648 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:34:30 INFO - TEST-INFO | 1648: exit 0 09:34:30 INFO - Browser initialized. 09:34:30 INFO - Running cycle 1/1 for kraken test... 09:34:30 INFO - TEST-INFO | started process 1650 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/tmpkU_hSd/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:34:42 INFO - PROCESS | 1650 | RSS: Main: 163594240 09:34:42 INFO - PROCESS | 1650 | 09:34:45 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49245/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49245/tests/kraken/driver.html?testName=audio-beat-detection) 09:34:46 INFO - PROCESS | 1650 | RSS: Main: 214351872 09:34:46 INFO - PROCESS | 1650 | 09:34:48 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49245/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49245/tests/kraken/driver.html?testName=audio-dft) 09:34:49 INFO - PROCESS | 1650 | RSS: Main: 228995072 09:34:49 INFO - PROCESS | 1650 | 09:34:52 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49245/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49245/tests/kraken/driver.html?testName=audio-fft) 09:34:53 INFO - PROCESS | 1650 | RSS: Main: 325754880 09:34:53 INFO - PROCESS | 1650 | 09:34:55 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49245/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49245/tests/kraken/driver.html?testName=audio-oscillator) 09:34:55 INFO - PROCESS | 1650 | RSS: Main: 229052416 09:34:55 INFO - PROCESS | 1650 | 09:34:57 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49245/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49245/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:34:58 INFO - PROCESS | 1650 | RSS: Main: 231690240 09:34:58 INFO - PROCESS | 1650 | 09:35:01 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49245/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49245/tests/kraken/driver.html?testName=imaging-darkroom) 09:35:01 INFO - PROCESS | 1650 | RSS: Main: 271003648 09:35:01 INFO - PROCESS | 1650 | 09:35:04 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49245/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49245/tests/kraken/driver.html?testName=imaging-desaturate) 09:35:05 INFO - PROCESS | 1650 | RSS: Main: 271167488 09:35:05 INFO - PROCESS | 1650 | 09:35:08 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49245/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49245/tests/kraken/driver.html?testName=json-parse-financial) 09:35:08 INFO - PROCESS | 1650 | RSS: Main: 268394496 09:35:08 INFO - PROCESS | 1650 | 09:35:10 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49245/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49245/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:35:10 INFO - PROCESS | 1650 | RSS: Main: 245157888 09:35:10 INFO - PROCESS | 1650 | 09:35:12 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49245/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49245/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:35:13 INFO - PROCESS | 1650 | RSS: Main: 247357440 09:35:13 INFO - PROCESS | 1650 | 09:35:15 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49245/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49245/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:35:16 INFO - PROCESS | 1650 | RSS: Main: 256897024 09:35:16 INFO - PROCESS | 1650 | 09:35:19 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49245/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49245/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:35:19 INFO - PROCESS | 1650 | RSS: Main: 270442496 09:35:19 INFO - PROCESS | 1650 | 09:35:22 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49245/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49245/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:35:23 INFO - PROCESS | 1650 | RSS: Main: 263008256 09:35:23 INFO - PROCESS | 1650 | 09:35:25 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49245/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49245/tests/kraken/driver.html?testName=ai-astar) 09:35:25 INFO - PROCESS | 1650 | RSS: Main: 307318784 09:35:25 INFO - PROCESS | 1650 | 09:35:25 INFO - PROCESS | 1650 | __start_tp_report 09:35:25 INFO - PROCESS | 1650 | _x_x_mozilla_page_load 09:35:25 INFO - PROCESS | 1650 | _x_x_mozilla_page_load_details 09:35:25 INFO - PROCESS | 1650 | |i|pagename|runs| 09:35:25 INFO - PROCESS | 1650 | |0;ai-astar;104;113;113;114;113;113;114;112;113;113 09:35:25 INFO - PROCESS | 1650 | |1;audio-beat-detection;141;106;115;143;106;109;108;108;125;129 09:35:25 INFO - PROCESS | 1650 | |2;audio-dft;185;183;182;184;184;179;183;181;182;182 09:35:25 INFO - PROCESS | 1650 | |3;audio-fft;79;58;60;88;60;58;61;73;97;82 09:35:25 INFO - PROCESS | 1650 | |4;audio-oscillator;82;93;118;100;78;70;81;68;67;83 09:35:25 INFO - PROCESS | 1650 | |5;imaging-gaussian-blur;91;87;90;88;90;87;90;86;89;86 09:35:25 INFO - PROCESS | 1650 | |6;imaging-darkroom;95;93;95;96;95;95;96;95;95;95 09:35:25 INFO - PROCESS | 1650 | |7;imaging-desaturate;85;85;88;90;85;85;85;83;86;87 09:35:25 INFO - PROCESS | 1650 | |8;json-parse-financial;54;52;51;53;57;55;56;56;57;54 09:35:25 INFO - PROCESS | 1650 | |9;json-stringify-tinderbox;65;73;73;74;71;69;68;69;70;68 09:35:25 INFO - PROCESS | 1650 | |10;stanford-crypto-aes;82;83;84;82;83;83;81;86;95;103 09:35:25 INFO - PROCESS | 1650 | |11;stanford-crypto-ccm;132;134;142;142;141;130;130;129;174;114 09:35:25 INFO - PROCESS | 1650 | |12;stanford-crypto-pbkdf2;164;165;163;162;160;217;162;165;172;164 09:35:25 INFO - PROCESS | 1650 | |13;stanford-crypto-sha256-iterative;65;65;65;64;62;60;62;65;63;63 09:35:25 INFO - PROCESS | 1650 | __end_tp_report 09:35:25 INFO - PROCESS | 1650 | __start_cc_report 09:35:25 INFO - PROCESS | 1650 | _x_x_mozilla_cycle_collect,2083 09:35:25 INFO - PROCESS | 1650 | __end_cc_report 09:35:25 INFO - PROCESS | 1650 | __startTimestamp1490114125299__endTimestamp 09:35:25 INFO - PROCESS | 1650 | 09:35:25 INFO - PROCESS | 1650 | ------- Summary: start ------- 09:35:25 INFO - PROCESS | 1650 | Number of tests: 14 09:35:25 INFO - PROCESS | 1650 | 09:35:25 INFO - PROCESS | 1650 | [#0] ai-astar Cycles:10 Average:112.20 Median:113.00 stddev:2.94 (2.6%) stddev-sans-first:0.60 09:35:25 INFO - PROCESS | 1650 | Values: 104.0 113.0 113.0 114.0 113.0 113.0 114.0 112.0 113.0 113.0 09:35:25 INFO - PROCESS | 1650 | 09:35:25 INFO - PROCESS | 1650 | [#1] audio-beat-detection Cycles:10 Average:119.00 Median:120.00 stddev:14.50 (12.1%) stddev-sans-first:13.01 09:35:25 INFO - PROCESS | 1650 | Values: 141.0 106.0 115.0 143.0 106.0 109.0 108.0 108.0 125.0 129.0 09:35:25 INFO - PROCESS | 1650 | 09:35:25 INFO - PROCESS | 1650 | [#2] audio-dft Cycles:10 Average:182.50 Median:183.00 stddev:1.72 (0.9%) stddev-sans-first:1.56 09:35:25 INFO - PROCESS | 1650 | Values: 185.0 183.0 182.0 184.0 184.0 179.0 183.0 181.0 182.0 182.0 09:35:25 INFO - PROCESS | 1650 | 09:35:25 INFO - PROCESS | 1650 | [#3] audio-fft Cycles:10 Average:71.60 Median:76.00 stddev:14.26 (18.8%) stddev-sans-first:14.87 09:35:25 INFO - PROCESS | 1650 | Values: 79.0 58.0 60.0 88.0 60.0 58.0 61.0 73.0 97.0 82.0 09:35:25 INFO - PROCESS | 1650 | 09:35:25 INFO - PROCESS | 1650 | [#4] audio-oscillator Cycles:10 Average:84.00 Median:79.50 stddev:15.93 (20.0%) stddev-sans-first:16.88 09:35:25 INFO - PROCESS | 1650 | Values: 82.0 93.0 118.0 100.0 78.0 70.0 81.0 68.0 67.0 83.0 09:35:25 INFO - PROCESS | 1650 | 09:35:25 INFO - PROCESS | 1650 | [#5] imaging-gaussian-blur Cycles:10 Average:88.40 Median:89.50 stddev:1.84 (2.1%) stddev-sans-first:1.69 09:35:25 INFO - PROCESS | 1650 | Values: 91.0 87.0 90.0 88.0 90.0 87.0 90.0 86.0 89.0 86.0 09:35:25 INFO - PROCESS | 1650 | 09:35:25 INFO - PROCESS | 1650 | [#6] imaging-darkroom Cycles:10 Average:95.00 Median:95.00 stddev:0.82 (0.9%) stddev-sans-first:0.87 09:35:25 INFO - PROCESS | 1650 | Values: 95.0 93.0 95.0 96.0 95.0 95.0 96.0 95.0 95.0 95.0 09:35:25 INFO - PROCESS | 1650 | 09:35:25 INFO - PROCESS | 1650 | [#7] imaging-desaturate Cycles:10 Average:85.90 Median:85.50 stddev:1.97 (2.3%) stddev-sans-first:2.06 09:35:25 INFO - PROCESS | 1650 | Values: 85.0 85.0 88.0 90.0 85.0 85.0 85.0 83.0 86.0 87.0 09:35:25 INFO - PROCESS | 1650 | 09:35:25 INFO - PROCESS | 1650 | [#8] json-parse-financial Cycles:10 Average:54.50 Median:55.50 stddev:2.07 (3.7%) stddev-sans-first:2.19 09:35:25 INFO - PROCESS | 1650 | Values: 54.0 52.0 51.0 53.0 57.0 55.0 56.0 56.0 57.0 54.0 09:35:25 INFO - PROCESS | 1650 | 09:35:25 INFO - PROCESS | 1650 | [#9] json-stringify-tinderbox Cycles:10 Average:70.00 Median:70.50 stddev:2.79 (4.0%) stddev-sans-first:2.30 09:35:25 INFO - PROCESS | 1650 | Values: 65.0 73.0 73.0 74.0 71.0 69.0 68.0 69.0 70.0 68.0 09:35:25 INFO - PROCESS | 1650 | 09:35:25 INFO - PROCESS | 1650 | [#10] stanford-crypto-aes Cycles:10 Average:86.20 Median:83.00 stddev:7.13 (8.6%) stddev-sans-first:7.40 09:35:25 INFO - PROCESS | 1650 | Values: 82.0 83.0 84.0 82.0 83.0 83.0 81.0 86.0 95.0 103.0 09:35:25 INFO - PROCESS | 1650 | 09:35:25 INFO - PROCESS | 1650 | [#11] stanford-crypto-ccm Cycles:10 Average:136.80 Median:137.50 stddev:15.49 (11.3%) stddev-sans-first:16.33 09:35:25 INFO - PROCESS | 1650 | Values: 132.0 134.0 142.0 142.0 141.0 130.0 130.0 129.0 174.0 114.0 09:35:25 INFO - PROCESS | 1650 | 09:35:25 INFO - PROCESS | 1650 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:169.40 Median:164.50 stddev:17.02 (10.3%) stddev-sans-first:17.94 09:35:25 INFO - PROCESS | 1650 | Values: 164.0 165.0 163.0 162.0 160.0 217.0 162.0 165.0 172.0 164.0 09:35:25 INFO - PROCESS | 1650 | 09:35:25 INFO - PROCESS | 1650 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.40 Median:64.50 stddev:1.71 (2.7%) stddev-sans-first:1.72 09:35:25 INFO - PROCESS | 1650 | Values: 65.0 65.0 65.0 64.0 62.0 60.0 62.0 65.0 63.0 63.0 09:35:25 INFO - PROCESS | 1650 | -------- Summary: end -------- 09:35:25 INFO - PROCESS | 1650 | 09:35:26 INFO - TEST-INFO | 1650: exit 0 09:35:26 INFO - TEST-OK | kraken | took 58110ms 09:35:26 INFO - SUITE-END | took 1174s 09:35:26 INFO - Completed test suite (00:19:34) 09:35:26 INFO - javascript benchmark 09:35:26 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3435.347284016036, 3439.1574064354236, 3449.741269404792, 3452.413089774738, 3490.2670439207764, 5753.884922301562, 5856.47291743743, 5866.911996320058, 5883.352831188571, 5903.439173278537, 5855.677937713424, 5918.4081591840795, 5924.200232968548, 5933.970330148354, 5949.375315591866, 5249.1601343784905, 5284.497972692588, 5338.252644629755, 5355.357357117151, 5378.596605254602, 5097.770600322994, 5255.264263003182, 5303.496167864047, 5386.461353864622, 5400.054990376688, 5288.92066619001, 5295.20571914214, 5302.337207849019, 5329.094054010828, 5333.733313334337, 5336.573074154077, 5361.222622719683, 5362.168863826113, 5362.651427657229, 5366.892662146754, 5188.325517682715, 5218.425973142951, 5285.101532739443, 5290.470952904717, 5338.946610533883, 5731.770729170828, 5763.654180749127, 5790.623609465413, 5794.88410231793, 5799.739011744482, 6272.466840318579, 6321.715522801485, 6331.176946996861, 6337.207849018872, 6338.239411270631, 6232.096346029845, 6263.467605253559, 6273.780417685405, 6277.183966084425, 6279.058141278799, 5861.706914654335, 5900.822975310747, 5947.197128387699, 5962.34414214436, 5984.940150598525, 6287.591306565058, 6297.338779428185, 6337.366263373626, 6349.650769207646, 6359.236891573041, 6290.55966082379, 6299.842503937347, 6301.842453938597, 6314.431701146918, 6329.968350158219, 6321.367863213642, 6321.431071203614, 6324.873502529924, 6325.65208913505, 6342.334054924258, 6191.442770150618, 6222.12890195373, 6224.813255602339, 6282.4974002079725, 6283.120363149072, 6295.055741638791, 6295.37046295376, 6300.558960872695, 6329.145565348619, 6333.46165575922, 5064.949350506521, 5070.771815268322, 5075.365579302587, 5086.745662716849, 5106.0, 4505.81976720934, 4521.4574251089425, 4525.456945166601, 4538.228501154812, 4556.635469162459, 5926.407359264039, 5950.940490595039, 6009.519238461, 6014.8195554133445, 6020.066889632114, 6268.0054122334595, 6288.308286088527, 6300.590461620071, 6301.212348456443, 6315.40003699657, 4731.621470282369, 5790.623609465371, 5920.111983202554, 5985.661835940806, 5998.580099393001, 5427.267318911896, 5483.232347471358, 5494.5054945055135, 5502.58730595207, 5560.777568897199, 6361.9045714314325, 6374.26695929974, 6396.968015159894, 6406.13517175194, 6407.199100112486, 5085.0, 6219.689015549114, 6250.281217659845, 6251.78118765841, 6260.436560709558, 6214.8135555933395, 6251.843703907439, 6298.968505157445, 6363.363663633785, 6373.235211774617, 6220.813375598739, 6256.906146407717, 6301.054841773771, 6323.715432805443, 6349.0476428536085, 4902.607791376753, 5232.947670523246, 5237.502437268454, 5275.393329767126, 6295.905561416674, 6118.284172697687, 6208.410201030895, 6234.719437625408, 6274.6548939808745, 6306.495480361652, 5101.260317253903, 6124.136831511461, 6161.568690191643, 6254.0, 6273.0, 5121.7695203715175, 6162.630242185483, 6181.938180618136, 6183.628982261079, 6191.19514463117, 6074.605150665193, 6265.404786545271, 6272.027835685293, 6285.622862628257, 6300.464460520907, 6056.152138700673, 6107.389261073857, 6128.808691620048, 6132.816015519542, 6169.876602468015], "value": 5765.691544923661, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [471.6604045087537, 531.6252042310169, 531.9867003324914, 534.4794060896747, 549.6564647095565, 32455.188620284476, 33182.66817331826, 34578.82710586447, 42289.36565951505, 44213.7789311053, 45129.54870451295, 45429.77285113578, 45569.7721511392, 45645.087098258016, 45782.0, 9526.190273826716, 9733.929267780539, 9734.0, 9745.463999480025, 9747.56135973883, 9029.367944243906, 9230.16928476437, 9237.399569028024, 9322.161005509503, 9590.328676992613, 7734.535927844319, 11768.117391195652, 12023.338716370596, 12024.7595048099, 12206.206596571194, 11736.589219377367, 11811.291322520634, 11914.642560723149, 11917.22538035025, 11931.1051671125, 11883.94058029713, 11949.163558550905, 11954.342511161884, 11958.222715523463, 11959.94020029903, 42121.78939105316, 42529.36205956913, 42545.0, 42626.0, 42652.3602145968, 4064.248114098901, 4092.3043082676018, 4144.48193975753, 4149.398337241113, 4196.328587425997, 30500.69499305023, 30850.845745771352, 31998.20004499883, 32192.468702457125, 32446.188845278823, 3265.151060724205, 3340.2317466982486, 3483.390406678821, 3520.7887526748223, 3523.489094081344, 431053.0, 460165.0, 461686.0, 463819.0, 463994.0, 63658.68170659117, 63915.68042159759, 65804.34195658079, 66075.67848643, 66279.66860165668, 58896.11655825166, 59126.40873591295, 59273.110903336485, 59385.812283754945, 59397.70301148553, 17271.65456690859, 17872.731909021375, 17907.73138402925, 17909.552261193574, 17913.10434478271, 13578.932105339607, 13601.727965440636, 13640.454381824815, 13659.521916732867, 13660.65848353799, 15625.296861641253, 15943.123128228059, 16845.989240645602, 17426.21582028812, 17495.825041749675, 6842.7605033823575, 7061.187963384174, 7113.253108423644, 7153.749618763422, 7199.812031014929, 882.8499155143512, 912.926965842731, 915.7207051849117, 935.1443429262284, 954.1317401164906, 30927.84536077305, 31249.0, 32155.0, 32279.870204543196, 32328.0, 902.3953950852945, 1088.6733979806027, 1099.3568762273999, 1119.7200699825044, 1125.8966213111196, 14254.429822807178, 14886.925565372321, 14984.18490277931, 15027.699446011018, 15210.619734506727, 529587.0, 532218.0, 533479.0, 534012.0, 534693.0, 48376.0, 49174.262386064234, 55260.89478210413, 55330.72334638301, 56272.0, 1467.486379767073, 1487.300968544804, 1500.309857465578, 1510.546835949233, 1515.3181068519211, 22315.888420557792, 28747.712522874503, 30674.392676622738, 30708.385832283675, 31194.532082018333, 48771.75614121907, 55129.0, 56460.74157033673, 56628.433715662315, 58490.0, 590914.0, 597679.0, 627774.0, 635016.0, 644176.0, 24552.386190345384, 25153.365031272908, 25410.364740881625, 25869.353266168495, 25883.611745824204, 41426.585734142274, 43775.0, 43869.34195986999, 43949.12101758011, 44033.0, 32793.50809737904, 34840.30319393649, 35588.82205589059, 36140.0, 37950.051248719006, 36111.27777444489, 36161.45757813688, 37082.814585927976, 37248.255034899696, 37400.0, 35341.46987795237, 35385.938421847386, 36279.63720362762, 36438.81780591186, 36719.449208261365, 29775.851120744257, 31814.0, 32272.677273226967, 32278.19304517406, 32290.83854580712, 24114.87942560276, 24198.516029678955, 24350.391240219134, 24676.753232467447, 24714.0], "value": 20170.73866315917, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [396.37175077502155, 403.2076968756394, 403.94142849286874, 411.4856429463171, 428.92064967980923, 17594.82405175951, 20582.794172058275, 20929.267475638335, 21840.126394944222, 21974.01116949737, 22023.559528809456, 22233.666495002588, 22470.438239044033, 22532.0, 22847.42881427965, 5763.452472015162, 6072.848178795522, 6076.0, 6082.1180928765525, 6082.847928801793, 5764.077747560391, 5981.282246130449, 5983.790567330145, 6030.909536356936, 6045.637261764286, 5969.88060238795, 5981.252343457068, 5987.610805297663, 5990.820275391745, 5997.040473524237, 5687.431256874321, 5896.292444906596, 5939.910901336483, 5945.554083443716, 5947.583669143161, 5237.764300606482, 5245.186996015624, 5245.344331958505, 5246.895062098737, 5247.842564723026, 26416.471670566672, 26728.0, 26799.0, 26875.865620671968, 27066.594001089998, 2738.1785464360614, 2762.654668166479, 2779.777617790572, 2809.9016534421403, 2822.9435411291865, 15791.447299344467, 15824.44614438489, 15871.0, 15948.441804536786, 16193.433229837017, 1839.1447976690904, 1843.6589230992308, 1850.8796928199624, 1851.787044489874, 1863.363296215145, 124140.0, 125926.37036814849, 129283.0, 131800.6819931798, 131861.0, 9731.783527059117, 11015.504302306415, 11712.590059347882, 11743.47154378055, 11957.760844783055, 12021.038316934624, 14289.071210371292, 14980.1011939284, 14987.550373488813, 14995.625109372135, 8721.127887211229, 8969.775755606162, 8999.37004409685, 9116.8632470513, 9127.315451341043, 8991.0, 9010.098990100938, 9020.81958360829, 9025.954870225738, 9205.03347148553, 7132.643367831588, 7270.382017528464, 7270.781876543712, 7283.745068922668, 7288.12542494904, 1793.650238203564, 1902.3531999120366, 1943.1637102937589, 1969.5470041890446, 1969.881807091579, 737.8782500887294, 788.909275433321, 806.5241507510597, 808.5068108453838, 855.8844555984987, 20242.89878550598, 20677.438348918782, 23554.411139721644, 23632.7636723634, 23682.81585920697, 836.0510820219096, 850.2645211891669, 896.1128482801979, 906.71891713569, 917.4403613795579, 11991.400429978466, 12165.14843960932, 12403.565875194505, 12463.189892656948, 12470.43883025266, 790729.0, 794067.0, 797650.0, 798259.0, 811120.0, 103758.0, 117085.41457292659, 156367.0, 157861.0, 158324.20837895738, 1119.205364191433, 1137.9487923043482, 1171.0, 1179.1569028144918, 1185.519864454897, 19944.50138746543, 20229.19083236654, 20758.58482830365, 20817.0, 20847.0, 51772.482275176764, 58954.0, 62008.689956549926, 62659.6867015662, 63175.0, 88711.0, 91240.54379728324, 93940.0, 94465.0, 96688.0, 6569.343065693392, 8336.87494687568, 8523.786905327417, 8758.167974042455, 8904.86642700373, 11734.295942243492, 12518.687032824253, 13183.40674669623, 13317.334133293103, 13391.330433478091, 11033.834492482458, 11125.388103654053, 11373.090152787592, 11703.531858725897, 11727.706807329885, 9829.557669904729, 11276.154288428237, 11323.716907077389, 11379.658610241706, 11905.583304584297, 11537.884621154017, 11598.18812683138, 11673.241239319417, 11777.352245626573, 12046.638600841989, 7684.272083410532, 7853.096893857051, 8269.131741167092, 8550.358723095917, 8615.8707619387, 10501.31741436804, 11039.834402483808, 11532.88467115318, 11721.472533735832, 11882.524699011943], "value": 10274.444862499748, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1466.2668665667165, 1469.7574900141476, 1483.0360265827214, 1487.3158347160306, 1493.3503925792281, 8100.189981001904, 8532.744017679464, 8551.957240213791, 8562.186592273732, 8565.357598180139, 7522.96238518808, 7766.184550622188, 7774.183710710378, 8162.591870406485, 8336.208060234283, 2378.417287764496, 2413.5293617744546, 2424.612062070069, 2429.307647320514, 2429.3197904586655, 2303.216906251874, 2330.207729372013, 2339.8479098858606, 2340.8946597403155, 2347.295811256625, 2381.0475809676095, 2386.844855084414, 2401.5557121932497, 2411.1199412214505, 2415.2271273192587, 2364.704411948515, 2376.2039716694926, 2376.4652953085592, 2399.3281881073326, 2401.6637670726113, 2359.7876191142877, 2365.219477572397, 2420.5642984262827, 2422.6002709552904, 2427.1990243219693, 8385.538795366252, 8484.66061357545, 8485.321174306102, 8499.787505312355, 8505.064442911274, 5174.016936782037, 5321.920171197435, 5334.893302133935, 5337.11937530307, 5340.0, 3511.5929508466966, 3564.465330200465, 3576.946345804815, 3602.2435288589427, 3647.76289541179, 1222.2666400159922, 1225.91418600698, 1260.8802163794426, 1273.6624794429483, 1281.1608396500308, 9149.0, 10882.40146791926, 10939.781204375948, 10954.287971281841, 10964.56141754321, 4414.911701766011, 4705.835295764632, 4777.092352453093, 4789.161896668069, 4795.976020119947, 9535.0, 9543.141117299476, 9552.761180970392, 9553.331266811396, 9561.569729362196, 5352.090144675414, 5354.330708661418, 5356.946430535722, 5358.356997160287, 5375.973120134374, 4128.339465685476, 4351.434313539283, 4457.175422546774, 4828.7102773833685, 4931.802727890916, 3833.099221682902, 3876.9418458723144, 3944.092858642471, 3976.8608098716404, 3979.1245925896837, 1073.4686330266568, 1103.4813637590319, 1289.7807372746656, 1303.074816880007, 1308.5027689478127, 815.502543448496, 895.5477483870734, 915.3455279475207, 924.6902287733684, 927.4759760735163, 5377.300950876439, 5740.655560666373, 5770.07678771403, 5873.530117590582, 5959.880802384015, 995.8307087795092, 1002.674130907458, 1016.8779746430475, 1018.1549314069305, 1089.4988305379613, 3710.703143748494, 3750.6061863504483, 3877.3408520551575, 3881.049142959993, 3883.9029024274055, 9750.75623109428, 10046.648367307109, 10133.240006999356, 10142.645007424851, 10150.949245253727, 9559.522023898777, 9997.80004399908, 10086.142677872316, 10101.090901818725, 10115.544800483996, 6932.064171336805, 7840.255175758294, 7964.920350796418, 8026.357891368676, 8049.195080491904, 5515.558755299647, 5557.694326811902, 5590.720463976703, 5798.82603521895, 5890.381509941566, 9119.407238529475, 9300.581473833829, 9429.481378523973, 9490.28822838276, 9507.144357007903, 9212.953935230282, 9474.668386606436, 9593.856092158763, 9757.658481953098, 9772.80454390894, 7140.178879428724, 7262.310080542551, 7315.012473316247, 7362.6686799093095, 7376.96311518439, 7914.485558438683, 7922.881156782768, 8004.039515257973, 8012.559309238048, 8015.118336983044, 7179.605121718356, 7225.855482890418, 7287.307705767944, 7301.0, 7388.963055184905, 7048.788536343918, 7138.785836424916, 7145.535540189871, 7176.641167941478, 7204.171520275236, 6387.648679322682, 6463.418292353711, 6505.902411463927, 6519.380658837403, 6537.28089910119, 4894.0, 4947.727874966768, 5023.7488125592845, 5029.641996660808, 5158.948410515847, 4992.101421744121, 5020.974895125501, 5084.872878178076, 5127.256547800623, 5132.43543210254], "value": 4503.5313399910365, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [365.7403243696975, 371.78436506826046, 377.1984532867655, 387.268063360249, 387.7421514692729, 5208.531232189098, 5293.364796224459, 5454.0, 5464.426235245297, 5483.698396588186, 4534.97732511337, 5354.330708661418, 5379.5427388671915, 5424.376196737377, 5494.911933465288, 4174.872784348224, 4237.749863790189, 4312.74930270222, 4314.4391229140165, 4340.435743353375, 3931.9606803932024, 4106.753594784308, 4325.653947684178, 4331.787099612114, 4352.847650332239, 4095.692823038269, 4115.794210289489, 4119.814608342616, 4121.26906699187, 4160.521540022906, 4083.183363327332, 4093.6111069448502, 4136.710430269883, 4143.295639741251, 4153.086321009373, 3577.2130131371055, 3579.8568057277676, 3583.5486627915734, 3598.355208921441, 3600.3519366514015, 4853.757312134379, 5062.8608563073385, 5306.8407947761625, 5310.150375939831, 5366.275552800361, 3991.44119823225, 4777.474477807438, 4777.498362671939, 4784.186688263004, 4796.424429068499, 5166.793328266865, 5435.483629055233, 5683.976884160849, 5756.0214763489885, 5792.82621521355, 3522.4892390603477, 3914.15845593196, 3956.6834653227675, 3970.602939706035, 3974.960250397488, 4867.70793752376, 5764.16419619157, 6035.517158627299, 6063.242094738158, 6091.390860913917, 4005.7796821175116, 4017.678585713136, 4035.2938235808615, 4046.1705350403095, 4047.8785636430366, 3413.4026545354463, 3827.4641550182996, 3845.7115716321387, 4070.776107314126, 4078.5317285777096, 4727.881802954954, 4735.857924262277, 4739.559127049572, 4746.0, 4779.856604301807, 5846.473817356373, 5850.502707269845, 5863.3257175424515, 5869.501092407193, 5957.672328022, 1076.967690969272, 1077.6120596585224, 1140.3329052504212, 1239.9708242159168, 1248.3945286536023, 746.7380127584365, 753.7851712261979, 793.2701914238914, 798.6446031515919, 893.8525143351275, 4684.695494792828, 5018.591076283405, 5043.2687260347775, 5097.923531147036, 5134.640575159703, 4622.306654001859, 4692.507286734912, 5322.308099947059, 5591.384947655754, 5593.188987596775, 4217.936730949038, 4270.0, 4442.335073564323, 4960.677555958851, 5106.66806657566, 2587.728288529715, 2696.6089916961932, 2753.7796976241852, 2947.820871651357, 3005.3989202159655, 5078.923816142761, 5205.713685747321, 5274.97362513185, 5847.736851841677, 5858.443447872531, 4449.7997590108525, 5174.767135478913, 5549.334079910436, 5568.693721845257, 5804.303483581997, 4896.143174944371, 5412.918806217988, 6197.690115494207, 6209.472194863487, 6218.0, 5183.766730497061, 5800.171886554854, 5825.533957283492, 5980.611260268069, 6046.637201767908, 5177.990291893045, 5222.869428264324, 5873.471387575139, 5894.970525147518, 5938.584299099021, 5682.886342273214, 6171.475424588781, 6179.443850053517, 6186.597371445597, 6238.532110091671, 3660.7986560739414, 3713.313037088147, 4016.6987475938836, 4035.7085732565297, 4060.654844338146, 5173.482651734947, 5368.73834648865, 5656.660600363992, 5977.252843394575, 6014.428629280212, 4579.633629309581, 4896.404905400143, 5571.860703482445, 5668.461496157858, 5718.714064296852, 5088.923666144937, 5804.82585522435, 5823.272090988627, 5826.941730582809, 5835.824925252249, 5433.8369848904595, 5592.273004509388, 5687.857803554944, 5708.288562932574, 5748.378521531408, 5133.635351058228, 5769.249997500298, 5779.942200577941, 5783.277090363705, 5824.310949824503, 4495.775211239359, 5641.605087643826, 5687.004774164422, 5722.513586345207, 5765.365809761007], "value": 4148.5413183375285, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [742.7029188324666, 753.58929383486, 789.6525528767341, 856.4347530629784, 866.190112245051, 15247.847521524782, 15455.45905893294, 15999.520014399572, 16043.037417754913, 16085.034897906135, 14713.926430367834, 14721.26393680317, 14807.703845923075, 14845.925770371134, 14874.628134296649, 723.1611330856208, 743.9293267139614, 747.1370566995103, 889.230815344727, 905.597009330848, 885.2696525366566, 911.3028533172129, 916.5463095767572, 916.9174774270315, 917.321182325078, 965.4062751407904, 984.0, 984.1831280037587, 985.3792110970114, 987.8666380038675, 975.7267964969819, 976.9560369783342, 978.1929907826072, 979.4025644356936, 979.6130528441297, 728.1735230513352, 729.3180875881068, 729.719058162606, 730.747891977267, 731.8646050480678, 15824.208789560476, 16057.277422516016, 16121.27454264561, 16183.83816161835, 16415.753763693556, 15079.0, 15365.308561114665, 15375.154366509838, 15393.307301171475, 15436.151011694352, 11638.767224655545, 11845.5854045108, 11930.522779088826, 12229.449674764657, 12336.198147120409, 3771.0949372150762, 3834.654881060718, 3956.6636835868985, 4016.136530645896, 4071.42999980003, 107164.46417767939, 109532.0, 113173.99999999917, 113337.0, 116909.0, 11024.779504410028, 11632.360220187802, 11717.355545444912, 11785.233959792586, 12367.62897113088, 20918.58162836735, 21304.934753262274, 22309.77690223077, 25033.87483062573, 25457.490850182894, 8269.338452923752, 8335.458195217292, 8372.958135209285, 8483.533405662625, 8540.530270835165, 3839.404892241707, 4468.821247150077, 4501.414816073955, 4537.802532657279, 4621.861344159681, 3803.4294855771304, 3877.0307423144213, 3894.337962546374, 3896.4155376693725, 3900.687944964396, 716.4483347822148, 719.2986837833071, 720.2797202797203, 732.6886073418775, 735.6211551051213, 697.8848489999194, 711.1643818513227, 730.1603156370217, 739.9677449957279, 781.3124450483651, 10545.9472702636, 10736.838947415796, 10764.925928498453, 11078.446077696244, 11256.0, 550.3615459616178, 658.9292399850243, 664.5281849886538, 706.1420374245214, 706.8868980963124, 5124.897502049938, 5225.634205605647, 5276.630635855453, 5278.551323137576, 5280.313559237351, 112370.0, 113976.43011784888, 114224.21702581365, 114537.4273128629, 116136.6772664542, 83305.16694833095, 91436.0, 99553.0, 102362.48818756007, 104228.47885760674, 82651.5867420659, 85424.6868087703, 86358.56820715856, 88192.0, 89275.9999999987, 9899.65351212704, 10230.976902309709, 10237.283390162616, 10262.486875656337, 10267.229957753048, 56661.0, 56748.148777769195, 57130.0, 57683.4231657678, 59396.0, 61023.0, 75688.86466702893, 76729.61635192012, 78916.68666506551, 80238.0, 11761.117916156494, 11870.228435151688, 11880.0, 11890.940545297219, 12064.215825971283, 12815.487380504675, 13045.608631741063, 13205.471781129032, 13933.372998214902, 14198.503052393116, 11684.240524365889, 12135.878641213829, 12144.089193310714, 12366.938165309115, 12394.3183124929, 11915.702107447036, 12313.815292770794, 12329.938350308192, 12439.253644781342, 12859.421326040538, 10451.425171615634, 11855.466504007169, 12114.273143611412, 12220.694482638006, 12434.253944763343, 10289.485525723534, 10353.275270730977, 10429.26995110335, 10723.785524289626, 11269.985701286923, 10241.897581024094, 10325.63860264887, 10344.896551034393, 10359.0, 10400.739981500523], "value": 7789.200738229997, "unit": "score"}], "name": "dromaeo_css", "value": 7471.137250003634, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 113.0, 113.0, 114.0, 113.0, 113.0, 114.0, 112.0, 113.0, 113.0], "value": 112.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 106.0, 115.0, 143.0, 106.0, 109.0, 108.0, 108.0, 125.0, 129.0], "value": 119.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [185.0, 183.0, 182.0, 184.0, 184.0, 179.0, 183.0, 181.0, 182.0, 182.0], "value": 182.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 58.0, 60.0, 88.0, 60.0, 58.0, 61.0, 73.0, 97.0, 82.0], "value": 71.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 93.0, 118.0, 100.0, 78.0, 70.0, 81.0, 68.0, 67.0, 83.0], "value": 84.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 87.0, 90.0, 88.0, 90.0, 87.0, 90.0, 86.0, 89.0, 86.0], "value": 88.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 93.0, 95.0, 96.0, 95.0, 95.0, 96.0, 95.0, 95.0, 95.0], "value": 95.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 88.0, 90.0, 85.0, 85.0, 85.0, 83.0, 86.0, 87.0], "value": 85.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 52.0, 51.0, 53.0, 57.0, 55.0, 56.0, 56.0, 57.0, 54.0], "value": 54.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 73.0, 73.0, 74.0, 71.0, 69.0, 68.0, 69.0, 70.0, 68.0], "value": 70.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 83.0, 84.0, 82.0, 83.0, 83.0, 81.0, 86.0, 95.0, 103.0], "value": 86.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [132.0, 134.0, 142.0, 142.0, 141.0, 130.0, 130.0, 129.0, 174.0, 114.0], "value": 136.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 165.0, 163.0, 162.0, 160.0, 217.0, 162.0, 165.0, 172.0, 164.0], "value": 169.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 65.0, 64.0, 62.0, 60.0, 62.0, 65.0, 63.0, 63.0], "value": 63.4, "unit": "score"}], "name": "kraken", "value": 1418.9, "alertThreshold": 2.0}]} 09:35:26 INFO - Return code: 0 09:35:26 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:35:26 INFO - # TBPL SUCCESS # 09:35:26 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 09:35:26 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 09:35:26 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 09:35:26 INFO - 2017-03-21 09:35:26.623 screenresolution[1654:9673] starting screenresolution argv=screenresolution get 09:35:26 INFO - 2017-03-21 09:35:26.626 screenresolution[1654:9673] Display 0: 1600x1200x32@60 09:35:26 INFO - 2017-03-21 09:35:26.632 screenresolution[1655:9676] starting screenresolution argv=screenresolution list 09:35:26 INFO - Available Modes on Display 0 09:35:26 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 09:35:26 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 09:35:26 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 09:35:26 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 09:35:26 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 09:35:26 INFO - Intel Iris: 09:35:26 INFO - Chipset Model: Intel Iris 09:35:26 INFO - Type: GPU 09:35:26 INFO - Bus: Built-In 09:35:26 INFO - VRAM (Dynamic, Max): 1536 MB 09:35:26 INFO - Vendor: Intel (0x8086) 09:35:26 INFO - Device ID: 0x0a2e 09:35:26 INFO - Revision ID: 0x0009 09:35:26 INFO - Displays: 09:35:26 INFO - Display: 09:35:26 INFO - Resolution: 1600 x 1200 @ 60 Hz 09:35:26 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 09:35:26 INFO - Display Serial Number: 1600x1200 60 09:35:26 INFO - Main Display: Yes 09:35:26 INFO - Mirror: Off 09:35:26 INFO - Online: Yes 09:35:26 INFO - Rotation: Supported 09:35:26 INFO - Return code: 0 09:35:26 INFO - Running post-action listener: _resource_record_post_action 09:35:26 INFO - [mozharness: 2017-03-21 16:35:26.867376Z] Finished run-tests step (success) 09:35:26 INFO - Running post-run listener: _resource_record_post_run 09:35:26 INFO - Total resource usage - Wall time: 1190s; CPU: 54.0%; Read bytes: 38085632; Write bytes: 422247936; Read time: 247; Write time: 1391 09:35:26 INFO - TinderboxPrint: CPU usage
53.5% 09:35:26 INFO - TinderboxPrint: I/O read bytes / time
38,085,632 / 247 09:35:26 INFO - TinderboxPrint: I/O write bytes / time
422,247,936 / 1,391 09:35:26 INFO - TinderboxPrint: CPU idle
2,212.1 (46.5%) 09:35:26 INFO - TinderboxPrint: CPU system
951.9 (20.0%) 09:35:26 INFO - TinderboxPrint: CPU user
1,597.7 (33.6%) 09:35:26 INFO - TinderboxPrint: Swap in / out
160,079,872 / 0 09:35:26 INFO - install - Wall time: 15s; CPU: 54.0%; Read bytes: 122911232; Write bytes: 124220928; Read time: 11171; Write time: 281 09:35:26 INFO - run-tests - Wall time: 1176s; CPU: 54.0%; Read bytes: 34264064; Write bytes: 296491008; Read time: 224; Write time: 1106 09:35:27 INFO - Running post-run listener: _upload_blobber_files 09:35:27 INFO - Blob upload gear active. 09:35:27 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:35:27 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 09:35:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 09:35:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 09:35:27 INFO - (blobuploader) - INFO - Open directory for files ... 09:35:27 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 09:35:27 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:35:27 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:35:28 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 09:35:28 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:35:28 INFO - (blobuploader) - INFO - Done attempting. 09:35:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 09:35:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:35:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:35:29 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 09:35:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:35:29 INFO - (blobuploader) - INFO - Done attempting. 09:35:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 09:35:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:35:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:35:30 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 09:35:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:35:30 INFO - (blobuploader) - INFO - Done attempting. 09:35:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:35:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:35:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:35:33 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:35:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:35:33 INFO - (blobuploader) - INFO - Done attempting. 09:35:33 INFO - (blobuploader) - INFO - Iteration through files over. 09:35:33 INFO - Return code: 0 09:35:33 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:35:33 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:35:33 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/1a2558a7dd0736794301c11d2331bae239426f6d31a625f56b90a30b6f6aec0b190c10141569b75f51ef513ed8a295bc04b8d4222116a6cc3841710032e4161f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/1c55f1092641b592624ded891864d8d156c0b4b0fd835b79b07345f2884d48471588da8c9c9e9e9262b1e94b635d7c24b8baee51c491289db787f6b273d07da2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/a51fd17f20f5dfd9efb298c1735802c45d6b00ced78122369bd70d96cac14eb2d754dd9709ea60aa07efdeafb72edaa5eddc7a761160d72819325b3ab86e6a48", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/412884cbf8d305a6d7afea8a8ba402bbef22d7cc2995447d9012695358e97d15341deef4d8ceaa12ee70612257e719942426f632128d1b2bdfc6e0d895da6da3"} 09:35:33 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:35:33 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:35:33 INFO - Contents: 09:35:33 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/1a2558a7dd0736794301c11d2331bae239426f6d31a625f56b90a30b6f6aec0b190c10141569b75f51ef513ed8a295bc04b8d4222116a6cc3841710032e4161f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/1c55f1092641b592624ded891864d8d156c0b4b0fd835b79b07345f2884d48471588da8c9c9e9e9262b1e94b635d7c24b8baee51c491289db787f6b273d07da2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/a51fd17f20f5dfd9efb298c1735802c45d6b00ced78122369bd70d96cac14eb2d754dd9709ea60aa07efdeafb72edaa5eddc7a761160d72819325b3ab86e6a48", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/412884cbf8d305a6d7afea8a8ba402bbef22d7cc2995447d9012695358e97d15341deef4d8ceaa12ee70612257e719942426f632128d1b2bdfc6e0d895da6da3"} 09:35:33 INFO - Running post-run listener: copy_logs_to_upload_dir 09:35:33 INFO - Copying logs to upload dir... 09:35:33 INFO - mkdir: /builds/slave/test/build/upload/logs 09:35:33 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1253.928747 ========= master_lag: 0.06 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 20 mins, 53 secs) (at 2017-03-21 09:35:32.570272) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-21 09:35:32.577175) ========= 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.p5WIUVMJeJ/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.Iodrzj126C/Listeners TMPDIR=/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/1a2558a7dd0736794301c11d2331bae239426f6d31a625f56b90a30b6f6aec0b190c10141569b75f51ef513ed8a295bc04b8d4222116a6cc3841710032e4161f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/1c55f1092641b592624ded891864d8d156c0b4b0fd835b79b07345f2884d48471588da8c9c9e9e9262b1e94b635d7c24b8baee51c491289db787f6b273d07da2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/a51fd17f20f5dfd9efb298c1735802c45d6b00ced78122369bd70d96cac14eb2d754dd9709ea60aa07efdeafb72edaa5eddc7a761160d72819325b3ab86e6a48", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/412884cbf8d305a6d7afea8a8ba402bbef22d7cc2995447d9012695358e97d15341deef4d8ceaa12ee70612257e719942426f632128d1b2bdfc6e0d895da6da3"} build_url:https://queue.taskcluster.net/v1/task/JtmctiQNQl6AaKwXy0sI1Q/artifacts/public/build/firefox-53.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010893 build_url: 'https://queue.taskcluster.net/v1/task/JtmctiQNQl6AaKwXy0sI1Q/artifacts/public/build/firefox-53.0.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/1a2558a7dd0736794301c11d2331bae239426f6d31a625f56b90a30b6f6aec0b190c10141569b75f51ef513ed8a295bc04b8d4222116a6cc3841710032e4161f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/1c55f1092641b592624ded891864d8d156c0b4b0fd835b79b07345f2884d48471588da8c9c9e9e9262b1e94b635d7c24b8baee51c491289db787f6b273d07da2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/a51fd17f20f5dfd9efb298c1735802c45d6b00ced78122369bd70d96cac14eb2d754dd9709ea60aa07efdeafb72edaa5eddc7a761160d72819325b3ab86e6a48", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/412884cbf8d305a6d7afea8a8ba402bbef22d7cc2995447d9012695358e97d15341deef4d8ceaa12ee70612257e719942426f632128d1b2bdfc6e0d895da6da3"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-21 09:35:32.610562) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-21 09:35:32.610896) ========= 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.p5WIUVMJeJ/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.Iodrzj126C/Listeners TMPDIR=/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/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.004989 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-21 09:35:32.659434) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-21 09:35:32.659728) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-21 09:35:32.660048) ========= ========= Total master_lag: 0.21 =========