builder: mozilla-beta_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0352 starttime: 1492653921.51 results: success (0) buildid: 20170419174827 builduid: 9086fc883d884cfc98b049c40e8b2481 revision: 584df356a66b1f5d48c73625dd08589a11029845 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-04-19 19:05:21.514990) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-04-19 19:05:21.515456) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-19 19:05:21.515733) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-19 19:05:21.542033) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-19 19:05:21.542443) ========= 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.QwNtBq01ym/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.zOsqx2452J/Listeners TMPDIR=/var/folders/ng/csmfm9x9681blsv1wkb387f800000w/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-04-19 19:05:21-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 10.4M=0.001s 2017-04-19 19:05:21 (10.4 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.090905 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-19 19:05:21.657659) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-19 19:05:21.657984) ========= 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.QwNtBq01ym/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.zOsqx2452J/Listeners TMPDIR=/var/folders/ng/csmfm9x9681blsv1wkb387f800000w/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.027092 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-19 19:05:21.708359) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-04-19 19:05:21.708853) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 584df356a66b1f5d48c73625dd08589a11029845 --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 584df356a66b1f5d48c73625dd08589a11029845 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.QwNtBq01ym/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.zOsqx2452J/Listeners TMPDIR=/var/folders/ng/csmfm9x9681blsv1wkb387f800000w/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-04-19 19:05:21,857 truncating revision to first 12 chars 2017-04-19 19:05:21,858 Setting DEBUG logging. 2017-04-19 19:05:21,858 attempt 1/10 2017-04-19 19:05:21,858 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/584df356a66b?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-04-19 19:05:23,390 unpacking tar archive at: mozilla-beta-584df356a66b/testing/mozharness/ program finished with exit code 0 elapsedTime=1.807809 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-04-19 19:05:23.542454) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-19 19:05:23.542824) ========= script_repo_revision: 584df356a66b1f5d48c73625dd08589a11029845 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-19 19:05:23.543316) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-19 19:05:23.543714) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-19 19:05:23.564234) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 15 secs) (at 2017-04-19 19:05:23.564702) ========= /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.QwNtBq01ym/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.zOsqx2452J/Listeners TMPDIR=/var/folders/ng/csmfm9x9681blsv1wkb387f800000w/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 19:05:23 INFO - MultiFileLogger online at 20170419 19:05:23 in /builds/slave/test 19:05:23 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 19:05:23 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 19:05:23 INFO - {'append_to_log': False, 19:05:23 INFO - 'base_work_dir': '/builds/slave/test', 19:05:23 INFO - 'blob_upload_branch': 'Mozilla-Beta', 19:05:23 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 19:05:23 INFO - 'branch': 'Mozilla-Beta', 19:05:23 INFO - 'buildbot_json_path': 'buildprops.json', 19:05:23 INFO - 'config_files': ('talos/mac_config.py',), 19:05:23 INFO - 'default_actions': ('clobber', 19:05:23 INFO - 'read-buildbot-config', 19:05:23 INFO - 'download-and-extract', 19:05:23 INFO - 'populate-webroot', 19:05:23 INFO - 'create-virtualenv', 19:05:23 INFO - 'install', 19:05:23 INFO - 'run-tests'), 19:05:23 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 19:05:23 INFO - 'download_minidump_stackwalk': True, 19:05:23 INFO - 'download_symbols': 'ondemand', 19:05:23 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 19:05:23 INFO - 'tooltool.py': '/tools/tooltool.py', 19:05:23 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 19:05:23 INFO - '/tools/misc-python/virtualenv.py')}, 19:05:23 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 19:05:23 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 19:05:23 INFO - 'gecko_profile': False, 19:05:23 INFO - 'gecko_profile_interval': 0, 19:05:23 INFO - 'installer_path': 'installer.exe', 19:05:23 INFO - 'log_level': 'info', 19:05:23 INFO - 'log_name': 'talos', 19:05:23 INFO - 'log_to_console': True, 19:05:23 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 19:05:23 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 19:05:23 INFO - 'opt_config_files': (), 19:05:23 INFO - 'pip_index': False, 19:05:23 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 19:05:23 INFO - 'cmd': ('bash', 19:05:23 INFO - '-c', 19:05:23 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 19:05:23 INFO - 'enabled': True, 19:05:23 INFO - 'halt_on_failure': False, 19:05:23 INFO - 'name': 'check_screen_resolution'},), 19:05:23 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 19:05:23 INFO - 'cmd': ('bash', 19:05:23 INFO - '-c', 19:05:23 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 19:05:23 INFO - 'enabled': True, 19:05:23 INFO - 'halt_on_failure': False, 19:05:23 INFO - 'name': 'check_screen_resolution'},), 19:05:23 INFO - 'run_cmd_checks_enabled': True, 19:05:23 INFO - 'suite': 'dromaeojs', 19:05:23 INFO - 'system_bits': '32', 19:05:23 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 19:05:23 INFO - 'title': 't-yosemite-r7-0352', 19:05:23 INFO - 'tooltool_cache': '/builds/tooltool_cache', 19:05:23 INFO - 'use_talos_json': True, 19:05:23 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 19:05:23 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 19:05:23 INFO - 'work_dir': 'build'} 19:05:23 INFO - [mozharness: 2017-04-20 02:05:23.821084Z] Running clobber step. 19:05:23 INFO - Running pre-action listener: _resource_record_pre_action 19:05:23 INFO - Running main action method: clobber 19:05:23 INFO - rmtree: /builds/slave/test/build 19:05:23 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 19:05:26 INFO - Running post-action listener: _resource_record_post_action 19:05:26 INFO - [mozharness: 2017-04-20 02:05:26.276746Z] Finished clobber step (success) 19:05:26 INFO - [mozharness: 2017-04-20 02:05:26.276876Z] Running read-buildbot-config step. 19:05:26 INFO - Running pre-action listener: _resource_record_pre_action 19:05:26 INFO - Running main action method: read_buildbot_config 19:05:26 INFO - Using buildbot properties: 19:05:26 INFO - { 19:05:26 INFO - "project": "", 19:05:26 INFO - "product": "firefox", 19:05:26 INFO - "script_repo_revision": "production", 19:05:26 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs", 19:05:26 INFO - "repository": "", 19:05:26 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs", 19:05:26 INFO - "buildid": "20170419174827", 19:05:26 INFO - "pgo_build": "False", 19:05:26 INFO - "basedir": "/builds/slave/test", 19:05:26 INFO - "buildnumber": 2, 19:05:26 INFO - "slavename": "t-yosemite-r7-0352", 19:05:26 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 19:05:26 INFO - "platform": "yosemite_r7", 19:05:26 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 19:05:26 INFO - "branch": "mozilla-beta", 19:05:26 INFO - "repo_path": "releases/mozilla-beta", 19:05:26 INFO - "revision": "584df356a66b1f5d48c73625dd08589a11029845", 19:05:26 INFO - "stage_platform": "macosx64", 19:05:26 INFO - "builduid": "9086fc883d884cfc98b049c40e8b2481", 19:05:26 INFO - "slavebuilddir": "test" 19:05:26 INFO - } 19:05:26 INFO - Found installer url https://queue.taskcluster.net/v1/task/KynrzFL-QUeRgmfBseZKwA/artifacts/public/build/firefox-54.0.en-US.mac.dmg. 19:05:26 INFO - Running post-action listener: _resource_record_post_action 19:05:26 INFO - [mozharness: 2017-04-20 02:05:26.280199Z] Finished read-buildbot-config step (success) 19:05:26 INFO - [mozharness: 2017-04-20 02:05:26.280302Z] Running download-and-extract step. 19:05:26 INFO - Running pre-action listener: _resource_record_pre_action 19:05:26 INFO - Running main action method: download_and_extract 19:05:26 INFO - mkdir: /builds/slave/test/build/tests 19:05:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:05:26 INFO - trying https://queue.taskcluster.net/v1/task/KynrzFL-QUeRgmfBseZKwA/artifacts/public/build/firefox-54.0.en-US.mac.test_packages.json 19:05:26 INFO - Downloading https://queue.taskcluster.net/v1/task/KynrzFL-QUeRgmfBseZKwA/artifacts/public/build/firefox-54.0.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-54.0.en-US.mac.test_packages.json 19:05:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/KynrzFL-QUeRgmfBseZKwA/artifacts/public/build/firefox-54.0.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-54.0.en-US.mac.test_packages.json'}, attempt #1 19:05:27 INFO - Downloaded 1165 bytes. 19:05:27 INFO - Reading from file /builds/slave/test/build/firefox-54.0.en-US.mac.test_packages.json 19:05:27 INFO - Using the following test package requirements: 19:05:27 INFO - {u'common': [u'firefox-54.0.en-US.mac.common.tests.zip'], 19:05:27 INFO - u'cppunittest': [u'firefox-54.0.en-US.mac.common.tests.zip', 19:05:27 INFO - u'firefox-54.0.en-US.mac.cppunittest.tests.zip'], 19:05:27 INFO - u'gtest': [u'firefox-54.0.en-US.mac.common.tests.zip', 19:05:27 INFO - u'firefox-54.0.en-US.mac.gtest.tests.zip'], 19:05:27 INFO - u'jittest': [u'firefox-54.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 19:05:27 INFO - u'mochitest': [u'firefox-54.0.en-US.mac.common.tests.zip', 19:05:27 INFO - u'firefox-54.0.en-US.mac.mochitest.tests.zip'], 19:05:27 INFO - u'mozbase': [u'firefox-54.0.en-US.mac.common.tests.zip'], 19:05:27 INFO - u'reftest': [u'firefox-54.0.en-US.mac.common.tests.zip', 19:05:27 INFO - u'firefox-54.0.en-US.mac.reftest.tests.zip'], 19:05:27 INFO - u'talos': [u'firefox-54.0.en-US.mac.common.tests.zip', 19:05:27 INFO - u'firefox-54.0.en-US.mac.talos.tests.zip'], 19:05:27 INFO - u'web-platform': [u'firefox-54.0.en-US.mac.common.tests.zip', 19:05:27 INFO - u'firefox-54.0.en-US.mac.web-platform.tests.zip'], 19:05:27 INFO - u'xpcshell': [u'firefox-54.0.en-US.mac.common.tests.zip', 19:05:27 INFO - u'firefox-54.0.en-US.mac.xpcshell.tests.zip']} 19:05:27 INFO - Downloading packages: [u'firefox-54.0.en-US.mac.common.tests.zip'] for test suite category: common 19:05:27 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/KynrzFL-QUeRgmfBseZKwA/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip 19:05:27 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/KynrzFL-QUeRgmfBseZKwA/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip'}, attempt #1 19:05:27 INFO - Fetch https://queue.taskcluster.net/v1/task/KynrzFL-QUeRgmfBseZKwA/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip into memory 19:05:28 INFO - Expected file size: 51220716 19:05:28 INFO - Obtained file size: 51220716 19:05:44 INFO - Downloading packages: [u'firefox-54.0.en-US.mac.common.tests.zip', u'firefox-54.0.en-US.mac.talos.tests.zip'] for test suite category: talos 19:05:44 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/KynrzFL-QUeRgmfBseZKwA/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip 19:05:44 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/KynrzFL-QUeRgmfBseZKwA/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip'}, attempt #1 19:05:44 INFO - Fetch https://queue.taskcluster.net/v1/task/KynrzFL-QUeRgmfBseZKwA/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip into memory 19:05:46 INFO - Expected file size: 51220716 19:05:46 INFO - Obtained file size: 51220716 19:06:01 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/KynrzFL-QUeRgmfBseZKwA/artifacts/public/build/firefox-54.0.en-US.mac.talos.tests.zip 19:06:01 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/KynrzFL-QUeRgmfBseZKwA/artifacts/public/build/firefox-54.0.en-US.mac.talos.tests.zip'}, attempt #1 19:06:01 INFO - Fetch https://queue.taskcluster.net/v1/task/KynrzFL-QUeRgmfBseZKwA/artifacts/public/build/firefox-54.0.en-US.mac.talos.tests.zip into memory 19:06:02 INFO - Expected file size: 14404424 19:06:02 INFO - Obtained file size: 14404424 19:06:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:06:03 INFO - trying https://queue.taskcluster.net/v1/task/KynrzFL-QUeRgmfBseZKwA/artifacts/public/build/firefox-54.0.en-US.mac.dmg 19:06:03 INFO - Downloading https://queue.taskcluster.net/v1/task/KynrzFL-QUeRgmfBseZKwA/artifacts/public/build/firefox-54.0.en-US.mac.dmg to /builds/slave/test/build/firefox-54.0.en-US.mac.dmg 19:06:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/KynrzFL-QUeRgmfBseZKwA/artifacts/public/build/firefox-54.0.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-54.0.en-US.mac.dmg'}, attempt #1 19:06:05 INFO - Downloaded 59217981 bytes. 19:06:05 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/KynrzFL-QUeRgmfBseZKwA/artifacts/public/build/firefox-54.0.en-US.mac.dmg 19:06:05 INFO - mkdir: /builds/slave/test/properties 19:06:05 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 19:06:05 INFO - Writing to file /builds/slave/test/properties/build_url 19:06:05 INFO - Contents: 19:06:05 INFO - build_url:https://queue.taskcluster.net/v1/task/KynrzFL-QUeRgmfBseZKwA/artifacts/public/build/firefox-54.0.en-US.mac.dmg 19:06:05 INFO - Running post-action listener: _resource_record_post_action 19:06:05 INFO - Running post-action listener: set_extra_try_arguments 19:06:05 INFO - [mozharness: 2017-04-20 02:06:05.778547Z] Finished download-and-extract step (success) 19:06:05 INFO - [mozharness: 2017-04-20 02:06:05.778674Z] Running populate-webroot step. 19:06:05 INFO - Running pre-action listener: _resource_record_pre_action 19:06:05 INFO - Running main action method: populate_webroot 19:06:05 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 19:06:05 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 19:06:05 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 19:06:05 INFO - '--tppagecycles', 19:06:05 INFO - '7'], 19:06:05 INFO - 'tests': ['tsvgm']}}, 19:06:05 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 19:06:05 INFO - 'tests': ['tresize', 'tcanvasmark']}, 19:06:05 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 19:06:05 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 19:06:05 INFO - 'tests': ['dromaeo_css', 'kraken']}, 19:06:05 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 19:06:05 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 19:06:05 INFO - 'talos_options': ['--disable-e10s'], 19:06:05 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:06:05 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 19:06:05 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:06:05 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 19:06:05 INFO - 'talos_options': ['--disable-e10s'], 19:06:05 INFO - 'tests': ['damp', 'tps']}, 19:06:05 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 19:06:05 INFO - 'tests': ['damp', 'tps']}, 19:06:05 INFO - 'g3': {'talos_options': ['--disable-e10s'], 19:06:05 INFO - 'tests': ['dromaeo_dom']}, 19:06:05 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 19:06:05 INFO - 'g4': {'talos_options': ['--disable-e10s'], 19:06:05 INFO - 'tests': ['basic_compositor_video']}, 19:06:05 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 19:06:05 INFO - 'other': {'talos_options': ['--disable-e10s'], 19:06:05 INFO - 'tests': ['a11yr', 19:06:05 INFO - 'ts_paint', 19:06:05 INFO - 'tpaint', 19:06:05 INFO - 'sessionrestore', 19:06:05 INFO - 'sessionrestore_no_auto_restore', 19:06:05 INFO - 'tabpaint']}, 19:06:05 INFO - 'other-e10s': {'tests': ['a11yr', 19:06:05 INFO - 'ts_paint', 19:06:05 INFO - 'tpaint', 19:06:05 INFO - 'sessionrestore', 19:06:05 INFO - 'sessionrestore_no_auto_restore', 19:06:05 INFO - 'tabpaint']}, 19:06:05 INFO - 'other-e10s_l64': {'tests': ['a11yr', 19:06:05 INFO - 'ts_paint', 19:06:05 INFO - 'tpaint', 19:06:05 INFO - 'sessionrestore', 19:06:05 INFO - 'sessionrestore_no_auto_restore', 19:06:05 INFO - 'tabpaint']}, 19:06:05 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 19:06:05 INFO - 'ts_paint', 19:06:05 INFO - 'tpaint', 19:06:05 INFO - 'sessionrestore', 19:06:05 INFO - 'sessionrestore_no_auto_restore', 19:06:05 INFO - 'tabpaint']}, 19:06:05 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 19:06:05 INFO - 'tests': ['a11yr', 19:06:05 INFO - 'ts_paint', 19:06:05 INFO - 'tpaint', 19:06:05 INFO - 'sessionrestore', 19:06:05 INFO - 'sessionrestore_no_auto_restore', 19:06:05 INFO - 'tabpaint']}, 19:06:05 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 19:06:05 INFO - 'tests': ['a11yr', 19:06:05 INFO - 'ts_paint', 19:06:05 INFO - 'tpaint', 19:06:05 INFO - 'sessionrestore', 19:06:05 INFO - 'sessionrestore_no_auto_restore', 19:06:05 INFO - 'tabpaint']}, 19:06:05 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 19:06:05 INFO - 'tests': ['tsvgx', 19:06:05 INFO - 'tsvgr_opacity', 19:06:05 INFO - 'tart', 19:06:05 INFO - 'tscrollx', 19:06:05 INFO - 'cart', 19:06:05 INFO - 'tsvg_static']}, 19:06:05 INFO - 'svgr-e10s': {'tests': ['tsvgx', 19:06:05 INFO - 'tsvgr_opacity', 19:06:05 INFO - 'tart', 19:06:05 INFO - 'tscrollx', 19:06:05 INFO - 'cart', 19:06:05 INFO - 'tsvg_static']}, 19:06:05 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 19:06:05 INFO - 'talos_options': ['--disable-e10s'], 19:06:05 INFO - 'tests': ['tp5o']}, 19:06:05 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 19:06:05 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 19:06:05 INFO - 'talos_options': ['--disable-e10s', 19:06:05 INFO - '--xperf_path', 19:06:05 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:06:05 INFO - 'tests': ['tp5n']}, 19:06:05 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 19:06:05 INFO - 'talos_options': ['--xperf_path', 19:06:05 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:06:05 INFO - 'tests': ['tp5n']}}, 19:06:05 INFO - 'talos.zip': {'path': '', 19:06:05 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 19:06:05 INFO - Running post-action listener: _resource_record_post_action 19:06:05 INFO - [mozharness: 2017-04-20 02:06:05.796834Z] Finished populate-webroot step (success) 19:06:05 INFO - [mozharness: 2017-04-20 02:06:05.796924Z] Running create-virtualenv step. 19:06:05 INFO - Running pre-action listener: _resource_record_pre_action 19:06:05 INFO - Running main action method: create_virtualenv 19:06:05 INFO - Creating virtualenv /builds/slave/test/build/venv 19:06:05 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 19:06:05 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 19:06:05 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 19:06:05 INFO - Using real prefix '/tools/python27' 19:06:05 INFO - New python executable in /builds/slave/test/build/venv/bin/python 19:06:06 INFO - Installing distribute.............................................................................................................................................................................................done. 19:06:09 INFO - Installing pip.................done. 19:06:09 INFO - Return code: 0 19:06:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 19:06:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 19:06:09 INFO - Reading from file tmpfile_stdout 19:06:09 INFO - Output received: 19:06:09 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) 19:06:09 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 19:06:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:06:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:06:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:06:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:06:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:06:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:06:09 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x108450b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108453768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff34a5da160>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10822ed30>, '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 0x108155db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108223be8>, '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.QwNtBq01ym/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.zOsqx2452J/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ng/csmfm9x9681blsv1wkb387f800000w/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 19:06:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 19:06:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 19:06:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.QwNtBq01ym/Render', 19:06:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:06:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:06:09 INFO - 'HOME': '/Users/cltbld', 19:06:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:06:09 INFO - 'LOGNAME': 'cltbld', 19:06:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:06:09 INFO - 'MOZ_NO_REMOTE': '1', 19:06:09 INFO - 'NO_EM_RESTART': '1', 19:06:09 INFO - 'PAGER': '/bin/cat', 19:06:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:06:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:06:09 INFO - 'PWD': '/builds/slave/test', 19:06:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:06:09 INFO - 'SHELL': '/bin/bash', 19:06:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.zOsqx2452J/Listeners', 19:06:09 INFO - 'TMPDIR': '/var/folders/ng/csmfm9x9681blsv1wkb387f800000w/T/', 19:06:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:06:09 INFO - 'USER': 'cltbld', 19:06:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:06:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:06:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:06:09 INFO - 'XPC_FLAGS': '0x0', 19:06:09 INFO - 'XPC_SERVICE_NAME': '0', 19:06:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:06:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:06:10 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 19:06:10 INFO - Cleaning up... 19:06:10 INFO - Return code: 0 19:06:10 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 19:06:10 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')]} 19:06:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:06:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:06:10 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')]} 19:06:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:06:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:06:10 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 0x108450b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108453768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff34a5da160>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10822ed30>, '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 0x108155db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108223be8>, '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.QwNtBq01ym/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.zOsqx2452J/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ng/csmfm9x9681blsv1wkb387f800000w/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 19:06:10 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 19:06:10 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 19:06:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.QwNtBq01ym/Render', 19:06:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:06:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:06:10 INFO - 'HOME': '/Users/cltbld', 19:06:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:06:10 INFO - 'LOGNAME': 'cltbld', 19:06:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:06:10 INFO - 'MOZ_NO_REMOTE': '1', 19:06:10 INFO - 'NO_EM_RESTART': '1', 19:06:10 INFO - 'PAGER': '/bin/cat', 19:06:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:06:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:06:10 INFO - 'PWD': '/builds/slave/test', 19:06:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:06:10 INFO - 'SHELL': '/bin/bash', 19:06:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.zOsqx2452J/Listeners', 19:06:10 INFO - 'TMPDIR': '/var/folders/ng/csmfm9x9681blsv1wkb387f800000w/T/', 19:06:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:06:10 INFO - 'USER': 'cltbld', 19:06:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:06:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:06:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:06:10 INFO - 'XPC_FLAGS': '0x0', 19:06:10 INFO - 'XPC_SERVICE_NAME': '0', 19:06:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:06:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:06:10 INFO - Downloading/unpacking psutil>=3.1.1 19:06:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:06:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:06:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:06:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:06:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:06:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:06:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 19:06:13 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:06:13 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:06:13 INFO - Installing collected packages: psutil 19:06:13 INFO - Running setup.py install for psutil 19:06:13 INFO - building 'psutil._psutil_osx' extension 19:06:13 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 19:06:14 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 19:06:14 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 19:06:14 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 19:06:14 INFO - building 'psutil._psutil_posix' extension 19:06:14 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 19:06:14 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 19:06:14 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 19:06:14 INFO - ^ 19:06:14 INFO - 1 warning generated. 19:06:14 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 19:06:14 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:06:14 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:06:14 INFO - Successfully installed psutil 19:06:14 INFO - Cleaning up... 19:06:14 INFO - Return code: 0 19:06:14 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 19:06: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')]} 19:06:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:06:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:06: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')]} 19:06:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:06:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:06: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x108450b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108453768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff34a5da160>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10822ed30>, '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 0x108155db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108223be8>, '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.QwNtBq01ym/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.zOsqx2452J/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ng/csmfm9x9681blsv1wkb387f800000w/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 19:06: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 19:06: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 mozsystemmonitor==0.3 19:06:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.QwNtBq01ym/Render', 19:06:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:06:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:06:14 INFO - 'HOME': '/Users/cltbld', 19:06:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:06:14 INFO - 'LOGNAME': 'cltbld', 19:06:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:06:14 INFO - 'MOZ_NO_REMOTE': '1', 19:06:14 INFO - 'NO_EM_RESTART': '1', 19:06:14 INFO - 'PAGER': '/bin/cat', 19:06:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:06:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:06:14 INFO - 'PWD': '/builds/slave/test', 19:06:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:06:14 INFO - 'SHELL': '/bin/bash', 19:06:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.zOsqx2452J/Listeners', 19:06:14 INFO - 'TMPDIR': '/var/folders/ng/csmfm9x9681blsv1wkb387f800000w/T/', 19:06:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:06:14 INFO - 'USER': 'cltbld', 19:06:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:06:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:06:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:06:14 INFO - 'XPC_FLAGS': '0x0', 19:06:14 INFO - 'XPC_SERVICE_NAME': '0', 19:06:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:06:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:06:15 INFO - Downloading/unpacking mozsystemmonitor==0.3 19:06: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 19:06: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 19:06: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 19:06: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 19:06: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 19:06: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 19:06:17 INFO - Downloading mozsystemmonitor-0.3.tar.gz 19:06:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 19:06:17 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 19:06:17 INFO - Installing collected packages: mozsystemmonitor 19:06:17 INFO - Running setup.py install for mozsystemmonitor 19:06:18 INFO - Successfully installed mozsystemmonitor 19:06:18 INFO - Cleaning up... 19:06:18 INFO - Return code: 0 19:06:18 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 19:06: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')]} 19:06:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:06:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:06: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')]} 19:06:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:06:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:06:19 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 0x108450b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108453768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff34a5da160>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10822ed30>, '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 0x108155db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108223be8>, '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.QwNtBq01ym/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.zOsqx2452J/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ng/csmfm9x9681blsv1wkb387f800000w/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 19:06:19 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 19:06:19 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 19:06:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.QwNtBq01ym/Render', 19:06:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:06:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:06:19 INFO - 'HOME': '/Users/cltbld', 19:06:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:06:19 INFO - 'LOGNAME': 'cltbld', 19:06:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:06:19 INFO - 'MOZ_NO_REMOTE': '1', 19:06:19 INFO - 'NO_EM_RESTART': '1', 19:06:19 INFO - 'PAGER': '/bin/cat', 19:06:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:06:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:06:19 INFO - 'PWD': '/builds/slave/test', 19:06:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:06:19 INFO - 'SHELL': '/bin/bash', 19:06:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.zOsqx2452J/Listeners', 19:06:19 INFO - 'TMPDIR': '/var/folders/ng/csmfm9x9681blsv1wkb387f800000w/T/', 19:06:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:06:19 INFO - 'USER': 'cltbld', 19:06:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:06:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:06:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:06:19 INFO - 'XPC_FLAGS': '0x0', 19:06:19 INFO - 'XPC_SERVICE_NAME': '0', 19:06:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:06:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:06:19 INFO - Downloading/unpacking jsonschema==2.5.1 19:06: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 19:06: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 19:06: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 19:06: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 19:06: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 19:06: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 19:06:22 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 19:06:22 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 19:06: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 19:06: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 19:06: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 19:06: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 19:06: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 19:06: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 19:06:22 INFO - Downloading functools32-3.2.3-2.tar.gz 19:06:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 19:06:22 INFO - warning: no files found matching '*.txt' 19:06:22 INFO - no previously-included directories found matching 'build' 19:06:22 INFO - no previously-included directories found matching 'dist' 19:06:22 INFO - no previously-included directories found matching '.git*' 19:06:22 INFO - Installing collected packages: jsonschema, functools32 19:06:22 INFO - Running setup.py install for functools32 19:06:22 INFO - warning: no files found matching '*.txt' 19:06:22 INFO - no previously-included directories found matching 'build' 19:06:22 INFO - no previously-included directories found matching 'dist' 19:06:22 INFO - no previously-included directories found matching '.git*' 19:06:22 INFO - Successfully installed jsonschema functools32 19:06:22 INFO - Cleaning up... 19:06:22 INFO - Return code: 0 19:06:22 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 19:06:22 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')]} 19:06:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:06:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:06:22 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')]} 19:06:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:06:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:06:22 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 0x108450b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108453768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff34a5da160>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10822ed30>, '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 0x108155db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108223be8>, '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.QwNtBq01ym/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.zOsqx2452J/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ng/csmfm9x9681blsv1wkb387f800000w/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 19:06:22 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 19:06:22 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 19:06:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.QwNtBq01ym/Render', 19:06:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:06:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:06:22 INFO - 'HOME': '/Users/cltbld', 19:06:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:06:22 INFO - 'LOGNAME': 'cltbld', 19:06:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:06:22 INFO - 'MOZ_NO_REMOTE': '1', 19:06:22 INFO - 'NO_EM_RESTART': '1', 19:06:22 INFO - 'PAGER': '/bin/cat', 19:06:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:06:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:06:22 INFO - 'PWD': '/builds/slave/test', 19:06:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:06:22 INFO - 'SHELL': '/bin/bash', 19:06:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.zOsqx2452J/Listeners', 19:06:22 INFO - 'TMPDIR': '/var/folders/ng/csmfm9x9681blsv1wkb387f800000w/T/', 19:06:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:06:22 INFO - 'USER': 'cltbld', 19:06:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:06:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:06:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:06:22 INFO - 'XPC_FLAGS': '0x0', 19:06:22 INFO - 'XPC_SERVICE_NAME': '0', 19:06:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:06:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:06:23 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 19:06:23 INFO - Cleaning up... 19:06:23 INFO - Return code: 0 19:06:23 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 19:06: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')]} 19:06:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:06:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:06: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')]} 19:06:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:06:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:06:23 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 0x108450b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108453768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff34a5da160>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10822ed30>, '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 0x108155db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108223be8>, '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.QwNtBq01ym/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.zOsqx2452J/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ng/csmfm9x9681blsv1wkb387f800000w/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 19:06:23 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 19:06:23 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 19:06:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.QwNtBq01ym/Render', 19:06:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:06:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:06:23 INFO - 'HOME': '/Users/cltbld', 19:06:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:06:23 INFO - 'LOGNAME': 'cltbld', 19:06:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:06:23 INFO - 'MOZ_NO_REMOTE': '1', 19:06:23 INFO - 'NO_EM_RESTART': '1', 19:06:23 INFO - 'PAGER': '/bin/cat', 19:06:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:06:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:06:23 INFO - 'PWD': '/builds/slave/test', 19:06:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:06:23 INFO - 'SHELL': '/bin/bash', 19:06:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.zOsqx2452J/Listeners', 19:06:23 INFO - 'TMPDIR': '/var/folders/ng/csmfm9x9681blsv1wkb387f800000w/T/', 19:06:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:06:23 INFO - 'USER': 'cltbld', 19:06:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:06:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:06:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:06:23 INFO - 'XPC_FLAGS': '0x0', 19:06:23 INFO - 'XPC_SERVICE_NAME': '0', 19:06:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:06:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:06:23 INFO - Downloading/unpacking blobuploader==1.2.4 19:06:23 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 19:06:23 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 19:06:23 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 19:06:23 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 19:06:23 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 19:06:23 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 19:06:25 INFO - Downloading blobuploader-1.2.4.tar.gz 19:06:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 19:06:26 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 19:06:26 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 19:06:26 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 19:06:26 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 19:06:26 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 19:06:26 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 19:06:26 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 19:06:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 19:06:26 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 19:06:26 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 19:06:26 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 19:06:26 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 19:06:26 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 19:06:26 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 19:06:26 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 19:06:27 INFO - Downloading docopt-0.6.1.tar.gz 19:06:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 19:06:27 INFO - Installing collected packages: blobuploader, requests, docopt 19:06:27 INFO - Running setup.py install for blobuploader 19:06:27 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 19:06:27 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 19:06:27 INFO - Running setup.py install for requests 19:06:28 INFO - Running setup.py install for docopt 19:06:28 INFO - Successfully installed blobuploader requests docopt 19:06:28 INFO - Cleaning up... 19:06:28 INFO - Return code: 0 19:06:28 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:06: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')]} 19:06:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:06:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:06: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')]} 19:06:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:06:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:06:28 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 0x108450b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108453768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff34a5da160>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10822ed30>, '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 0x108155db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108223be8>, '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.QwNtBq01ym/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.zOsqx2452J/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ng/csmfm9x9681blsv1wkb387f800000w/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 19:06:28 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 19:06:28 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 19:06:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.QwNtBq01ym/Render', 19:06:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:06:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:06:28 INFO - 'HOME': '/Users/cltbld', 19:06:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:06:28 INFO - 'LOGNAME': 'cltbld', 19:06:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:06:28 INFO - 'MOZ_NO_REMOTE': '1', 19:06:28 INFO - 'NO_EM_RESTART': '1', 19:06:28 INFO - 'PAGER': '/bin/cat', 19:06:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:06:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:06:28 INFO - 'PWD': '/builds/slave/test', 19:06:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:06:28 INFO - 'SHELL': '/bin/bash', 19:06:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.zOsqx2452J/Listeners', 19:06:28 INFO - 'TMPDIR': '/var/folders/ng/csmfm9x9681blsv1wkb387f800000w/T/', 19:06:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:06:28 INFO - 'USER': 'cltbld', 19:06:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:06:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:06:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:06:28 INFO - 'XPC_FLAGS': '0x0', 19:06:28 INFO - 'XPC_SERVICE_NAME': '0', 19:06:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:06:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:06:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:06:28 INFO - Running setup.py (path:/var/folders/ng/csmfm9x9681blsv1wkb387f800000w/T/pip-BTMxos-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:06:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:06:28 INFO - Running setup.py (path:/var/folders/ng/csmfm9x9681blsv1wkb387f800000w/T/pip-KYsbww-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:06:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:06:28 INFO - Running setup.py (path:/var/folders/ng/csmfm9x9681blsv1wkb387f800000w/T/pip-_P8V81-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:06:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:06:28 INFO - Running setup.py (path:/var/folders/ng/csmfm9x9681blsv1wkb387f800000w/T/pip-DvRn8S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:06:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:06:28 INFO - Running setup.py (path:/var/folders/ng/csmfm9x9681blsv1wkb387f800000w/T/pip-00oLxD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:06:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:06:29 INFO - Running setup.py (path:/var/folders/ng/csmfm9x9681blsv1wkb387f800000w/T/pip-vyfKtI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:06:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:06:29 INFO - Running setup.py (path:/var/folders/ng/csmfm9x9681blsv1wkb387f800000w/T/pip-seUtMa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:06:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:06:29 INFO - Running setup.py (path:/var/folders/ng/csmfm9x9681blsv1wkb387f800000w/T/pip-x7LcqJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:06:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:06:29 INFO - Running setup.py (path:/var/folders/ng/csmfm9x9681blsv1wkb387f800000w/T/pip-MdxbI_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:06:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:06:29 INFO - Running setup.py (path:/var/folders/ng/csmfm9x9681blsv1wkb387f800000w/T/pip-4ffhF3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:06:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:06:29 INFO - Running setup.py (path:/var/folders/ng/csmfm9x9681blsv1wkb387f800000w/T/pip-pbHiSj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:06:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:06:29 INFO - Running setup.py (path:/var/folders/ng/csmfm9x9681blsv1wkb387f800000w/T/pip-aqlZTf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:06:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:06:29 INFO - Running setup.py (path:/var/folders/ng/csmfm9x9681blsv1wkb387f800000w/T/pip-_yrLn3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:06:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:06:29 INFO - Running setup.py (path:/var/folders/ng/csmfm9x9681blsv1wkb387f800000w/T/pip-OJI_9X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:06:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:06:29 INFO - Running setup.py (path:/var/folders/ng/csmfm9x9681blsv1wkb387f800000w/T/pip-yeMAPt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:06:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:06:30 INFO - Running setup.py (path:/var/folders/ng/csmfm9x9681blsv1wkb387f800000w/T/pip-kDwu90-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:06:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:06:30 INFO - Running setup.py (path:/var/folders/ng/csmfm9x9681blsv1wkb387f800000w/T/pip-Rx8Tie-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:06:30 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 19:06:30 INFO - Running setup.py install for manifestparser 19:06:30 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 19:06:30 INFO - Running setup.py install for mozcrash 19:06:30 INFO - Running setup.py install for mozdebug 19:06:30 INFO - Running setup.py install for mozdevice 19:06:30 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 19:06:30 INFO - Installing dm script to /builds/slave/test/build/venv/bin 19:06:30 INFO - Running setup.py install for mozfile 19:06:31 INFO - Running setup.py install for mozhttpd 19:06:31 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 19:06:31 INFO - Running setup.py install for mozinfo 19:06:31 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 19:06:31 INFO - Running setup.py install for mozInstall 19:06:31 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 19:06:31 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 19:06:31 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 19:06:31 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 19:06:31 INFO - Running setup.py install for mozleak 19:06:31 INFO - Running setup.py install for mozlog 19:06:31 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 19:06:31 INFO - Running setup.py install for moznetwork 19:06:31 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 19:06:31 INFO - Running setup.py install for mozprocess 19:06:32 INFO - Running setup.py install for mozprofile 19:06:32 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 19:06:32 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 19:06:32 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 19:06:32 INFO - Running setup.py install for mozrunner 19:06:32 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 19:06:32 INFO - Running setup.py install for mozscreenshot 19:06:32 INFO - Running setup.py install for moztest 19:06:32 INFO - Running setup.py install for mozversion 19:06:32 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 19:06:32 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 19:06:32 INFO - Cleaning up... 19:06:32 INFO - Return code: 0 19:06:32 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:06:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:06:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:06:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:06:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:06:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:06:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:06:32 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 0x108450b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108453768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff34a5da160>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10822ed30>, '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 0x108155db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108223be8>, '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.QwNtBq01ym/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.zOsqx2452J/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ng/csmfm9x9681blsv1wkb387f800000w/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 19:06:32 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 19:06:32 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 19:06:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.QwNtBq01ym/Render', 19:06:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:06:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:06:32 INFO - 'HOME': '/Users/cltbld', 19:06:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:06:32 INFO - 'LOGNAME': 'cltbld', 19:06:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:06:32 INFO - 'MOZ_NO_REMOTE': '1', 19:06:32 INFO - 'NO_EM_RESTART': '1', 19:06:32 INFO - 'PAGER': '/bin/cat', 19:06:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:06:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:06:32 INFO - 'PWD': '/builds/slave/test', 19:06:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:06:32 INFO - 'SHELL': '/bin/bash', 19:06:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.zOsqx2452J/Listeners', 19:06:32 INFO - 'TMPDIR': '/var/folders/ng/csmfm9x9681blsv1wkb387f800000w/T/', 19:06:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:06:32 INFO - 'USER': 'cltbld', 19:06:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:06:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:06:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:06:32 INFO - 'XPC_FLAGS': '0x0', 19:06:32 INFO - 'XPC_SERVICE_NAME': '0', 19:06:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:06:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:06:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:06:33 INFO - Running setup.py (path:/var/folders/ng/csmfm9x9681blsv1wkb387f800000w/T/pip-wnC9B4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:06:33 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)) 19:06:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:06:33 INFO - Running setup.py (path:/var/folders/ng/csmfm9x9681blsv1wkb387f800000w/T/pip-YYzL5v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:06:33 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)) 19:06:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:06:33 INFO - Running setup.py (path:/var/folders/ng/csmfm9x9681blsv1wkb387f800000w/T/pip-uKTg5z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:06:33 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)) 19:06:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:06:33 INFO - Running setup.py (path:/var/folders/ng/csmfm9x9681blsv1wkb387f800000w/T/pip-NY46xF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:06:33 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)) 19:06:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:06:33 INFO - Running setup.py (path:/var/folders/ng/csmfm9x9681blsv1wkb387f800000w/T/pip-EtXJsO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:06:33 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)) 19:06:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:06:33 INFO - Running setup.py (path:/var/folders/ng/csmfm9x9681blsv1wkb387f800000w/T/pip-xzpgCL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:06:33 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)) 19:06:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:06:33 INFO - Running setup.py (path:/var/folders/ng/csmfm9x9681blsv1wkb387f800000w/T/pip-oSxK7w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:06:33 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)) 19:06:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:06:33 INFO - Running setup.py (path:/var/folders/ng/csmfm9x9681blsv1wkb387f800000w/T/pip-0_QiQV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:06:34 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)) 19:06:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:06:34 INFO - Running setup.py (path:/var/folders/ng/csmfm9x9681blsv1wkb387f800000w/T/pip-o2DwaC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:06:34 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)) 19:06:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:06:34 INFO - Running setup.py (path:/var/folders/ng/csmfm9x9681blsv1wkb387f800000w/T/pip-cDSCAS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:06:34 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)) 19:06:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:06:34 INFO - Running setup.py (path:/var/folders/ng/csmfm9x9681blsv1wkb387f800000w/T/pip-UTruHP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:06:34 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)) 19:06:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:06:34 INFO - Running setup.py (path:/var/folders/ng/csmfm9x9681blsv1wkb387f800000w/T/pip-dsS5Ti-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:06:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 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)) 19:06:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:06:34 INFO - Running setup.py (path:/var/folders/ng/csmfm9x9681blsv1wkb387f800000w/T/pip-jkZfoz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:06:34 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)) 19:06:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:06:34 INFO - Running setup.py (path:/var/folders/ng/csmfm9x9681blsv1wkb387f800000w/T/pip-Uc0TNP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:06:34 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)) 19:06:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:06:34 INFO - Running setup.py (path:/var/folders/ng/csmfm9x9681blsv1wkb387f800000w/T/pip-7iLy4w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:06:34 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)) 19:06:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:06:34 INFO - Running setup.py (path:/var/folders/ng/csmfm9x9681blsv1wkb387f800000w/T/pip-nxGN4r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:06:34 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)) 19:06:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:06:34 INFO - Running setup.py (path:/var/folders/ng/csmfm9x9681blsv1wkb387f800000w/T/pip-QMgXEG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:06:34 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)) 19:06:34 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)) 19:06:34 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)) 19:06:34 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)) 19:06:34 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)) 19:06:34 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)) 19:06:34 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 19:06:34 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 19:06:34 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 19:06:34 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 19:06:34 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 19:06:34 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 19:06:34 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 19:06:37 INFO - Downloading blessings-1.6.tar.gz 19:06:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 19:06:37 INFO - Installing collected packages: blessings 19:06:37 INFO - Running setup.py install for blessings 19:06:37 INFO - Successfully installed blessings 19:06:37 INFO - Cleaning up... 19:06:37 INFO - Return code: 0 19:06:37 INFO - Done creating virtualenv /builds/slave/test/build/venv. 19:06:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:06:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:06:38 INFO - Reading from file tmpfile_stdout 19:06:38 INFO - Current package versions: 19:06:38 INFO - blessings == 1.6 19:06:38 INFO - blobuploader == 1.2.4 19:06:38 INFO - docopt == 0.6.1 19:06:38 INFO - functools32 == 3.2.3-2 19:06:38 INFO - jsonschema == 2.5.1 19:06:38 INFO - manifestparser == 1.1 19:06:38 INFO - mozInstall == 1.12 19:06:38 INFO - mozcrash == 1.0 19:06:38 INFO - mozdebug == 0.1 19:06:38 INFO - mozdevice == 0.49 19:06:38 INFO - mozfile == 1.2 19:06:38 INFO - mozhttpd == 0.7 19:06:38 INFO - mozinfo == 0.9 19:06:38 INFO - mozleak == 0.1 19:06:38 INFO - mozlog == 3.4 19:06:38 INFO - moznetwork == 0.27 19:06:38 INFO - mozprocess == 0.25 19:06:38 INFO - mozprofile == 0.28 19:06:38 INFO - mozrunner == 6.13 19:06:38 INFO - mozscreenshot == 0.1 19:06:38 INFO - mozsystemmonitor == 0.3 19:06:38 INFO - moztest == 0.8 19:06:38 INFO - mozversion == 1.4 19:06:38 INFO - psutil == 3.1.1 19:06:38 INFO - requests == 1.2.3 19:06:38 INFO - wsgiref == 0.1.2 19:06:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:06:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:06:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:06:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:06:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:06:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:06:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:06:38 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 0x108450b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108453768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff34a5da160>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10822ed30>, '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 0x108155db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108223be8>, '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.QwNtBq01ym/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.zOsqx2452J/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ng/csmfm9x9681blsv1wkb387f800000w/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 19:06:38 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 19:06:38 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 19:06:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.QwNtBq01ym/Render', 19:06:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:06:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:06:38 INFO - 'HOME': '/Users/cltbld', 19:06:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:06:38 INFO - 'LOGNAME': 'cltbld', 19:06:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:06:38 INFO - 'MOZ_NO_REMOTE': '1', 19:06:38 INFO - 'NO_EM_RESTART': '1', 19:06:38 INFO - 'PAGER': '/bin/cat', 19:06:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:06:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:06:38 INFO - 'PWD': '/builds/slave/test', 19:06:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:06:38 INFO - 'SHELL': '/bin/bash', 19:06:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.zOsqx2452J/Listeners', 19:06:38 INFO - 'TMPDIR': '/var/folders/ng/csmfm9x9681blsv1wkb387f800000w/T/', 19:06:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:06:38 INFO - 'USER': 'cltbld', 19:06:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:06:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:06:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:06:38 INFO - 'XPC_FLAGS': '0x0', 19:06:38 INFO - 'XPC_SERVICE_NAME': '0', 19:06:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:06:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:06:38 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)) 19:06:38 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)) 19:06:38 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)) 19:06:38 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)) 19:06:38 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)) 19:06:38 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)) 19:06:38 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)) 19:06:38 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)) 19:06:38 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)) 19:06:38 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)) 19:06:38 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)) 19:06:38 INFO - Cleaning up... 19:06:38 INFO - Return code: 0 19:06:38 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 19:06:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:06:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:06:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:06:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:06:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:06:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:06:38 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x108450b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108453768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff34a5da160>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10822ed30>, '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 0x108155db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108223be8>, '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.QwNtBq01ym/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.zOsqx2452J/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ng/csmfm9x9681blsv1wkb387f800000w/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 19:06:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 19:06:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 19:06:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.QwNtBq01ym/Render', 19:06:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:06:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:06:38 INFO - 'HOME': '/Users/cltbld', 19:06:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:06:38 INFO - 'LOGNAME': 'cltbld', 19:06:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:06:38 INFO - 'MOZ_NO_REMOTE': '1', 19:06:38 INFO - 'NO_EM_RESTART': '1', 19:06:38 INFO - 'PAGER': '/bin/cat', 19:06:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:06:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:06:38 INFO - 'PWD': '/builds/slave/test', 19:06:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:06:38 INFO - 'SHELL': '/bin/bash', 19:06:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.zOsqx2452J/Listeners', 19:06:38 INFO - 'TMPDIR': '/var/folders/ng/csmfm9x9681blsv1wkb387f800000w/T/', 19:06:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:06:38 INFO - 'USER': 'cltbld', 19:06:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:06:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:06:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:06:38 INFO - 'XPC_FLAGS': '0x0', 19:06:38 INFO - 'XPC_SERVICE_NAME': '0', 19:06:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:06:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:06:38 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 19:06:38 INFO - Cleaning up... 19:06:38 INFO - Return code: 0 19:06:38 INFO - Running post-action listener: _resource_record_post_action 19:06:38 INFO - Running post-action listener: _start_resource_monitoring 19:06:38 INFO - Starting resource monitoring. 19:06:38 INFO - [mozharness: 2017-04-20 02:06:38.734149Z] Finished create-virtualenv step (success) 19:06:38 INFO - [mozharness: 2017-04-20 02:06:38.735161Z] Running install step. 19:06:38 INFO - Running pre-action listener: _resource_record_pre_action 19:06:38 INFO - Running main action method: install 19:06:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:06:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:06:38 INFO - Reading from file tmpfile_stdout 19:06:38 INFO - Detecting whether we're running mozinstall >=1.0... 19:06:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 19:06:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 19:06:39 INFO - Reading from file tmpfile_stdout 19:06:39 INFO - Output received: 19:06:39 INFO - Usage: mozinstall [options] installer 19:06:39 INFO - Options: 19:06:39 INFO - -h, --help show this help message and exit 19:06:39 INFO - -d DEST, --destination=DEST 19:06:39 INFO - Directory to install application into. [default: 19:06:39 INFO - "/builds/slave/test"] 19:06:39 INFO - --app=APP Application being installed. [default: firefox] 19:06:39 INFO - mkdir: /builds/slave/test/build/application 19:06:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-54.0.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 19:06:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-54.0.en-US.mac.dmg --destination /builds/slave/test/build/application 19:06:53 INFO - Reading from file tmpfile_stdout 19:06:53 INFO - Output received: 19:06:53 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 19:06:53 INFO - Running post-action listener: _resource_record_post_action 19:06:53 INFO - [mozharness: 2017-04-20 02:06:53.856352Z] Finished install step (success) 19:06:53 INFO - [mozharness: 2017-04-20 02:06:53.856525Z] Running run-tests step. 19:06:53 INFO - Running pre-action listener: _resource_record_pre_action 19:06:53 INFO - Running main action method: run_tests 19:06:53 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 19:06:53 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 19:06:53 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 19:06:53 INFO - 2017-04-19 19:06:53.871 screenresolution[1624:7386] starting screenresolution argv=screenresolution get 19:06:53 INFO - 2017-04-19 19:06:53.873 screenresolution[1624:7386] Display 0: 1600x1200x32@60 19:06:53 INFO - 2017-04-19 19:06:53.879 screenresolution[1625:7388] starting screenresolution argv=screenresolution list 19:06:53 INFO - Available Modes on Display 0 19:06:53 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 19:06:53 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 19:06:53 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 19:06:53 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 19:06:54 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 19:06:54 INFO - Intel Iris: 19:06:54 INFO - Chipset Model: Intel Iris 19:06:54 INFO - Type: GPU 19:06:54 INFO - Bus: Built-In 19:06:54 INFO - VRAM (Dynamic, Max): 1536 MB 19:06:54 INFO - Vendor: Intel (0x8086) 19:06:54 INFO - Device ID: 0x0a2e 19:06:54 INFO - Revision ID: 0x0009 19:06:54 INFO - Displays: 19:06:54 INFO - Display: 19:06:54 INFO - Resolution: 1600 x 1200 @ 60 Hz 19:06:54 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 19:06:54 INFO - Display Serial Number: 1600x1200 60 19:06:54 INFO - Main Display: Yes 19:06:54 INFO - Mirror: Off 19:06:54 INFO - Online: Yes 19:06:54 INFO - Rotation: Supported 19:06:54 INFO - Return code: 0 19:06:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 19:06:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 19:06:54 INFO - Python 2.7.3 19:06:54 INFO - Return code: 0 19:06:54 INFO - grabbing minidump binary from tooltool 19:06:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:06:54 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 0x10822ed30>, '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 0x108155db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108223be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 19:06:54 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 19:06:54 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 19:06:54 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 19:06:54 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 19:06:54 INFO - Return code: 0 19:06:54 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 19:06:54 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 19:06:54 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 19:06:54 INFO - ENV: RUST_BACKTRACE is now 1 19:06:54 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 19:06:54 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 19:06:54 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/KynrzFL-QUeRgmfBseZKwA/artifacts/public/build/firefox-54.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0352', '--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 19:06:54 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/KynrzFL-QUeRgmfBseZKwA/artifacts/public/build/firefox-54.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0352 --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 19:06:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.QwNtBq01ym/Render', 19:06:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:06:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:06:54 INFO - 'HOME': '/Users/cltbld', 19:06:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:06:54 INFO - 'LOGNAME': 'cltbld', 19:06:54 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 19:06:54 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 19:06:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:06:54 INFO - 'MOZ_NO_REMOTE': '1', 19:06:54 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 19:06:54 INFO - 'NO_EM_RESTART': '1', 19:06:54 INFO - 'PAGER': '/bin/cat', 19:06:54 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:06:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:06:54 INFO - 'PWD': '/builds/slave/test', 19:06:54 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 19:06:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:06:54 INFO - 'RUST_BACKTRACE': '1', 19:06:54 INFO - 'SHELL': '/bin/bash', 19:06:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.zOsqx2452J/Listeners', 19:06:54 INFO - 'TMPDIR': '/var/folders/ng/csmfm9x9681blsv1wkb387f800000w/T/', 19:06:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:06:54 INFO - 'USER': 'cltbld', 19:06:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:06:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:06:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:06:54 INFO - 'XPC_FLAGS': '0x0', 19:06:54 INFO - 'XPC_SERVICE_NAME': '0', 19:06:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:06:54 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/KynrzFL-QUeRgmfBseZKwA/artifacts/public/build/firefox-54.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0352', '--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 19:06:54 INFO - mozversion application_buildid: 20170419174827 19:06:54 INFO - mozversion application_changeset: 584df356a66b1f5d48c73625dd08589a11029845 19:06:54 INFO - mozversion application_display_name: Firefox 19:06:54 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 19:06:54 INFO - mozversion application_name: Firefox 19:06:54 INFO - mozversion application_remotingname: firefox 19:06:54 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 19:06:54 INFO - mozversion application_vendor: Mozilla 19:06:54 INFO - mozversion application_version: 54.0 19:06:54 INFO - mozversion platform_buildid: 20170419174827 19:06:54 INFO - mozversion platform_changeset: 584df356a66b1f5d48c73625dd08589a11029845 19:06:54 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 19:06:54 INFO - mozversion platform_version: 54.0 19:06:54 INFO - using testdate: 1492654014 19:06:54 INFO - actual date: 1492654014 19:06:54 INFO - starting webserver on 'localhost:49245' 19:06:54 INFO - SUITE-START | Running 2 tests 19:06:54 INFO - TEST-START | dromaeo_css 19:06:54 INFO - operating with platform_type : mac_ 19:06:54 INFO - Initialising browser for dromaeo_css test... 19:06:54 INFO - TEST-INFO | started process 1635 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/ng/csmfm9x9681blsv1wkb387f800000w/T/tmpSnTwco/profile http://localhost:49245/getInfo.html) 19:06:57 INFO - PROCESS | 1635 | __metrics Screen width/height:1600/1200 19:06:57 INFO - PROCESS | 1635 | colorDepth:24 19:06:57 INFO - PROCESS | 1635 | Browser inner width/height: 1024/689 19:06:57 INFO - PROCESS | 1635 | __metrics 19:06:57 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" 19:06:57 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] 19:06:58 INFO - TEST-INFO | 1635: exit 0 19:06:58 INFO - Browser initialized. 19:06:58 INFO - Running cycle 1/1 for dromaeo_css test... 19:06:58 INFO - TEST-INFO | started process 1639 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/ng/csmfm9x9681blsv1wkb387f800000w/T/tmpSnTwco/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:07:10 INFO - PROCESS | 1639 | RSS: Main: 168996864 19:07:10 INFO - PROCESS | 1639 | 19:10:13 INFO - PROCESS | 1639 | Cycle 1(1): loaded http://localhost:49245/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49245/tests/dromaeo/cssquery-ext.html) 19:10:15 INFO - PROCESS | 1639 | RSS: Main: 328937472 19:10:15 INFO - PROCESS | 1639 | 19:13:18 INFO - PROCESS | 1639 | Cycle 1(1): loaded http://localhost:49245/tests/dromaeo/cssquery-ext.html (next: http://localhost:49245/tests/dromaeo/cssquery-jquery.html) 19:13:18 INFO - PROCESS | 1639 | RSS: Main: 305479680 19:13:18 INFO - PROCESS | 1639 | 19:16:21 INFO - PROCESS | 1639 | Cycle 1(1): loaded http://localhost:49245/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49245/tests/dromaeo/cssquery-mootools.html) 19:16:21 INFO - PROCESS | 1639 | RSS: Main: 296472576 19:16:21 INFO - PROCESS | 1639 | 19:19:24 INFO - PROCESS | 1639 | Cycle 1(1): loaded http://localhost:49245/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49245/tests/dromaeo/cssquery-prototype.html) 19:19:24 INFO - PROCESS | 1639 | RSS: Main: 293429248 19:19:24 INFO - PROCESS | 1639 | 19:22:28 INFO - PROCESS | 1639 | Cycle 1(1): loaded http://localhost:49245/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49245/tests/dromaeo/cssquery-yui.html) 19:22:28 INFO - PROCESS | 1639 | RSS: Main: 269807616 19:22:28 INFO - PROCESS | 1639 | 19:25:32 INFO - PROCESS | 1639 | Cycle 1(1): loaded http://localhost:49245/tests/dromaeo/cssquery-yui.html (next: http://localhost:49245/tests/dromaeo/cssquery-dojo.html) 19:25:32 INFO - PROCESS | 1639 | RSS: Main: 483479552 19:25:32 INFO - PROCESS | 1639 | 19:25:32 INFO - PROCESS | 1639 | __start_tp_report 19:25:32 INFO - PROCESS | 1639 | _x_x_mozilla_page_load 19:25:32 INFO - PROCESS | 1639 | _x_x_mozilla_page_load_details 19:25:32 INFO - PROCESS | 1639 | |i|pagename|runs| 19:25:32 INFO - PROCESS | 1639 | |0;dojo.html;2874.6837847836723;3288.717400213917;3449.137715571107;3460.9307813843725;3500.6499350064996;5724.084146536555;5725.227094342268;5744.224529688501;5816.069428891378;5838.2410286662725;5740.79907203248;5792.68140252286;5801.013827649299;5802.5938184327115;5802.767889284423;5245.44922783109;5262.710550919698;5299;5321.840344789663;5333.759980800874;5189.325387699594;5194.532492075712;5244.423113457517;5375.11310633745;5385.892282154355;5265.710385928773;5274.894502109955;5283.286756287909;5284.841454756363;5288.180332048539;4388.363687265361;5215.660982036194;5294.338207724035;5295.735213239323;5299.761510732007;5131.179011358202;5225.738713064332;5236.29310043147;5237.057329680656;5275.498827611371;5527.8391537777115;5780.3063632363965;5794.159846822187;5794.420557944214;5801.158831969383;5540.2243685884005;6199.690015499207;6204.47261982732;6216.595921265149;6217.782377616807;6343.207099112611;6387.936120638827;6415.87168256637;6428.967855160741;6434.485241180694;5865.794697185578;5867.911981320283;5876.55925805562;5878.5297176225795;5882.411758824126;6324.462420694201;6324.988001919671;6365.554411191172;6371.904421433682;6390.424861762371;5431.21247419122;6114.549543274429;6176.629402235881;6256.562040657202;6295.874082518324;5110.948890511122;6391.1371964785085;6396.968015159894;6405.775797847053;6412.647304398303;6120.14317995481;6311.747530098836;6313.810585682345;6314.936850631527;6323.30443651198;6197.070439434031;6219.40915613016;6248.4064013918605;6270.3416141305415;6289.371062893674;4995.175795993693;4995.775190116454;5002.374703162105;5028.421731500925;5039.3952725672425;4385.101054283864;4487.977560112178;4488.416505854283;4498.955010449919;4524.6380289576755;5005.649604527648;5747.482726554546;5828.737706803204;5848.88302233953;5977.731002104916;6172.444479996821;6198.2252218472695;6298.622082675054;6340.904886426707;6355.014972679242;6005.399460054047;6076.4531192192035;6109.327973922865;6129.540284478682;6136.29432615255;5423.511883930465;5495.807646732345;5511.118221084607;5530.640508366943;5538.529225015838;6498.415142637185;6500.609963402211;6502.902456463063;6518.902216466757;6528.37980391862;5218.608604354613;6178.845528861814;6227.750889964532;6293.622382657055;6333.778317758856;6336.556441049082;6341.7780377688405;6344.397282258178;6349.301576826453;6353.491720662243;4670.556297151765;6098.634081955097;6206.255249370104;6275.497960163085;6326;6381.425671689571;6395.8720825582295;6399.776007839703;6404.7438102477245;6406.071119687526;6020.4280593343565;6235.719392627433;6236.126942228001;6252.280987686474;6255.937440625536;6093;6117.327094019565;6141.854248382235;6147.600405973598;6217.253929528486;6043.939560604514;6075.696215189135;6086.60437071589;6095.085737139465;6100.206973093469;5129.358830146231;6137.7851775187655;6214.5028397728975;6215.192025036717;6226.377362263737;5793.536517078539;5829.59192856496;5906.852328691817;5915.58590898633;6055.576109672281 19:25:32 INFO - PROCESS | 1639 | |1;ext.html;798.8681867491864;817.4972391978932;831.9292860106889;904.7104926423543;917.3165991336456;29625.703742962593;41020.17959640805;41313.99999999996;41323;41406.96482587937;42798.786006069924;42828.35757463641;42835.35746963798;42853;42994;7968.402369822257;9698.175655069328;9850.507474626276;9866.161376283024;9883.209343252558;7997.360211183091;8074.273315401612;8077.35381169505;8080.232377924088;12001.639950801446;12151.756964860742;12218.32799196044;12239.632811015685;12245.693857653585;12352.258864468116;12107.878921210764;12122.575709850202;12152.331621760799;12167.209131406431;12175.878241217562;11704.239224450383;11707.2975621463;11778.234414763014;11779.116566257566;11780.234284771463;41014.76955691334;41062.76811695654;41155.794221029006;41156.588434115576;41199.558015469614;4013.979930100331;4081.3877918312196;4091.2226676931286;4093.5087789465156;4103.343465045608;28001.29996750077;28788.424231515462;30109.849450752827;30656;30930.53604195939;3192.7605429592872;3282.3599398117376;3353.279045005336;3433.570803649544;3449.534312867781;353877;357588;358900;359198.9999999974;359495;54341;54433.72783136059;54506.72746636241;54526.72736636292;54599.45400546023;57161;57167.71416142893;57175.714121429126;57216.71391643015;57314;14572.344244509022;15021.474248401253;15041.699166016619;15049.774253386207;15076.24618769057;12798.424070916832;12808.487660493662;12815.679608009688;12821.910137638219;12822.80765788514;11186.552537898393;11412.201145919871;11570.652880413601;12531.122821402414;13093.869061309455;4880.877398198434;5403.081476149064;5585.134304182858;5586.821139755499;5607.719614019283;1142.8057230270874;1150.4995327032768;1163.784699830534;1167.5096459487036;1207.0464333176867;26751.86624066906;27340.179794606192;27850.16449506518;27958.161255162377;28046;934.5841100710119;1265.7215412609212;1290.270996886756;1291.0962326371578;1329.7207586406962;14371.78442323366;14476.34856431463;14625.488107916384;14658.193799340925;14680.55958321252;479631;481625;482513.699452025;482580.5870970693;483346;48930.26604600934;49271.75364123157;51686;51966;52029.47970520322;1492.1643879427556;1495.8803295736316;1507.6306304954917;1525.4127161042857;1526.5572983834786;26708;28875.42249154963;29672.258193545335;30925.536116958712;31245.687543124277;49988;50149.74625634388;50302;50331.74834125806;50523.73690657763;413415;475351;477200;482677;490561;35509.91635961794;35634.82182589071;35721.46417803683;35919.461208081375;36445.45331819972;45130.77434612806;45469.54530454653;45679.77160114178;45769;45861.77069114633;25590.84841182114;27788.861055694593;27878.58182127229;30593.388132237676;30952.69047309588;30366.240843978194;30534.08397748071;30644.693553064182;31230.21924451907;31351.68648313579;37147.6998305058;37771.62228377681;37966;37991.24017519579;38129.809350953066;31342.843285783427;31651.84174079207;31817.5227371585;32202.711891524075;32207.194820129684;19408.61182776365;20216.78699278048;24297.90659420295;24860.751392485843;25261.74738252594 19:25:32 INFO - PROCESS | 1639 | |2;jquery.html;394.6704501741046;423.7309308589047;428.70205207380883;432.53502484828806;463.2264118921401;21015.789842101593;21944.341669749912;22227.888860555693;23233;23512;23146;23587.174448894293;23677.289681309547;23766.405839853967;24082;6668.599884006963;6908.7236510539515;6913.446924246048;6998.580085194904;7013.4389248860225;6595.934040659604;6913.4123599494105;6914.654267286615;6915.343042410988;6923.619200943971;6611.867762644744;6825.6587170641515;6887.449004079686;6904.620245886475;6933.583984960893;6040.516758659297;6701.1623547056615;6857.554258973176;6867;6946.895796563081;6729.8654026919185;6738.191417029988;6744.966275168642;6745.494087943375;6753.864922701568;27323.726762732316;27740.583891241648;27950.301242468897;28158.296042598893;28366.29084272889;2984.8358340291275;3046.6496352919253;3073.830939298338;3074.6925307469296;3117.3297740985795;16487.258073386725;16779.580510487212;17206.913965430216;17273.222704978307;18138.727919081226;1717.8797484176112;2136.42316574524;2192.9342119736434;2234.530748542808;2276.6926464927355;122140;123926;124474.37762811128;125059;127592.72407275994;17453.7381939271;20422.40495888443;21573.784262157493;21609.243676471247;21854.89072554659;35528.111797205274;36044.639553604655;36057.45913811295;36069.45895811565;36093.45859812105;10758.515866786014;10784.892151078546;10876.238663293494;10978.835317470244;11125.888741112485;7252.38354739853;8818.250448711931;8835.20483156519;8851;9023.233025192802;8670.829438025912;10112.292139550307;10537.736556586147;10609.84085238722;10648.946755266328;3836.582952739756;4064.1871625674985;4285.014446677219;4307.784610769449;4376.518582955872;1044.3264094659055;1117.3407689463256;1118.6028959719183;1130.949107290174;1190.922590031645;22437.21469748551;22480.887595562246;22906.427339316317;23838;24803.379915502257;961.2166084641135;965.3676841668719;976.1117383181413;1002.0580654185043;1002.2382988928467;7093.858122837514;7094.184168820651;7140.857182856314;7258.455615828729;7433.368163706145;766178;809351;811569;814329.9283503544;822060;93565.86992773741;129256.70743292634;152092;155243;162797;1286.7040580666312;1315.4738104758173;1357.2399456304502;1396.9511067112805;1443.7762146867462;18947.810521894604;20316.89841550783;21216.833074181068;21485.14059437605;21508;52887;57474.7126264366;65154.674226628566;66505.66747166234;67179.32820671926;93919;94086.05913940773;94559.52720236355;96406.55390169294;96620;9826.213902887896;11476.713082173012;11757.589089309338;11798.233114847508;11937.283762973902;10522.684319470429;12510.812337814757;12935.676608084874;13008.674783130118;13108.147970381895;11076.778464430827;11093.889061109285;11324.263922844988;11404.144689148514;11461.197716159788;8014.398920080901;10244;10506.947465262625;10520.316179448311;10574.15406767472;11263.211575189986;11306;11409.828852567052;11421.371824549396;11474.541018359172;10741.409222492526;11437.428128593703;11662.88337116618;11847.170698051053;11858.407079646156;10986.077619997306;11102.61140860066;11202.66392008241;11243.100551955988;11338 19:25:32 INFO - PROCESS | 1639 | |3;mootools.html;1379.2345248387144;1590.8409159084101;1631.4942367865956;1660.4437513433004;1661.8005839299285;10916.781664366708;11572.132090093255;11593.710157246072;11596.130290228235;11598.014168795651;10983;11302.152338574599;11498.137639677016;11507.42462876855;11519.25124866883;2467.12417091932;2504.9874750626223;2510.573202555561;2511.7739403453684;2514.5473814713346;2434.8904299306487;2461;2500.1624455807328;2508.4732206236713;2508.8871000805007;2416.9758302416926;2454.607262837946;2463.7043554773454;2468.6420469031978;2472.9752702473015;2418.806495480357;2426.987865060681;2452.4849781545895;2459.717132529764;2462.987685061581;2399;2421.4309637235237;2426.1993542131054;2426.5632186206476;2428.659987601737;11099.278546894508;11348.943255283753;11351.772964540745;11377.772444551063;11395.772084558344;5986.97006514969;6159.538034647375;6163.938360616381;6171.197744293213;6190.226221722285;3523.3481805865995;3608.2963822054708;3615.963840361589;3746.419305007701;3805.353089974711;1210.612603966731;1220.8168774683868;1232.1621297517684;1267.8161666558296;1279.9168054076456;13952;14272.714545709028;14575.27123643803;15357.692846143127;15507.379704811794;4127.29835927893;4336.132773445323;4413.713108647928;4452.621527170162;4897.804087836446;12257.38713064361;12264.509419623115;12282.692932676755;12290.692732681755;12296.631101066982;6073.362296958844;6087.299960504599;6092.45167934888;6093.482054025458;6095.390460953958;5365.114756065205;5478.835634930959;5479.315085614298;5544.417836127229;5552.555795536347;3924.4113382992778;4023.8994025149605;4055.7160998730396;4085.9795701021303;4122.42286079949;1072.5227273863056;1075.3870293932384;1076.7146706122883;1090.1769164281075;1091.8362245663054;806.1132753970703;809.3444310108831;814.8696208606713;837.7151768398652;839.4627438439404;6275.96862015687;6643.236027856762;6674.566153200027;6777.695003724745;6881.724731010803;1018.3228153277987;1021.1065317846884;1026.6879403807395;1037.0873631204493;1062.68119564132;3647.6899463545365;3831.252905683365;4238.576142385798;4324.0919406924895;4387.934180987288;13586.93206533961;14227.14637121776;14248;14262.78766304855;14276.143431393943;14125.223112728692;14129.010969232055;14137.293135343192;14141.5050473235;14151.50469733575;8659.437136586102;8896.243819275305;9048.321375896834;9860.211183105477;10218.540165692413;6691.330866913269;6790;6819.397441601319;7006.6846991886505;7107.857842843217;12349.93825030869;12463.813042804546;12694.619161425171;12837.165584236995;12872.35638218104;12861.292628905127;12869.485220591072;12975.545855894998;13073.019523535962;13141.211527308393;9291.67479138227;9531.380460270339;9531.47576883278;9551.283653726137;9555.713328600154;10255.282130250811;10449.477526123512;10576.942305769362;10584.047435730821;10591.788164236827;8839.46963182211;8975.102489750972;9062.864057039282;9120.868711142397;9123.406978546373;8763.3427492937;8827.117288271122;8839.46963182211;8947.821043579223;8952.01527831951;7953.721619743281;8125.715599953974;8136.349092072738;8141.185881411811;8141.470804397695;5752.626079304831;5799.565032622654;5805.709714514173;5961.552883533665;5972.671503067373;4997.950020499894;5855.297364316139;5880.26496687914;5960.135780311917;6005.609635373687 19:25:32 INFO - PROCESS | 1639 | |4;prototype.html;378.5344026846978;391.65534329789784;394.9071968087501;398.52177387135447;401.55226921981983;4939.975300123503;5065.164247899097;5096.413912400075;5100.260462232979;5105.336306280178;4274.444322238105;4756.881077973052;4840.225563909775;4888.291197776321;5040.974795126029;3698.7041036716996;4230.46393322317;4257.7445353278745;4284.743594867891;4304.526502084768;3882.9223415531815;4118.855840045599;4255.4467919170465;4274.807633656477;4358;3706.555213374399;4071.089171242561;4169.353750168729;4267.375564028116;4282.957170428287;3257.1531401835455;3320.0205939247858;4195.91608167835;4195.937060944088;4197.916041679165;3898.5126859142606;3933.704972127102;3944.5858184890462;3978.9403158952637;3996.5603783583783;4937.555619994182;5014.3674570850235;5026.195808670595;5042.268871013719;5107.9744601277125;4462.464504259509;4534.77326133692;4867.977724677822;4888.242322440027;4936.308916751657;4984.152694042022;5116.923246151311;5374.543163831079;5486;5506.449355064461;3648.5986541480415;4073.3075377185655;4163.188178305231;4462.977685111586;4470.329450582406;5191.196753752969;5270;5411.404745477994;5537.723113844291;5700.7719691212305;3943.881683549498;4315.244832154361;4383.216657422496;4446.088551846864;4452.5547445255215;3784.299904517673;3904;4526.388937493462;4531.27499600069;4640.419947506562;4527.162474942146;4605.355250264965;4817.325574419584;4873.002069151631;4890.750254882722;4625.537446255347;4817.373741413664;5010;5277.393099793496;5376.569874410038;1245.850497940253;1341.3695563085334;1367.589723083071;1397.2255235850616;1562.62497000719;1022.9437380943971;1067.4395942130443;1121.9270747401392;1171.3967306836985;1198.3888217009214;4278.358246263086;4432.911341773147;4551.294549344857;4876.609871210295;5202.193659982709;4889.608831293488;5250.503606472137;5405.216278628043;5509.787846673726;5542.699779591505;4609.631229501631;4853.635977301717;4969.01239504194;5023.748812559357;5197.946811009706;2539.987300063488;2719.904803331874;2873.396586716813;2884.783641226916;2885.5238885584063;4767.547083027107;5008.323876276729;5746.913796293059;5776.913346299809;5851.38560451155;4807.134715751128;5379.62037962038;5431.565474762088;5732.942670573324;5741;4705.058988202373;5216.817411390583;5421.620486565903;5453.045716999509;5850.707464626752;4673.616455607596;5067.771950262173;5661.98999355223;5674.007048766532;5681.829545113488;4693.5071817458675;4702.929456058094;4740.1230772307235;5400.891982160413;5511.862203444946;5566.944330556643;5605;5688.7440065198;5712.828615141552;5809;4225.873223803291;4846.297286893451;4867.853964381075;4904.656674032926;5027.9748601258225;5200.5059519345605;5327.520523152934;5628;5643.746031428677;5672.404397538199;4940.555350018516;5339.092354299701;5350.475114592323;5402.784373515928;5426.019502881499;4518.537397118513;4878.146324393146;5268.894622107459;5456.890862182655;5494.478024587658;4385.298352263622;4910.330487634222;4933.703977761345;5021.995600879912;5250.451116920442;4749.532841026001;5404.864878378072;5409.675419474844;5423.8033596393525;5450.400455949763;4311.93532097025;4710.6231501479115;5053.620978426707;5363.088274993339;5398.892022159614 19:25:32 INFO - PROCESS | 1639 | |5;yui.html;752.7026824404361;777.4208214879911;802.4864086984331;842.6591236147307;875.9211670949613;15896;17568.385106521273;17587.73618395725;17601.207945642444;17680.82319176808;16037.278322475488;16147.757783633255;16271.51185464438;16300.103494307808;16303.673926521462;943.075785729985;944.7874228298647;945.54141241498;945.862849886766;946.5598496699033;937.100383631711;939.821433927555;940.2008292951006;940.2055263302499;940.887093548775;842.6039761312204;1029.6602121299952;1069.198101423932;1069.5187165775394;1069.9411532365755;1060.178361769627;1061.071562382911;1061.8247989081792;1062.829947208443;1063.957441702331;783.2050468774198;784.9372050235968;785.2696991797626;785.3442375616368;785.4541093939714;17343.306267749274;17603.735943960724;17635.118244087873;18044.90977545117;18306.725399119023;12316.384180790925;14801.629959250997;14911.850881491155;15053.849461505355;15366.30851611669;11935.761284774257;12032.217905836093;12132.696682582919;12338.629841104781;12614.873851261462;3741.887743367676;3812.8284227209842;3837;3987.142764305688;3988.4017397390335;90766;111585;111586;111786;114617.4269128649;11265.26775759573;11318.151138664633;11403.087752979907;11717.707057323465;11815.763684726257;23718.16986405502;24097.638535421982;24137.034518619057;24163.51672966531;24171;7921.247481489249;7975.880361794578;7990.4406691532195;8028.518288902685;8171.346292296602;4598.540145985442;4626.167289887785;4636.884077898079;4684.672072954929;4830.758462076952;3656.4880916671686;3708.313961917054;3725.0501122214205;3748.812559372075;3770.5286839145106;643.6781609195402;665.0722242471725;668.3216535216759;670.9228438729511;682.6382017530717;577.9971749015455;608.8386577556951;677.6273049822578;686.8282929267683;714.9499535032602;10436.791264174673;10735.302205356784;10798.406087665096;11110.55557777696;11288.435578221057;589.755251570602;603.7072020070262;603.7171011600349;605.9242594675666;739.8261408568982;5130.87172820675;5303.443138470482;5303.920441193385;5321.654092484054;5327.920081198785;82985.58507207547;90632;94687;95636.52181739047;103885;52835.67910802261;56023.719881400335;61082.083768743505;82836.17163828405;83617;73740.63129684317;78570.6071469639;79203;80603.59698201471;81907.9999999988;10962;11338.433078346216;11342;11421.371824549396;11603.709907252387;39461;47255.763721181174;49899.750501248716;51050.48949510457;52569.737151313995;58727.82544349004;68297;68921.3107868915;70076;72009.91985120122;13914.582562523141;14848.257587120817;14982.325795339018;15032.398704051715;15090.54728358151;13055.738885222052;15289.77065344043;16037.438689645807;16136.596585085466;16718.66562668764;13540.187588744708;14309.069910456203;14672.85327146715;14899.255037248311;14942.626434339229;14285.142891426547;14830.480933167288;14850.480233191787;14971.176585287914;15628.68742625164;14226.430942762174;14592.489262875748;14719.852801471849;14853.183074930983;15510;10088.849245304842;10784.137269018616;10906.836397454203;10991.835122473329;11170.329780213213;10334.844977325496;10889.401082940514;11854.466549005143;12344.506219751109;12613.30626815534 19:25:32 INFO - PROCESS | 1639 | __end_tp_report 19:25:32 INFO - PROCESS | 1639 | __start_cc_report 19:25:32 INFO - PROCESS | 1639 | _x_x_mozilla_cycle_collect,1612 19:25:32 INFO - PROCESS | 1639 | __end_cc_report 19:25:32 INFO - PROCESS | 1639 | __startTimestamp1492655132375__endTimestamp 19:25:32 INFO - PROCESS | 1639 | 19:25:32 INFO - PROCESS | 1639 | ------- Summary: start ------- 19:25:32 INFO - PROCESS | 1639 | Number of tests: 6 19:25:32 INFO - PROCESS | 1639 | 19:25:32 INFO - PROCESS | 1639 | [#0] dojo.html Cycles:165 Average:5780.96 Median:6043.94 stddev:679.27 (11.2%) stddev-sans-first:641.96 19:25:32 INFO - PROCESS | 1639 | Values: 2874.7 3288.7 3449.1 3460.9 3500.6 5724.1 5725.2 5744.2 5816.1 5838.2 5740.8 5792.7 5801.0 5802.6 5802.8 5245.4 5262.7 5299.0 5321.8 5333.8 5189.3 5194.5 5244.4 5375.1 5385.9 5265.7 5274.9 5283.3 5284.8 5288.2 4388.4 5215.7 5294.3 5295.7 5299.8 5131.2 5225.7 5236.3 5237.1 5275.5 5527.8 5780.3 5794.2 5794.4 5801.2 5540.2 6199.7 6204.5 6216.6 6217.8 6343.2 6387.9 6415.9 6429.0 6434.5 5865.8 5867.9 5876.6 5878.5 5882.4 6324.5 6325.0 6365.6 6371.9 6390.4 5431.2 6114.5 6176.6 6256.6 6295.9 5110.9 6391.1 6397.0 6405.8 6412.6 6120.1 6311.7 6313.8 6314.9 6323.3 6197.1 6219.4 6248.4 6270.3 6289.4 4995.2 4995.8 5002.4 5028.4 5039.4 4385.1 4488.0 4488.4 4499.0 4524.6 5005.6 5747.5 5828.7 5848.9 5977.7 6172.4 6198.2 6298.6 6340.9 6355.0 6005.4 6076.5 6109.3 6129.5 6136.3 5423.5 5495.8 5511.1 5530.6 5538.5 6498.4 6500.6 6502.9 6518.9 6528.4 5218.6 6178.8 6227.8 6293.6 6333.8 6336.6 6341.8 6344.4 6349.3 6353.5 4670.6 6098.6 6206.3 6275.5 6326.0 6381.4 6395.9 6399.8 6404.7 6406.1 6020.4 6235.7 6236.1 6252.3 6255.9 6093.0 6117.3 6141.9 6147.6 6217.3 6043.9 6075.7 6086.6 6095.1 6100.2 5129.4 6137.8 6214.5 6215.2 6226.4 5793.5 5829.6 5906.9 5915.6 6055.6 19:25:32 INFO - PROCESS | 1639 | 19:25:32 INFO - PROCESS | 1639 | [#1] ext.html Cycles:180 Average:58043.95 Median:178663.27 stddev:116645.51 (65.3%) stddev-sans-first:116893.54 19:25:32 INFO - PROCESS | 1639 | Values: 798.9 817.5 831.9 904.7 917.3 29625.7 41020.2 41314.0 41323.0 41407.0 42798.8 42828.4 42835.4 42853.0 42994.0 7968.4 9698.2 9850.5 9866.2 9883.2 7997.4 8074.3 8077.4 8080.2 12001.6 12151.8 12218.3 12239.6 12245.7 12352.3 12107.9 12122.6 12152.3 12167.2 12175.9 11704.2 11707.3 11778.2 11779.1 11780.2 41014.8 41062.8 41155.8 41156.6 41199.6 4014.0 4081.4 4091.2 4093.5 4103.3 28001.3 28788.4 30109.8 30656.0 30930.5 3192.8 3282.4 3353.3 3433.6 3449.5 353877.0 357588.0 358900.0 359199.0 359495.0 54341.0 54433.7 54506.7 54526.7 54599.5 57161.0 57167.7 57175.7 57216.7 57314.0 14572.3 15021.5 15041.7 15049.8 15076.2 12798.4 12808.5 12815.7 12821.9 12822.8 11186.6 11412.2 11570.7 12531.1 13093.9 4880.9 5403.1 5585.1 5586.8 5607.7 1142.8 1150.5 1163.8 1167.5 1207.0 26751.9 27340.2 27850.2 27958.2 28046.0 934.6 1265.7 1290.3 1291.1 1329.7 14371.8 14476.3 14625.5 14658.2 14680.6 479631.0 481625.0 482513.7 482580.6 483346.0 48930.3 49271.8 51686.0 51966.0 52029.5 1492.2 1495.9 1507.6 1525.4 1526.6 26708.0 28875.4 29672.3 30925.5 31245.7 49988.0 50149.7 50302.0 50331.7 50523.7 413415.0 475351.0 477200.0 482677.0 490561.0 35509.9 35634.8 35721.5 35919.5 36445.5 45130.8 45469.5 45679.8 45769.0 45861.8 25590.8 27788.9 27878.6 30593.4 30952.7 30366.2 30534.1 30644.7 31230.2 31351.7 37147.7 37771.6 37966.0 37991.2 38129.8 31342.8 31651.8 31817.5 32202.7 32207.2 19408.6 20216.8 24297.9 24860.8 25261.7 19:25:32 INFO - PROCESS | 1639 | 19:25:32 INFO - PROCESS | 1639 | [#2] jquery.html Cycles:180 Average:43879.03 Median:23372.50 stddev:132997.06 (569.0%) stddev-sans-first:133330.07 19:25:32 INFO - PROCESS | 1639 | Values: 394.7 423.7 428.7 432.5 463.2 21015.8 21944.3 22227.9 23233.0 23512.0 23146.0 23587.2 23677.3 23766.4 24082.0 6668.6 6908.7 6913.4 6998.6 7013.4 6595.9 6913.4 6914.7 6915.3 6923.6 6611.9 6825.7 6887.4 6904.6 6933.6 6040.5 6701.2 6857.6 6867.0 6946.9 6729.9 6738.2 6745.0 6745.5 6753.9 27323.7 27740.6 27950.3 28158.3 28366.3 2984.8 3046.6 3073.8 3074.7 3117.3 16487.3 16779.6 17206.9 17273.2 18138.7 1717.9 2136.4 2192.9 2234.5 2276.7 122140.0 123926.0 124474.4 125059.0 127592.7 17453.7 20422.4 21573.8 21609.2 21854.9 35528.1 36044.6 36057.5 36069.5 36093.5 10758.5 10784.9 10876.2 10978.8 11125.9 7252.4 8818.3 8835.2 8851.0 9023.2 8670.8 10112.3 10537.7 10609.8 10648.9 3836.6 4064.2 4285.0 4307.8 4376.5 1044.3 1117.3 1118.6 1130.9 1190.9 22437.2 22480.9 22906.4 23838.0 24803.4 961.2 965.4 976.1 1002.1 1002.2 7093.9 7094.2 7140.9 7258.5 7433.4 766178.0 809351.0 811569.0 814329.9 822060.0 93565.9 129256.7 152092.0 155243.0 162797.0 1286.7 1315.5 1357.2 1397.0 1443.8 18947.8 20316.9 21216.8 21485.1 21508.0 52887.0 57474.7 65154.7 66505.7 67179.3 93919.0 94086.1 94559.5 96406.6 96620.0 9826.2 11476.7 11757.6 11798.2 11937.3 10522.7 12510.8 12935.7 13008.7 13108.1 11076.8 11093.9 11324.3 11404.1 11461.2 8014.4 10244.0 10506.9 10520.3 10574.2 11263.2 11306.0 11409.8 11421.4 11474.5 10741.4 11437.4 11662.9 11847.2 11858.4 10986.1 11102.6 11202.7 11243.1 11338.0 19:25:32 INFO - PROCESS | 1639 | 19:25:32 INFO - PROCESS | 1639 | [#3] mootools.html Cycles:180 Average:6874.41 Median:2506.73 stddev:4306.97 (171.8%) stddev-sans-first:4299.26 19:25:32 INFO - PROCESS | 1639 | Values: 1379.2 1590.8 1631.5 1660.4 1661.8 10916.8 11572.1 11593.7 11596.1 11598.0 10983.0 11302.2 11498.1 11507.4 11519.3 2467.1 2505.0 2510.6 2511.8 2514.5 2434.9 2461.0 2500.2 2508.5 2508.9 2417.0 2454.6 2463.7 2468.6 2473.0 2418.8 2427.0 2452.5 2459.7 2463.0 2399.0 2421.4 2426.2 2426.6 2428.7 11099.3 11348.9 11351.8 11377.8 11395.8 5987.0 6159.5 6163.9 6171.2 6190.2 3523.3 3608.3 3616.0 3746.4 3805.4 1210.6 1220.8 1232.2 1267.8 1279.9 13952.0 14272.7 14575.3 15357.7 15507.4 4127.3 4336.1 4413.7 4452.6 4897.8 12257.4 12264.5 12282.7 12290.7 12296.6 6073.4 6087.3 6092.5 6093.5 6095.4 5365.1 5478.8 5479.3 5544.4 5552.6 3924.4 4023.9 4055.7 4086.0 4122.4 1072.5 1075.4 1076.7 1090.2 1091.8 806.1 809.3 814.9 837.7 839.5 6276.0 6643.2 6674.6 6777.7 6881.7 1018.3 1021.1 1026.7 1037.1 1062.7 3647.7 3831.3 4238.6 4324.1 4387.9 13586.9 14227.1 14248.0 14262.8 14276.1 14125.2 14129.0 14137.3 14141.5 14151.5 8659.4 8896.2 9048.3 9860.2 10218.5 6691.3 6790.0 6819.4 7006.7 7107.9 12349.9 12463.8 12694.6 12837.2 12872.4 12861.3 12869.5 12975.5 13073.0 13141.2 9291.7 9531.4 9531.5 9551.3 9555.7 10255.3 10449.5 10576.9 10584.0 10591.8 8839.5 8975.1 9062.9 9120.9 9123.4 8763.3 8827.1 8839.5 8947.8 8952.0 7953.7 8125.7 8136.3 8141.2 8141.5 5752.6 5799.6 5805.7 5961.6 5972.7 4998.0 5855.3 5880.3 5960.1 6005.6 19:25:32 INFO - PROCESS | 1639 | 19:25:32 INFO - PROCESS | 1639 | [#4] prototype.html Cycles:180 Average:4491.08 Median:4870.49 stddev:1251.36 (25.7%) stddev-sans-first:1216.21 19:25:32 INFO - PROCESS | 1639 | Values: 378.5 391.7 394.9 398.5 401.6 4940.0 5065.2 5096.4 5100.3 5105.3 4274.4 4756.9 4840.2 4888.3 5041.0 3698.7 4230.5 4257.7 4284.7 4304.5 3882.9 4118.9 4255.4 4274.8 4358.0 3706.6 4071.1 4169.4 4267.4 4283.0 3257.2 3320.0 4195.9 4195.9 4197.9 3898.5 3933.7 3944.6 3978.9 3996.6 4937.6 5014.4 5026.2 5042.3 5108.0 4462.5 4534.8 4868.0 4888.2 4936.3 4984.2 5116.9 5374.5 5486.0 5506.4 3648.6 4073.3 4163.2 4463.0 4470.3 5191.2 5270.0 5411.4 5537.7 5700.8 3943.9 4315.2 4383.2 4446.1 4452.6 3784.3 3904.0 4526.4 4531.3 4640.4 4527.2 4605.4 4817.3 4873.0 4890.8 4625.5 4817.4 5010.0 5277.4 5376.6 1245.9 1341.4 1367.6 1397.2 1562.6 1022.9 1067.4 1121.9 1171.4 1198.4 4278.4 4432.9 4551.3 4876.6 5202.2 4889.6 5250.5 5405.2 5509.8 5542.7 4609.6 4853.6 4969.0 5023.7 5197.9 2540.0 2719.9 2873.4 2884.8 2885.5 4767.5 5008.3 5746.9 5776.9 5851.4 4807.1 5379.6 5431.6 5732.9 5741.0 4705.1 5216.8 5421.6 5453.0 5850.7 4673.6 5067.8 5662.0 5674.0 5681.8 4693.5 4702.9 4740.1 5400.9 5511.9 5566.9 5605.0 5688.7 5712.8 5809.0 4225.9 4846.3 4867.9 4904.7 5028.0 5200.5 5327.5 5628.0 5643.7 5672.4 4940.6 5339.1 5350.5 5402.8 5426.0 4518.5 4878.1 5268.9 5456.9 5494.5 4385.3 4910.3 4933.7 5022.0 5250.5 4749.5 5404.9 5409.7 5423.8 5450.4 4311.9 4710.6 5053.6 5363.1 5398.9 19:25:32 INFO - PROCESS | 1639 | 19:25:32 INFO - PROCESS | 1639 | [#5] yui.html Cycles:180 Average:20248.93 Median:24117.34 stddev:27637.62 (114.6%) stddev-sans-first:27676.38 19:25:32 INFO - PROCESS | 1639 | Values: 752.7 777.4 802.5 842.7 875.9 15896.0 17568.4 17587.7 17601.2 17680.8 16037.3 16147.8 16271.5 16300.1 16303.7 943.1 944.8 945.5 945.9 946.6 937.1 939.8 940.2 940.2 940.9 842.6 1029.7 1069.2 1069.5 1069.9 1060.2 1061.1 1061.8 1062.8 1064.0 783.2 784.9 785.3 785.3 785.5 17343.3 17603.7 17635.1 18044.9 18306.7 12316.4 14801.6 14911.9 15053.8 15366.3 11935.8 12032.2 12132.7 12338.6 12614.9 3741.9 3812.8 3837.0 3987.1 3988.4 90766.0 111585.0 111586.0 111786.0 114617.4 11265.3 11318.2 11403.1 11717.7 11815.8 23718.2 24097.6 24137.0 24163.5 24171.0 7921.2 7975.9 7990.4 8028.5 8171.3 4598.5 4626.2 4636.9 4684.7 4830.8 3656.5 3708.3 3725.1 3748.8 3770.5 643.7 665.1 668.3 670.9 682.6 578.0 608.8 677.6 686.8 714.9 10436.8 10735.3 10798.4 11110.6 11288.4 589.8 603.7 603.7 605.9 739.8 5130.9 5303.4 5303.9 5321.7 5327.9 82985.6 90632.0 94687.0 95636.5 103885.0 52835.7 56023.7 61082.1 82836.2 83617.0 73740.6 78570.6 79203.0 80603.6 81908.0 10962.0 11338.4 11342.0 11421.4 11603.7 39461.0 47255.8 49899.8 51050.5 52569.7 58727.8 68297.0 68921.3 70076.0 72009.9 13914.6 14848.3 14982.3 15032.4 15090.5 13055.7 15289.8 16037.4 16136.6 16718.7 13540.2 14309.1 14672.9 14899.3 14942.6 14285.1 14830.5 14850.5 14971.2 15628.7 14226.4 14592.5 14719.9 14853.2 15510.0 10088.8 10784.1 10906.8 10991.8 11170.3 10334.8 10889.4 11854.5 12344.5 12613.3 19:25:32 INFO - PROCESS | 1639 | -------- Summary: end -------- 19:25:32 INFO - PROCESS | 1639 | 19:25:33 INFO - TEST-INFO | 1639: exit 0 19:25:33 INFO - TEST-OK | dromaeo_css | took 1118595ms 19:25:33 INFO - TEST-START | kraken 19:25:33 INFO - operating with platform_type : mac_ 19:25:33 INFO - Initialising browser for kraken test... 19:25:33 INFO - TEST-INFO | started process 1648 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/ng/csmfm9x9681blsv1wkb387f800000w/T/tmpt6csRK/profile http://localhost:49245/getInfo.html) 19:25:35 INFO - PROCESS | 1648 | __metrics Screen width/height:1600/1200 19:25:35 INFO - PROCESS | 1648 | colorDepth:24 19:25:35 INFO - PROCESS | 1648 | Browser inner width/height: 1024/689 19:25:35 INFO - PROCESS | 1648 | __metrics 19:25:35 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" 19:25:35 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] 19:25:36 INFO - TEST-INFO | 1648: exit 0 19:25:36 INFO - Browser initialized. 19:25:36 INFO - Running cycle 1/1 for kraken test... 19:25:36 INFO - TEST-INFO | started process 1650 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/ng/csmfm9x9681blsv1wkb387f800000w/T/tmpt6csRK/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:25:48 INFO - PROCESS | 1650 | RSS: Main: 165019648 19:25:48 INFO - PROCESS | 1650 | 19:25:51 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) 19:25:52 INFO - PROCESS | 1650 | RSS: Main: 215748608 19:25:52 INFO - PROCESS | 1650 | 19:25:54 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) 19:25:55 INFO - PROCESS | 1650 | RSS: Main: 231682048 19:25:55 INFO - PROCESS | 1650 | 19:25:58 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) 19:25:59 INFO - PROCESS | 1650 | RSS: Main: 327507968 19:25:59 INFO - PROCESS | 1650 | 19:26:01 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) 19:26:01 INFO - PROCESS | 1650 | RSS: Main: 230232064 19:26:01 INFO - PROCESS | 1650 | 19:26:03 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) 19:26:04 INFO - PROCESS | 1650 | RSS: Main: 231907328 19:26:04 INFO - PROCESS | 1650 | 19:26:07 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) 19:26:07 INFO - PROCESS | 1650 | RSS: Main: 271908864 19:26:07 INFO - PROCESS | 1650 | 19:26:10 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) 19:26:11 INFO - PROCESS | 1650 | RSS: Main: 273653760 19:26:11 INFO - PROCESS | 1650 | 19:26:14 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) 19:26:14 INFO - PROCESS | 1650 | RSS: Main: 271855616 19:26:14 INFO - PROCESS | 1650 | 19:26:16 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) 19:26:17 INFO - PROCESS | 1650 | RSS: Main: 247595008 19:26:17 INFO - PROCESS | 1650 | 19:26:19 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) 19:26:19 INFO - PROCESS | 1650 | RSS: Main: 251457536 19:26:19 INFO - PROCESS | 1650 | 19:26:21 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) 19:26:22 INFO - PROCESS | 1650 | RSS: Main: 259444736 19:26:22 INFO - PROCESS | 1650 | 19:26:25 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) 19:26:26 INFO - PROCESS | 1650 | RSS: Main: 273084416 19:26:26 INFO - PROCESS | 1650 | 19:26:28 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) 19:26:29 INFO - PROCESS | 1650 | RSS: Main: 266715136 19:26:29 INFO - PROCESS | 1650 | 19:26:31 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) 19:26:31 INFO - PROCESS | 1650 | RSS: Main: 311164928 19:26:31 INFO - PROCESS | 1650 | 19:26:31 INFO - PROCESS | 1650 | __start_tp_report 19:26:31 INFO - PROCESS | 1650 | _x_x_mozilla_page_load 19:26:31 INFO - PROCESS | 1650 | _x_x_mozilla_page_load_details 19:26:31 INFO - PROCESS | 1650 | |i|pagename|runs| 19:26:31 INFO - PROCESS | 1650 | |0;ai-astar;103;114;113;114;113;114;114;115;113;115 19:26:31 INFO - PROCESS | 1650 | |1;audio-beat-detection;143;108;110;143;109;109;107;116;126;107 19:26:31 INFO - PROCESS | 1650 | |2;audio-dft;184;185;182;184;185;186;181;181;184;184 19:26:31 INFO - PROCESS | 1650 | |3;audio-fft;84;59;59;92;62;60;59;61;91;83 19:26:31 INFO - PROCESS | 1650 | |4;audio-oscillator;87;68;85;68;69;68;82;69;69;82 19:26:31 INFO - PROCESS | 1650 | |5;imaging-gaussian-blur;91;114;89;88;89;88;89;87;87;87 19:26:31 INFO - PROCESS | 1650 | |6;imaging-darkroom;93;94;102;95;94;95;95;94;94;96 19:26:31 INFO - PROCESS | 1650 | |7;imaging-desaturate;84;82;83;82;84;85;83;85;85;83 19:26:31 INFO - PROCESS | 1650 | |8;json-parse-financial;61;58;59;59;61;62;63;62;61;63 19:26:31 INFO - PROCESS | 1650 | |9;json-stringify-tinderbox;56;60;67;56;67;59;59;61;60;62 19:26:31 INFO - PROCESS | 1650 | |10;stanford-crypto-aes;84;87;80;85;79;83;81;82;87;82 19:26:31 INFO - PROCESS | 1650 | |11;stanford-crypto-ccm;135;133;133;137;138;139;118;138;193;161 19:26:31 INFO - PROCESS | 1650 | |12;stanford-crypto-pbkdf2;159;165;163;162;159;162;159;161;160;160 19:26:31 INFO - PROCESS | 1650 | |13;stanford-crypto-sha256-iterative;64;65;63;64;62;64;70;65;54;65 19:26:31 INFO - PROCESS | 1650 | __end_tp_report 19:26:31 INFO - PROCESS | 1650 | __start_cc_report 19:26:31 INFO - PROCESS | 1650 | _x_x_mozilla_cycle_collect,2080 19:26:31 INFO - PROCESS | 1650 | __end_cc_report 19:26:31 INFO - PROCESS | 1650 | __startTimestamp1492655191380__endTimestamp 19:26:31 INFO - PROCESS | 1650 | 19:26:31 INFO - PROCESS | 1650 | ------- Summary: start ------- 19:26:31 INFO - PROCESS | 1650 | Number of tests: 14 19:26:31 INFO - PROCESS | 1650 | 19:26:31 INFO - PROCESS | 1650 | [#0] ai-astar Cycles:10 Average:112.80 Median:114.00 stddev:3.52 (3.1%) stddev-sans-first:0.78 19:26:31 INFO - PROCESS | 1650 | Values: 103.0 114.0 113.0 114.0 113.0 114.0 114.0 115.0 113.0 115.0 19:26:31 INFO - PROCESS | 1650 | 19:26:31 INFO - PROCESS | 1650 | [#1] audio-beat-detection Cycles:10 Average:117.80 Median:113.00 stddev:14.47 (12.8%) stddev-sans-first:12.14 19:26:31 INFO - PROCESS | 1650 | Values: 143.0 108.0 110.0 143.0 109.0 109.0 107.0 116.0 126.0 107.0 19:26:31 INFO - PROCESS | 1650 | 19:26:31 INFO - PROCESS | 1650 | [#2] audio-dft Cycles:10 Average:183.60 Median:184.00 stddev:1.71 (0.9%) stddev-sans-first:1.81 19:26:31 INFO - PROCESS | 1650 | Values: 184.0 185.0 182.0 184.0 185.0 186.0 181.0 181.0 184.0 184.0 19:26:31 INFO - PROCESS | 1650 | 19:26:31 INFO - PROCESS | 1650 | [#3] audio-fft Cycles:10 Average:71.00 Median:72.50 stddev:14.48 (20.0%) stddev-sans-first:14.58 19:26:31 INFO - PROCESS | 1650 | Values: 84.0 59.0 59.0 92.0 62.0 60.0 59.0 61.0 91.0 83.0 19:26:31 INFO - PROCESS | 1650 | 19:26:31 INFO - PROCESS | 1650 | [#4] audio-oscillator Cycles:10 Average:74.70 Median:75.50 stddev:8.14 (10.8%) stddev-sans-first:7.31 19:26:31 INFO - PROCESS | 1650 | Values: 87.0 68.0 85.0 68.0 69.0 68.0 82.0 69.0 69.0 82.0 19:26:31 INFO - PROCESS | 1650 | 19:26:31 INFO - PROCESS | 1650 | [#5] imaging-gaussian-blur Cycles:10 Average:90.90 Median:88.50 stddev:8.21 (9.3%) stddev-sans-first:8.71 19:26:31 INFO - PROCESS | 1650 | Values: 91.0 114.0 89.0 88.0 89.0 88.0 89.0 87.0 87.0 87.0 19:26:31 INFO - PROCESS | 1650 | 19:26:31 INFO - PROCESS | 1650 | [#6] imaging-darkroom Cycles:10 Average:95.20 Median:94.50 stddev:2.53 (2.7%) stddev-sans-first:2.55 19:26:31 INFO - PROCESS | 1650 | Values: 93.0 94.0 102.0 95.0 94.0 95.0 95.0 94.0 94.0 96.0 19:26:31 INFO - PROCESS | 1650 | 19:26:31 INFO - PROCESS | 1650 | [#7] imaging-desaturate Cycles:10 Average:83.60 Median:84.00 stddev:1.17 (1.4%) stddev-sans-first:1.24 19:26:31 INFO - PROCESS | 1650 | Values: 84.0 82.0 83.0 82.0 84.0 85.0 83.0 85.0 85.0 83.0 19:26:31 INFO - PROCESS | 1650 | 19:26:31 INFO - PROCESS | 1650 | [#8] json-parse-financial Cycles:10 Average:60.90 Median:61.50 stddev:1.73 (2.8%) stddev-sans-first:1.83 19:26:31 INFO - PROCESS | 1650 | Values: 61.0 58.0 59.0 59.0 61.0 62.0 63.0 62.0 61.0 63.0 19:26:31 INFO - PROCESS | 1650 | 19:26:31 INFO - PROCESS | 1650 | [#9] json-stringify-tinderbox Cycles:10 Average:60.70 Median:60.50 stddev:3.83 (6.3%) stddev-sans-first:3.67 19:26:31 INFO - PROCESS | 1650 | Values: 56.0 60.0 67.0 56.0 67.0 59.0 59.0 61.0 60.0 62.0 19:26:31 INFO - PROCESS | 1650 | 19:26:31 INFO - PROCESS | 1650 | [#10] stanford-crypto-aes Cycles:10 Average:83.00 Median:83.50 stddev:2.75 (3.3%) stddev-sans-first:2.89 19:26:31 INFO - PROCESS | 1650 | Values: 84.0 87.0 80.0 85.0 79.0 83.0 81.0 82.0 87.0 82.0 19:26:31 INFO - PROCESS | 1650 | 19:26:31 INFO - PROCESS | 1650 | [#11] stanford-crypto-ccm Cycles:10 Average:142.50 Median:138.00 stddev:20.58 (14.9%) stddev-sans-first:21.65 19:26:31 INFO - PROCESS | 1650 | Values: 135.0 133.0 133.0 137.0 138.0 139.0 118.0 138.0 193.0 161.0 19:26:31 INFO - PROCESS | 1650 | 19:26:31 INFO - PROCESS | 1650 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:161.00 Median:161.50 stddev:2.00 (1.2%) stddev-sans-first:1.99 19:26:31 INFO - PROCESS | 1650 | Values: 159.0 165.0 163.0 162.0 159.0 162.0 159.0 161.0 160.0 160.0 19:26:31 INFO - PROCESS | 1650 | 19:26:31 INFO - PROCESS | 1650 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.60 Median:64.50 stddev:3.98 (6.2%) stddev-sans-first:4.22 19:26:31 INFO - PROCESS | 1650 | Values: 64.0 65.0 63.0 64.0 62.0 64.0 70.0 65.0 54.0 65.0 19:26:31 INFO - PROCESS | 1650 | -------- Summary: end -------- 19:26:31 INFO - PROCESS | 1650 | 19:26:32 INFO - TEST-INFO | 1650: exit 0 19:26:32 INFO - TEST-OK | kraken | took 59353ms 19:26:32 INFO - SUITE-END | took 1177s 19:26:32 INFO - Completed test suite (00:19:38) 19:26:32 INFO - javascript benchmark 19:26:32 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7794.083407942217, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2874.6837847836723, 3288.717400213917, 3449.137715571107, 3460.9307813843725, 3500.6499350064996, 5724.084146536555, 5725.227094342268, 5744.224529688501, 5816.069428891378, 5838.2410286662725, 5740.79907203248, 5792.68140252286, 5801.013827649299, 5802.5938184327115, 5802.767889284423, 5245.44922783109, 5262.710550919698, 5299.0, 5321.840344789663, 5333.759980800874, 5189.325387699594, 5194.532492075712, 5244.423113457517, 5375.11310633745, 5385.892282154355, 5265.710385928773, 5274.894502109955, 5283.286756287909, 5284.841454756363, 5288.180332048539, 4388.363687265361, 5215.660982036194, 5294.338207724035, 5295.735213239323, 5299.761510732007, 5131.179011358202, 5225.738713064332, 5236.29310043147, 5237.057329680656, 5275.498827611371, 5527.8391537777115, 5780.3063632363965, 5794.159846822187, 5794.420557944214, 5801.158831969383, 5540.2243685884005, 6199.690015499207, 6204.47261982732, 6216.595921265149, 6217.782377616807, 6343.207099112611, 6387.936120638827, 6415.87168256637, 6428.967855160741, 6434.485241180694, 5865.794697185578, 5867.911981320283, 5876.55925805562, 5878.5297176225795, 5882.411758824126, 6324.462420694201, 6324.988001919671, 6365.554411191172, 6371.904421433682, 6390.424861762371, 5431.21247419122, 6114.549543274429, 6176.629402235881, 6256.562040657202, 6295.874082518324, 5110.948890511122, 6391.1371964785085, 6396.968015159894, 6405.775797847053, 6412.647304398303, 6120.14317995481, 6311.747530098836, 6313.810585682345, 6314.936850631527, 6323.30443651198, 6197.070439434031, 6219.40915613016, 6248.4064013918605, 6270.3416141305415, 6289.371062893674, 4995.175795993693, 4995.775190116454, 5002.374703162105, 5028.421731500925, 5039.3952725672425, 4385.101054283864, 4487.977560112178, 4488.416505854283, 4498.955010449919, 4524.6380289576755, 5005.649604527648, 5747.482726554546, 5828.737706803204, 5848.88302233953, 5977.731002104916, 6172.444479996821, 6198.2252218472695, 6298.622082675054, 6340.904886426707, 6355.014972679242, 6005.399460054047, 6076.4531192192035, 6109.327973922865, 6129.540284478682, 6136.29432615255, 5423.511883930465, 5495.807646732345, 5511.118221084607, 5530.640508366943, 5538.529225015838, 6498.415142637185, 6500.609963402211, 6502.902456463063, 6518.902216466757, 6528.37980391862, 5218.608604354613, 6178.845528861814, 6227.750889964532, 6293.622382657055, 6333.778317758856, 6336.556441049082, 6341.7780377688405, 6344.397282258178, 6349.301576826453, 6353.491720662243, 4670.556297151765, 6098.634081955097, 6206.255249370104, 6275.497960163085, 6326.0, 6381.425671689571, 6395.8720825582295, 6399.776007839703, 6404.7438102477245, 6406.071119687526, 6020.4280593343565, 6235.719392627433, 6236.126942228001, 6252.280987686474, 6255.937440625536, 6093.0, 6117.327094019565, 6141.854248382235, 6147.600405973598, 6217.253929528486, 6043.939560604514, 6075.696215189135, 6086.60437071589, 6095.085737139465, 6100.206973093469, 5129.358830146231, 6137.7851775187655, 6214.5028397728975, 6215.192025036717, 6226.377362263737, 5793.536517078539, 5829.59192856496, 5906.852328691817, 5915.58590898633, 6055.576109672281], "value": 5738.071021380576, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [798.8681867491864, 817.4972391978932, 831.9292860106889, 904.7104926423543, 917.3165991336456, 29625.703742962593, 41020.17959640805, 41313.99999999996, 41323.0, 41406.96482587937, 42798.786006069924, 42828.35757463641, 42835.35746963798, 42853.0, 42994.0, 7968.402369822257, 9698.175655069328, 9850.507474626276, 9866.161376283024, 9883.209343252558, 7997.360211183091, 8074.273315401612, 8077.35381169505, 8080.232377924088, 12001.639950801446, 12151.756964860742, 12218.32799196044, 12239.632811015685, 12245.693857653585, 12352.258864468116, 12107.878921210764, 12122.575709850202, 12152.331621760799, 12167.209131406431, 12175.878241217562, 11704.239224450383, 11707.2975621463, 11778.234414763014, 11779.116566257566, 11780.234284771463, 41014.76955691334, 41062.76811695654, 41155.794221029006, 41156.588434115576, 41199.558015469614, 4013.979930100331, 4081.3877918312196, 4091.2226676931286, 4093.5087789465156, 4103.343465045608, 28001.29996750077, 28788.424231515462, 30109.849450752827, 30656.0, 30930.53604195939, 3192.7605429592872, 3282.3599398117376, 3353.279045005336, 3433.570803649544, 3449.534312867781, 353877.0, 357588.0, 358900.0, 359198.9999999974, 359495.0, 54341.0, 54433.72783136059, 54506.72746636241, 54526.72736636292, 54599.45400546023, 57161.0, 57167.71416142893, 57175.714121429126, 57216.71391643015, 57314.0, 14572.344244509022, 15021.474248401253, 15041.699166016619, 15049.774253386207, 15076.24618769057, 12798.424070916832, 12808.487660493662, 12815.679608009688, 12821.910137638219, 12822.80765788514, 11186.552537898393, 11412.201145919871, 11570.652880413601, 12531.122821402414, 13093.869061309455, 4880.877398198434, 5403.081476149064, 5585.134304182858, 5586.821139755499, 5607.719614019283, 1142.8057230270874, 1150.4995327032768, 1163.784699830534, 1167.5096459487036, 1207.0464333176867, 26751.86624066906, 27340.179794606192, 27850.16449506518, 27958.161255162377, 28046.0, 934.5841100710119, 1265.7215412609212, 1290.270996886756, 1291.0962326371578, 1329.7207586406962, 14371.78442323366, 14476.34856431463, 14625.488107916384, 14658.193799340925, 14680.55958321252, 479631.0, 481625.0, 482513.699452025, 482580.5870970693, 483346.0, 48930.26604600934, 49271.75364123157, 51686.0, 51966.0, 52029.47970520322, 1492.1643879427556, 1495.8803295736316, 1507.6306304954917, 1525.4127161042857, 1526.5572983834786, 26708.0, 28875.42249154963, 29672.258193545335, 30925.536116958712, 31245.687543124277, 49988.0, 50149.74625634388, 50302.0, 50331.74834125806, 50523.73690657763, 413415.0, 475351.0, 477200.0, 482677.0, 490561.0, 35509.91635961794, 35634.82182589071, 35721.46417803683, 35919.461208081375, 36445.45331819972, 45130.77434612806, 45469.54530454653, 45679.77160114178, 45769.0, 45861.77069114633, 25590.84841182114, 27788.861055694593, 27878.58182127229, 30593.388132237676, 30952.69047309588, 30366.240843978194, 30534.08397748071, 30644.693553064182, 31230.21924451907, 31351.68648313579, 37147.6998305058, 37771.62228377681, 37966.0, 37991.24017519579, 38129.809350953066, 31342.843285783427, 31651.84174079207, 31817.5227371585, 32202.711891524075, 32207.194820129684, 19408.61182776365, 20216.78699278048, 24297.90659420295, 24860.751392485843, 25261.74738252594], "value": 19504.694311495226, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [394.6704501741046, 423.7309308589047, 428.70205207380883, 432.53502484828806, 463.2264118921401, 21015.789842101593, 21944.341669749912, 22227.888860555693, 23233.0, 23512.0, 23146.0, 23587.174448894293, 23677.289681309547, 23766.405839853967, 24082.0, 6668.599884006963, 6908.7236510539515, 6913.446924246048, 6998.580085194904, 7013.4389248860225, 6595.934040659604, 6913.4123599494105, 6914.654267286615, 6915.343042410988, 6923.619200943971, 6611.867762644744, 6825.6587170641515, 6887.449004079686, 6904.620245886475, 6933.583984960893, 6040.516758659297, 6701.1623547056615, 6857.554258973176, 6867.0, 6946.895796563081, 6729.8654026919185, 6738.191417029988, 6744.966275168642, 6745.494087943375, 6753.864922701568, 27323.726762732316, 27740.583891241648, 27950.301242468897, 28158.296042598893, 28366.29084272889, 2984.8358340291275, 3046.6496352919253, 3073.830939298338, 3074.6925307469296, 3117.3297740985795, 16487.258073386725, 16779.580510487212, 17206.913965430216, 17273.222704978307, 18138.727919081226, 1717.8797484176112, 2136.42316574524, 2192.9342119736434, 2234.530748542808, 2276.6926464927355, 122140.0, 123926.0, 124474.37762811128, 125059.0, 127592.72407275994, 17453.7381939271, 20422.40495888443, 21573.784262157493, 21609.243676471247, 21854.89072554659, 35528.111797205274, 36044.639553604655, 36057.45913811295, 36069.45895811565, 36093.45859812105, 10758.515866786014, 10784.892151078546, 10876.238663293494, 10978.835317470244, 11125.888741112485, 7252.38354739853, 8818.250448711931, 8835.20483156519, 8851.0, 9023.233025192802, 8670.829438025912, 10112.292139550307, 10537.736556586147, 10609.84085238722, 10648.946755266328, 3836.582952739756, 4064.1871625674985, 4285.014446677219, 4307.784610769449, 4376.518582955872, 1044.3264094659055, 1117.3407689463256, 1118.6028959719183, 1130.949107290174, 1190.922590031645, 22437.21469748551, 22480.887595562246, 22906.427339316317, 23838.0, 24803.379915502257, 961.2166084641135, 965.3676841668719, 976.1117383181413, 1002.0580654185043, 1002.2382988928467, 7093.858122837514, 7094.184168820651, 7140.857182856314, 7258.455615828729, 7433.368163706145, 766178.0, 809351.0, 811569.0, 814329.9283503544, 822060.0, 93565.86992773741, 129256.70743292634, 152092.0, 155243.0, 162797.0, 1286.7040580666312, 1315.4738104758173, 1357.2399456304502, 1396.9511067112805, 1443.7762146867462, 18947.810521894604, 20316.89841550783, 21216.833074181068, 21485.14059437605, 21508.0, 52887.0, 57474.7126264366, 65154.674226628566, 66505.66747166234, 67179.32820671926, 93919.0, 94086.05913940773, 94559.52720236355, 96406.55390169294, 96620.0, 9826.213902887896, 11476.713082173012, 11757.589089309338, 11798.233114847508, 11937.283762973902, 10522.684319470429, 12510.812337814757, 12935.676608084874, 13008.674783130118, 13108.147970381895, 11076.778464430827, 11093.889061109285, 11324.263922844988, 11404.144689148514, 11461.197716159788, 8014.398920080901, 10244.0, 10506.947465262625, 10520.316179448311, 10574.15406767472, 11263.211575189986, 11306.0, 11409.828852567052, 11421.371824549396, 11474.541018359172, 10741.409222492526, 11437.428128593703, 11662.88337116618, 11847.170698051053, 11858.407079646156, 10986.077619997306, 11102.61140860066, 11202.66392008241, 11243.100551955988, 11338.0], "value": 11711.695663675031, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1379.2345248387144, 1590.8409159084101, 1631.4942367865956, 1660.4437513433004, 1661.8005839299285, 10916.781664366708, 11572.132090093255, 11593.710157246072, 11596.130290228235, 11598.014168795651, 10983.0, 11302.152338574599, 11498.137639677016, 11507.42462876855, 11519.25124866883, 2467.12417091932, 2504.9874750626223, 2510.573202555561, 2511.7739403453684, 2514.5473814713346, 2434.8904299306487, 2461.0, 2500.1624455807328, 2508.4732206236713, 2508.8871000805007, 2416.9758302416926, 2454.607262837946, 2463.7043554773454, 2468.6420469031978, 2472.9752702473015, 2418.806495480357, 2426.987865060681, 2452.4849781545895, 2459.717132529764, 2462.987685061581, 2399.0, 2421.4309637235237, 2426.1993542131054, 2426.5632186206476, 2428.659987601737, 11099.278546894508, 11348.943255283753, 11351.772964540745, 11377.772444551063, 11395.772084558344, 5986.97006514969, 6159.538034647375, 6163.938360616381, 6171.197744293213, 6190.226221722285, 3523.3481805865995, 3608.2963822054708, 3615.963840361589, 3746.419305007701, 3805.353089974711, 1210.612603966731, 1220.8168774683868, 1232.1621297517684, 1267.8161666558296, 1279.9168054076456, 13952.0, 14272.714545709028, 14575.27123643803, 15357.692846143127, 15507.379704811794, 4127.29835927893, 4336.132773445323, 4413.713108647928, 4452.621527170162, 4897.804087836446, 12257.38713064361, 12264.509419623115, 12282.692932676755, 12290.692732681755, 12296.631101066982, 6073.362296958844, 6087.299960504599, 6092.45167934888, 6093.482054025458, 6095.390460953958, 5365.114756065205, 5478.835634930959, 5479.315085614298, 5544.417836127229, 5552.555795536347, 3924.4113382992778, 4023.8994025149605, 4055.7160998730396, 4085.9795701021303, 4122.42286079949, 1072.5227273863056, 1075.3870293932384, 1076.7146706122883, 1090.1769164281075, 1091.8362245663054, 806.1132753970703, 809.3444310108831, 814.8696208606713, 837.7151768398652, 839.4627438439404, 6275.96862015687, 6643.236027856762, 6674.566153200027, 6777.695003724745, 6881.724731010803, 1018.3228153277987, 1021.1065317846884, 1026.6879403807395, 1037.0873631204493, 1062.68119564132, 3647.6899463545365, 3831.252905683365, 4238.576142385798, 4324.0919406924895, 4387.934180987288, 13586.93206533961, 14227.14637121776, 14248.0, 14262.78766304855, 14276.143431393943, 14125.223112728692, 14129.010969232055, 14137.293135343192, 14141.5050473235, 14151.50469733575, 8659.437136586102, 8896.243819275305, 9048.321375896834, 9860.211183105477, 10218.540165692413, 6691.330866913269, 6790.0, 6819.397441601319, 7006.6846991886505, 7107.857842843217, 12349.93825030869, 12463.813042804546, 12694.619161425171, 12837.165584236995, 12872.35638218104, 12861.292628905127, 12869.485220591072, 12975.545855894998, 13073.019523535962, 13141.211527308393, 9291.67479138227, 9531.380460270339, 9531.47576883278, 9551.283653726137, 9555.713328600154, 10255.282130250811, 10449.477526123512, 10576.942305769362, 10584.047435730821, 10591.788164236827, 8839.46963182211, 8975.102489750972, 9062.864057039282, 9120.868711142397, 9123.406978546373, 8763.3427492937, 8827.117288271122, 8839.46963182211, 8947.821043579223, 8952.01527831951, 7953.721619743281, 8125.715599953974, 8136.349092072738, 8141.185881411811, 8141.470804397695, 5752.626079304831, 5799.565032622654, 5805.709714514173, 5961.552883533665, 5972.671503067373, 4997.950020499894, 5855.297364316139, 5880.26496687914, 5960.135780311917, 6005.609635373687], "value": 5228.864555482311, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [378.5344026846978, 391.65534329789784, 394.9071968087501, 398.52177387135447, 401.55226921981983, 4939.975300123503, 5065.164247899097, 5096.413912400075, 5100.260462232979, 5105.336306280178, 4274.444322238105, 4756.881077973052, 4840.225563909775, 4888.291197776321, 5040.974795126029, 3698.7041036716996, 4230.46393322317, 4257.7445353278745, 4284.743594867891, 4304.526502084768, 3882.9223415531815, 4118.855840045599, 4255.4467919170465, 4274.807633656477, 4358.0, 3706.555213374399, 4071.089171242561, 4169.353750168729, 4267.375564028116, 4282.957170428287, 3257.1531401835455, 3320.0205939247858, 4195.91608167835, 4195.937060944088, 4197.916041679165, 3898.5126859142606, 3933.704972127102, 3944.5858184890462, 3978.9403158952637, 3996.5603783583783, 4937.555619994182, 5014.3674570850235, 5026.195808670595, 5042.268871013719, 5107.9744601277125, 4462.464504259509, 4534.77326133692, 4867.977724677822, 4888.242322440027, 4936.308916751657, 4984.152694042022, 5116.923246151311, 5374.543163831079, 5486.0, 5506.449355064461, 3648.5986541480415, 4073.3075377185655, 4163.188178305231, 4462.977685111586, 4470.329450582406, 5191.196753752969, 5270.0, 5411.404745477994, 5537.723113844291, 5700.7719691212305, 3943.881683549498, 4315.244832154361, 4383.216657422496, 4446.088551846864, 4452.5547445255215, 3784.299904517673, 3904.0, 4526.388937493462, 4531.27499600069, 4640.419947506562, 4527.162474942146, 4605.355250264965, 4817.325574419584, 4873.002069151631, 4890.750254882722, 4625.537446255347, 4817.373741413664, 5010.0, 5277.393099793496, 5376.569874410038, 1245.850497940253, 1341.3695563085334, 1367.589723083071, 1397.2255235850616, 1562.62497000719, 1022.9437380943971, 1067.4395942130443, 1121.9270747401392, 1171.3967306836985, 1198.3888217009214, 4278.358246263086, 4432.911341773147, 4551.294549344857, 4876.609871210295, 5202.193659982709, 4889.608831293488, 5250.503606472137, 5405.216278628043, 5509.787846673726, 5542.699779591505, 4609.631229501631, 4853.635977301717, 4969.01239504194, 5023.748812559357, 5197.946811009706, 2539.987300063488, 2719.904803331874, 2873.396586716813, 2884.783641226916, 2885.5238885584063, 4767.547083027107, 5008.323876276729, 5746.913796293059, 5776.913346299809, 5851.38560451155, 4807.134715751128, 5379.62037962038, 5431.565474762088, 5732.942670573324, 5741.0, 4705.058988202373, 5216.817411390583, 5421.620486565903, 5453.045716999509, 5850.707464626752, 4673.616455607596, 5067.771950262173, 5661.98999355223, 5674.007048766532, 5681.829545113488, 4693.5071817458675, 4702.929456058094, 4740.1230772307235, 5400.891982160413, 5511.862203444946, 5566.944330556643, 5605.0, 5688.7440065198, 5712.828615141552, 5809.0, 4225.873223803291, 4846.297286893451, 4867.853964381075, 4904.656674032926, 5027.9748601258225, 5200.5059519345605, 5327.520523152934, 5628.0, 5643.746031428677, 5672.404397538199, 4940.555350018516, 5339.092354299701, 5350.475114592323, 5402.784373515928, 5426.019502881499, 4518.537397118513, 4878.146324393146, 5268.894622107459, 5456.890862182655, 5494.478024587658, 4385.298352263622, 4910.330487634222, 4933.703977761345, 5021.995600879912, 5250.451116920442, 4749.532841026001, 5404.864878378072, 5409.675419474844, 5423.8033596393525, 5450.400455949763, 4311.93532097025, 4710.6231501479115, 5053.620978426707, 5363.088274993339, 5398.892022159614], "value": 4127.988274072546, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [752.7026824404361, 777.4208214879911, 802.4864086984331, 842.6591236147307, 875.9211670949613, 15896.0, 17568.385106521273, 17587.73618395725, 17601.207945642444, 17680.82319176808, 16037.278322475488, 16147.757783633255, 16271.51185464438, 16300.103494307808, 16303.673926521462, 943.075785729985, 944.7874228298647, 945.54141241498, 945.862849886766, 946.5598496699033, 937.100383631711, 939.821433927555, 940.2008292951006, 940.2055263302499, 940.887093548775, 842.6039761312204, 1029.6602121299952, 1069.198101423932, 1069.5187165775394, 1069.9411532365755, 1060.178361769627, 1061.071562382911, 1061.8247989081792, 1062.829947208443, 1063.957441702331, 783.2050468774198, 784.9372050235968, 785.2696991797626, 785.3442375616368, 785.4541093939714, 17343.306267749274, 17603.735943960724, 17635.118244087873, 18044.90977545117, 18306.725399119023, 12316.384180790925, 14801.629959250997, 14911.850881491155, 15053.849461505355, 15366.30851611669, 11935.761284774257, 12032.217905836093, 12132.696682582919, 12338.629841104781, 12614.873851261462, 3741.887743367676, 3812.8284227209842, 3837.0, 3987.142764305688, 3988.4017397390335, 90766.0, 111585.0, 111586.0, 111786.0, 114617.4269128649, 11265.26775759573, 11318.151138664633, 11403.087752979907, 11717.707057323465, 11815.763684726257, 23718.16986405502, 24097.638535421982, 24137.034518619057, 24163.51672966531, 24171.0, 7921.247481489249, 7975.880361794578, 7990.4406691532195, 8028.518288902685, 8171.346292296602, 4598.540145985442, 4626.167289887785, 4636.884077898079, 4684.672072954929, 4830.758462076952, 3656.4880916671686, 3708.313961917054, 3725.0501122214205, 3748.812559372075, 3770.5286839145106, 643.6781609195402, 665.0722242471725, 668.3216535216759, 670.9228438729511, 682.6382017530717, 577.9971749015455, 608.8386577556951, 677.6273049822578, 686.8282929267683, 714.9499535032602, 10436.791264174673, 10735.302205356784, 10798.406087665096, 11110.55557777696, 11288.435578221057, 589.755251570602, 603.7072020070262, 603.7171011600349, 605.9242594675666, 739.8261408568982, 5130.87172820675, 5303.443138470482, 5303.920441193385, 5321.654092484054, 5327.920081198785, 82985.58507207547, 90632.0, 94687.0, 95636.52181739047, 103885.0, 52835.67910802261, 56023.719881400335, 61082.083768743505, 82836.17163828405, 83617.0, 73740.63129684317, 78570.6071469639, 79203.0, 80603.59698201471, 81907.9999999988, 10962.0, 11338.433078346216, 11342.0, 11421.371824549396, 11603.709907252387, 39461.0, 47255.763721181174, 49899.750501248716, 51050.48949510457, 52569.737151313995, 58727.82544349004, 68297.0, 68921.3107868915, 70076.0, 72009.91985120122, 13914.582562523141, 14848.257587120817, 14982.325795339018, 15032.398704051715, 15090.54728358151, 13055.738885222052, 15289.77065344043, 16037.438689645807, 16136.596585085466, 16718.66562668764, 13540.187588744708, 14309.069910456203, 14672.85327146715, 14899.255037248311, 14942.626434339229, 14285.142891426547, 14830.480933167288, 14850.480233191787, 14971.176585287914, 15628.68742625164, 14226.430942762174, 14592.489262875748, 14719.852801471849, 14853.183074930983, 15510.0, 10088.849245304842, 10784.137269018616, 10906.836397454203, 10991.835122473329, 11170.329780213213, 10334.844977325496, 10889.401082940514, 11854.466549005143, 12344.506219751109, 12613.30626815534], "value": 7922.747653967142, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1401.3, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 114.0, 113.0, 114.0, 113.0, 114.0, 114.0, 115.0, 113.0, 115.0], "value": 112.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 108.0, 110.0, 143.0, 109.0, 109.0, 107.0, 116.0, 126.0, 107.0], "value": 117.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [184.0, 185.0, 182.0, 184.0, 185.0, 186.0, 181.0, 181.0, 184.0, 184.0], "value": 183.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 59.0, 59.0, 92.0, 62.0, 60.0, 59.0, 61.0, 91.0, 83.0], "value": 71.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 68.0, 85.0, 68.0, 69.0, 68.0, 82.0, 69.0, 69.0, 82.0], "value": 74.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 114.0, 89.0, 88.0, 89.0, 88.0, 89.0, 87.0, 87.0, 87.0], "value": 90.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 94.0, 102.0, 95.0, 94.0, 95.0, 95.0, 94.0, 94.0, 96.0], "value": 95.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 82.0, 83.0, 82.0, 84.0, 85.0, 83.0, 85.0, 85.0, 83.0], "value": 83.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 58.0, 59.0, 59.0, 61.0, 62.0, 63.0, 62.0, 61.0, 63.0], "value": 60.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 60.0, 67.0, 56.0, 67.0, 59.0, 59.0, 61.0, 60.0, 62.0], "value": 60.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 87.0, 80.0, 85.0, 79.0, 83.0, 81.0, 82.0, 87.0, 82.0], "value": 83.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [135.0, 133.0, 133.0, 137.0, 138.0, 139.0, 118.0, 138.0, 193.0, 161.0], "value": 142.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 165.0, 163.0, 162.0, 159.0, 162.0, 159.0, 161.0, 160.0, 160.0], "value": 161.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 65.0, 63.0, 64.0, 62.0, 64.0, 70.0, 65.0, 54.0, 65.0], "value": 63.6, "unit": "score"}]}]} 19:26:32 INFO - Return code: 0 19:26:32 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 19:26:32 INFO - # TBPL SUCCESS # 19:26:32 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 19:26:32 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 19:26:32 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 19:26:32 INFO - 2017-04-19 19:26:32.708 screenresolution[1654:9763] starting screenresolution argv=screenresolution get 19:26:32 INFO - 2017-04-19 19:26:32.711 screenresolution[1654:9763] Display 0: 1600x1200x32@60 19:26:32 INFO - 2017-04-19 19:26:32.717 screenresolution[1655:9766] starting screenresolution argv=screenresolution list 19:26:32 INFO - Available Modes on Display 0 19:26:32 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 19:26:32 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 19:26:32 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 19:26:32 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 19:26:32 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 19:26:32 INFO - Intel Iris: 19:26:32 INFO - Chipset Model: Intel Iris 19:26:32 INFO - Type: GPU 19:26:32 INFO - Bus: Built-In 19:26:32 INFO - VRAM (Dynamic, Max): 1536 MB 19:26:32 INFO - Vendor: Intel (0x8086) 19:26:32 INFO - Device ID: 0x0a2e 19:26:32 INFO - Revision ID: 0x0009 19:26:32 INFO - Displays: 19:26:32 INFO - Display: 19:26:32 INFO - Resolution: 1600 x 1200 @ 60 Hz 19:26:32 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 19:26:32 INFO - Display Serial Number: 1600x1200 60 19:26:32 INFO - Main Display: Yes 19:26:32 INFO - Mirror: Off 19:26:32 INFO - Online: Yes 19:26:32 INFO - Rotation: Supported 19:26:32 INFO - Return code: 0 19:26:32 INFO - Running post-action listener: _resource_record_post_action 19:26:32 INFO - [mozharness: 2017-04-20 02:26:32.959841Z] Finished run-tests step (success) 19:26:32 INFO - Running post-run listener: _resource_record_post_run 19:26:33 INFO - Total resource usage - Wall time: 1193s; CPU: 54.0%; Read bytes: 38167552; Write bytes: 420958208; Read time: 246; Write time: 1364 19:26:33 INFO - TinderboxPrint: CPU usage
53.7% 19:26:33 INFO - TinderboxPrint: I/O read bytes / time
38,167,552 / 246 19:26:33 INFO - TinderboxPrint: I/O write bytes / time
420,958,208 / 1,364 19:26:33 INFO - TinderboxPrint: CPU idle
2,210.6 (46.3%) 19:26:33 INFO - TinderboxPrint: CPU system
950.4 (19.9%) 19:26:33 INFO - TinderboxPrint: CPU user
1,612.7 (33.8%) 19:26:33 INFO - TinderboxPrint: Swap in / out
173,871,104 / 0 19:26:33 INFO - install - Wall time: 15s; CPU: 54.0%; Read bytes: 122710528; Write bytes: 124905472; Read time: 11074; Write time: 282 19:26:33 INFO - run-tests - Wall time: 1179s; CPU: 54.0%; Read bytes: 34255872; Write bytes: 294569984; Read time: 218; Write time: 1076 19:26:33 INFO - Running post-run listener: _upload_blobber_files 19:26:33 INFO - Blob upload gear active. 19:26:33 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 19:26:33 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 19:26:33 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'] 19:26:33 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 19:26:33 INFO - (blobuploader) - INFO - Open directory for files ... 19:26:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 19:26:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:26:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:26:34 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 19:26:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:26:34 INFO - (blobuploader) - INFO - Done attempting. 19:26:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 19:26:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:26:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:26:35 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 19:26:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:26:35 INFO - (blobuploader) - INFO - Done attempting. 19:26:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 19:26:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:26:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:26:36 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 19:26:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:26:36 INFO - (blobuploader) - INFO - Done attempting. 19:26:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 19:26:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:26:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:26:39 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 19:26:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:26:39 INFO - (blobuploader) - INFO - Done attempting. 19:26:39 INFO - (blobuploader) - INFO - Iteration through files over. 19:26:39 INFO - Return code: 0 19:26:39 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 19:26:39 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 19:26:39 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/ee2ca9bd54ff93a70a9da8f0179b9f423ea6f751507d2d6c623f9feb96db35bd77d03970b4f48c4ef84df61f1e56de7ef288f924c42c9d4024ceca3e90bf7851", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/0289edfe5ebc57e9f64d52abcc46c7f63dbd196f709889c1ba3b34a56e9a060ab86b5a87adbb46c2e3d3006d1242ec3e033bd8b966ade14474d06eaadfe590f9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/410cc3ec7704b3715c048bac9928e9cc3817536e2fce2d17bbdef43eb609c94c6e32dce9a9165313cead07f2412fe1a56a97fb65878a6cbea047eac63c172f89", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/a973044e7554b21a8548967afb69c2e126637e482e023415780931adf4b57a759c16f6d1924122917b1f1e6e9e98d67d1a7502a8390a94699fc47c7676414e5d"} 19:26:39 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 19:26:39 INFO - Writing to file /builds/slave/test/properties/blobber_files 19:26:39 INFO - Contents: 19:26:39 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/ee2ca9bd54ff93a70a9da8f0179b9f423ea6f751507d2d6c623f9feb96db35bd77d03970b4f48c4ef84df61f1e56de7ef288f924c42c9d4024ceca3e90bf7851", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/0289edfe5ebc57e9f64d52abcc46c7f63dbd196f709889c1ba3b34a56e9a060ab86b5a87adbb46c2e3d3006d1242ec3e033bd8b966ade14474d06eaadfe590f9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/410cc3ec7704b3715c048bac9928e9cc3817536e2fce2d17bbdef43eb609c94c6e32dce9a9165313cead07f2412fe1a56a97fb65878a6cbea047eac63c172f89", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/a973044e7554b21a8548967afb69c2e126637e482e023415780931adf4b57a759c16f6d1924122917b1f1e6e9e98d67d1a7502a8390a94699fc47c7676414e5d"} 19:26:39 INFO - Running post-run listener: copy_logs_to_upload_dir 19:26:39 INFO - Copying logs to upload dir... 19:26:39 INFO - mkdir: /builds/slave/test/build/upload/logs 19:26:39 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1275.428262 ========= master_lag: 0.07 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 15 secs) (at 2017-04-19 19:26:39.064215) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-19 19:26:39.067567) ========= 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.QwNtBq01ym/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.zOsqx2452J/Listeners TMPDIR=/var/folders/ng/csmfm9x9681blsv1wkb387f800000w/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/ee2ca9bd54ff93a70a9da8f0179b9f423ea6f751507d2d6c623f9feb96db35bd77d03970b4f48c4ef84df61f1e56de7ef288f924c42c9d4024ceca3e90bf7851", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/0289edfe5ebc57e9f64d52abcc46c7f63dbd196f709889c1ba3b34a56e9a060ab86b5a87adbb46c2e3d3006d1242ec3e033bd8b966ade14474d06eaadfe590f9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/410cc3ec7704b3715c048bac9928e9cc3817536e2fce2d17bbdef43eb609c94c6e32dce9a9165313cead07f2412fe1a56a97fb65878a6cbea047eac63c172f89", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/a973044e7554b21a8548967afb69c2e126637e482e023415780931adf4b57a759c16f6d1924122917b1f1e6e9e98d67d1a7502a8390a94699fc47c7676414e5d"} build_url:https://queue.taskcluster.net/v1/task/KynrzFL-QUeRgmfBseZKwA/artifacts/public/build/firefox-54.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010941 build_url: 'https://queue.taskcluster.net/v1/task/KynrzFL-QUeRgmfBseZKwA/artifacts/public/build/firefox-54.0.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/ee2ca9bd54ff93a70a9da8f0179b9f423ea6f751507d2d6c623f9feb96db35bd77d03970b4f48c4ef84df61f1e56de7ef288f924c42c9d4024ceca3e90bf7851", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/0289edfe5ebc57e9f64d52abcc46c7f63dbd196f709889c1ba3b34a56e9a060ab86b5a87adbb46c2e3d3006d1242ec3e033bd8b966ade14474d06eaadfe590f9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/410cc3ec7704b3715c048bac9928e9cc3817536e2fce2d17bbdef43eb609c94c6e32dce9a9165313cead07f2412fe1a56a97fb65878a6cbea047eac63c172f89", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/a973044e7554b21a8548967afb69c2e126637e482e023415780931adf4b57a759c16f6d1924122917b1f1e6e9e98d67d1a7502a8390a94699fc47c7676414e5d"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-19 19:26:39.102947) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-19 19:26:39.103347) ========= 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.QwNtBq01ym/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.zOsqx2452J/Listeners TMPDIR=/var/folders/ng/csmfm9x9681blsv1wkb387f800000w/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.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-19 19:26:39.154905) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-19 19:26:39.155609) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-19 19:26:39.156403) ========= ========= Total master_lag: 0.22 =========