builder: mozilla-beta_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0309 starttime: 1483535075.18 results: success (0) buildid: 20170104030638 builduid: 7d4aaecafd124b69825ea722677a2524 revision: 6ef26e7b096abe026cf0c93cb4fcc6ec9f215226 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-01-04 05:04:35.182061) ========= master: http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-01-04 05:04:35.182527) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-04 05:04:35.182811) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-04 05:04:35.245823) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-04 05:04:35.246124) ========= 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.p3mf5tJXCC/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.SK6cx7odb8/Listeners TMPDIR=/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/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-01-04 05:04:35-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 7.29M=0.002s 2017-01-04 05:04:36 (7.29 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.609032 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-04 05:04:35.878854) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-04 05:04:35.879191) ========= 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.p3mf5tJXCC/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.SK6cx7odb8/Listeners TMPDIR=/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/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.019865 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-04 05:04:35.928149) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-04 05:04:35.928621) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 6ef26e7b096abe026cf0c93cb4fcc6ec9f215226 --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 6ef26e7b096abe026cf0c93cb4fcc6ec9f215226 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.p3mf5tJXCC/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.SK6cx7odb8/Listeners TMPDIR=/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/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-01-04 05:04:36,169 truncating revision to first 12 chars 2017-01-04 05:04:36,169 Setting DEBUG logging. 2017-01-04 05:04:36,169 attempt 1/10 2017-01-04 05:04:36,169 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/6ef26e7b096a?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-01-04 05:04:36,830 unpacking tar archive at: mozilla-beta-6ef26e7b096a/testing/mozharness/ program finished with exit code 0 elapsedTime=0.941216 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-04 05:04:36.894712) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-04 05:04:36.895172) ========= script_repo_revision: 6ef26e7b096abe026cf0c93cb4fcc6ec9f215226 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-04 05:04:36.895703) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-04 05:04:36.896020) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-04 05:04:36.918733) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 20 mins, 54 secs) (at 2017-01-04 05:04:36.919149) ========= /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.p3mf5tJXCC/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.SK6cx7odb8/Listeners TMPDIR=/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/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 05:04:37 INFO - MultiFileLogger online at 20170104 05:04:37 in /builds/slave/test 05:04:37 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 05:04:37 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:04:37 INFO - {'append_to_log': False, 05:04:37 INFO - 'base_work_dir': '/builds/slave/test', 05:04:37 INFO - 'blob_upload_branch': 'Mozilla-Beta', 05:04:37 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:04:37 INFO - 'branch': 'Mozilla-Beta', 05:04:37 INFO - 'buildbot_json_path': 'buildprops.json', 05:04:37 INFO - 'config_files': ('talos/mac_config.py',), 05:04:37 INFO - 'default_actions': ('clobber', 05:04:37 INFO - 'read-buildbot-config', 05:04:37 INFO - 'download-and-extract', 05:04:37 INFO - 'populate-webroot', 05:04:37 INFO - 'create-virtualenv', 05:04:37 INFO - 'install', 05:04:37 INFO - 'run-tests'), 05:04:37 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:04:37 INFO - 'download_minidump_stackwalk': True, 05:04:37 INFO - 'download_symbols': 'ondemand', 05:04:37 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:04:37 INFO - 'tooltool.py': '/tools/tooltool.py', 05:04:37 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:04:37 INFO - '/tools/misc-python/virtualenv.py')}, 05:04:37 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:04:37 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:04:37 INFO - 'installer_path': 'installer.exe', 05:04:37 INFO - 'log_level': 'info', 05:04:37 INFO - 'log_name': 'talos', 05:04:37 INFO - 'log_to_console': True, 05:04:37 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 05:04:37 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 05:04:37 INFO - 'opt_config_files': (), 05:04:37 INFO - 'pip_index': False, 05:04:37 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:04:37 INFO - 'cmd': ('bash', 05:04:37 INFO - '-c', 05:04:37 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:04:37 INFO - 'enabled': True, 05:04:37 INFO - 'halt_on_failure': False, 05:04:37 INFO - 'name': 'check_screen_resolution'},), 05:04:37 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:04:37 INFO - 'cmd': ('bash', 05:04:37 INFO - '-c', 05:04:37 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:04:37 INFO - 'enabled': True, 05:04:37 INFO - 'halt_on_failure': False, 05:04:37 INFO - 'name': 'check_screen_resolution'},), 05:04:37 INFO - 'run_cmd_checks_enabled': True, 05:04:37 INFO - 'sps_profile': False, 05:04:37 INFO - 'sps_profile_interval': 0, 05:04:37 INFO - 'suite': 'dromaeojs', 05:04:37 INFO - 'system_bits': '32', 05:04:37 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:04:37 INFO - 'title': 't-yosemite-r7-0309', 05:04:37 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:04:37 INFO - 'use_talos_json': True, 05:04:37 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:04:37 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:04:37 INFO - 'work_dir': 'build'} 05:04:37 INFO - [mozharness: 2017-01-04 13:04:37.284100Z] Running clobber step. 05:04:37 INFO - Running pre-action listener: _resource_record_pre_action 05:04:37 INFO - Running main action method: clobber 05:04:37 INFO - rmtree: /builds/slave/test/build 05:04:37 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:04:38 INFO - Running post-action listener: _resource_record_post_action 05:04:38 INFO - [mozharness: 2017-01-04 13:04:38.261438Z] Finished clobber step (success) 05:04:38 INFO - [mozharness: 2017-01-04 13:04:38.261593Z] Running read-buildbot-config step. 05:04:38 INFO - Running pre-action listener: _resource_record_pre_action 05:04:38 INFO - Running main action method: read_buildbot_config 05:04:38 INFO - Using buildbot properties: 05:04:38 INFO - { 05:04:38 INFO - "project": "", 05:04:38 INFO - "product": "firefox", 05:04:38 INFO - "script_repo_revision": "production", 05:04:38 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs", 05:04:38 INFO - "repository": "", 05:04:38 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs", 05:04:38 INFO - "buildid": "20170104030638", 05:04:38 INFO - "pgo_build": "False", 05:04:38 INFO - "basedir": "/builds/slave/test", 05:04:38 INFO - "buildnumber": 2, 05:04:38 INFO - "slavename": "t-yosemite-r7-0309", 05:04:38 INFO - "master": "http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/", 05:04:38 INFO - "platform": "yosemite_r7", 05:04:38 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 05:04:38 INFO - "branch": "mozilla-beta", 05:04:38 INFO - "repo_path": "releases/mozilla-beta", 05:04:38 INFO - "revision": "6ef26e7b096abe026cf0c93cb4fcc6ec9f215226", 05:04:38 INFO - "stage_platform": "macosx64", 05:04:38 INFO - "builduid": "7d4aaecafd124b69825ea722677a2524", 05:04:38 INFO - "slavebuilddir": "test" 05:04:38 INFO - } 05:04:38 INFO - Found installer url https://queue.taskcluster.net/v1/task/Ss5zA1YgTLSzNuL2I3XhRQ/artifacts/public/build/firefox-51.0.en-US.mac.dmg. 05:04:38 INFO - Running post-action listener: _resource_record_post_action 05:04:38 INFO - [mozharness: 2017-01-04 13:04:38.265029Z] Finished read-buildbot-config step (success) 05:04:38 INFO - [mozharness: 2017-01-04 13:04:38.265138Z] Running download-and-extract step. 05:04:38 INFO - Running pre-action listener: _resource_record_pre_action 05:04:38 INFO - Running main action method: download_and_extract 05:04:38 INFO - mkdir: /builds/slave/test/build/tests 05:04: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')]} 05:04:38 INFO - trying https://queue.taskcluster.net/v1/task/Ss5zA1YgTLSzNuL2I3XhRQ/artifacts/public/build/firefox-51.0.en-US.mac.test_packages.json 05:04:38 INFO - Downloading https://queue.taskcluster.net/v1/task/Ss5zA1YgTLSzNuL2I3XhRQ/artifacts/public/build/firefox-51.0.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-51.0.en-US.mac.test_packages.json 05:04:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Ss5zA1YgTLSzNuL2I3XhRQ/artifacts/public/build/firefox-51.0.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0.en-US.mac.test_packages.json'}, attempt #1 05:04:39 INFO - Downloaded 1165 bytes. 05:04:39 INFO - Reading from file /builds/slave/test/build/firefox-51.0.en-US.mac.test_packages.json 05:04:39 INFO - Using the following test package requirements: 05:04:39 INFO - {u'common': [u'firefox-51.0.en-US.mac.common.tests.zip'], 05:04:39 INFO - u'cppunittest': [u'firefox-51.0.en-US.mac.common.tests.zip', 05:04:39 INFO - u'firefox-51.0.en-US.mac.cppunittest.tests.zip'], 05:04:39 INFO - u'gtest': [u'firefox-51.0.en-US.mac.common.tests.zip', 05:04:39 INFO - u'firefox-51.0.en-US.mac.gtest.tests.zip'], 05:04:39 INFO - u'jittest': [u'firefox-51.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 05:04:39 INFO - u'mochitest': [u'firefox-51.0.en-US.mac.common.tests.zip', 05:04:39 INFO - u'firefox-51.0.en-US.mac.mochitest.tests.zip'], 05:04:39 INFO - u'mozbase': [u'firefox-51.0.en-US.mac.common.tests.zip'], 05:04:39 INFO - u'reftest': [u'firefox-51.0.en-US.mac.common.tests.zip', 05:04:39 INFO - u'firefox-51.0.en-US.mac.reftest.tests.zip'], 05:04:39 INFO - u'talos': [u'firefox-51.0.en-US.mac.common.tests.zip', 05:04:39 INFO - u'firefox-51.0.en-US.mac.talos.tests.zip'], 05:04:39 INFO - u'web-platform': [u'firefox-51.0.en-US.mac.common.tests.zip', 05:04:39 INFO - u'firefox-51.0.en-US.mac.web-platform.tests.zip'], 05:04:39 INFO - u'xpcshell': [u'firefox-51.0.en-US.mac.common.tests.zip', 05:04:39 INFO - u'firefox-51.0.en-US.mac.xpcshell.tests.zip']} 05:04:39 INFO - Downloading packages: [u'firefox-51.0.en-US.mac.common.tests.zip'] for test suite category: common 05:04:39 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Ss5zA1YgTLSzNuL2I3XhRQ/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip 05:04:39 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Ss5zA1YgTLSzNuL2I3XhRQ/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip'}, attempt #1 05:04:39 INFO - Fetch https://queue.taskcluster.net/v1/task/Ss5zA1YgTLSzNuL2I3XhRQ/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip into memory 05:04:39 INFO - Expected file size: 16234503 05:04:46 INFO - Downloading packages: [u'firefox-51.0.en-US.mac.common.tests.zip', u'firefox-51.0.en-US.mac.talos.tests.zip'] for test suite category: talos 05:04:46 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Ss5zA1YgTLSzNuL2I3XhRQ/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip 05:04:46 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Ss5zA1YgTLSzNuL2I3XhRQ/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip'}, attempt #1 05:04:46 INFO - Fetch https://queue.taskcluster.net/v1/task/Ss5zA1YgTLSzNuL2I3XhRQ/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip into memory 05:04:47 INFO - Expected file size: 16234503 05:04:53 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Ss5zA1YgTLSzNuL2I3XhRQ/artifacts/public/build/firefox-51.0.en-US.mac.talos.tests.zip 05:04:53 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Ss5zA1YgTLSzNuL2I3XhRQ/artifacts/public/build/firefox-51.0.en-US.mac.talos.tests.zip'}, attempt #1 05:04:53 INFO - Fetch https://queue.taskcluster.net/v1/task/Ss5zA1YgTLSzNuL2I3XhRQ/artifacts/public/build/firefox-51.0.en-US.mac.talos.tests.zip into memory 05:04:54 INFO - Expected file size: 14414089 05:04:55 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')]} 05:04:55 INFO - trying https://queue.taskcluster.net/v1/task/Ss5zA1YgTLSzNuL2I3XhRQ/artifacts/public/build/firefox-51.0.en-US.mac.dmg 05:04:55 INFO - Downloading https://queue.taskcluster.net/v1/task/Ss5zA1YgTLSzNuL2I3XhRQ/artifacts/public/build/firefox-51.0.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0.en-US.mac.dmg 05:04:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Ss5zA1YgTLSzNuL2I3XhRQ/artifacts/public/build/firefox-51.0.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-51.0.en-US.mac.dmg'}, attempt #1 05:04:57 INFO - Downloaded 86095631 bytes. 05:04:57 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Ss5zA1YgTLSzNuL2I3XhRQ/artifacts/public/build/firefox-51.0.en-US.mac.dmg 05:04:57 INFO - mkdir: /builds/slave/test/properties 05:04:57 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:04:57 INFO - Writing to file /builds/slave/test/properties/build_url 05:04:57 INFO - Contents: 05:04:57 INFO - build_url:https://queue.taskcluster.net/v1/task/Ss5zA1YgTLSzNuL2I3XhRQ/artifacts/public/build/firefox-51.0.en-US.mac.dmg 05:04:58 INFO - Running post-action listener: _resource_record_post_action 05:04:58 INFO - Running post-action listener: set_extra_try_arguments 05:04:58 INFO - [mozharness: 2017-01-04 13:04:58.454420Z] Finished download-and-extract step (success) 05:04:58 INFO - [mozharness: 2017-01-04 13:04:58.454535Z] Running populate-webroot step. 05:04:58 INFO - Running pre-action listener: _resource_record_pre_action 05:04:58 INFO - Running main action method: populate_webroot 05:04:58 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:04:58 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:04:58 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:04:58 INFO - '--tppagecycles', 05:04:58 INFO - '7'], 05:04:58 INFO - 'tests': ['tsvgm']}}, 05:04:58 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:04:58 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:04:58 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:04:58 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:04:58 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:04:58 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:04:58 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:04:58 INFO - 'talos_options': ['--disable-e10s'], 05:04:58 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:04:58 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:04:58 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:04:58 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:04:58 INFO - 'talos_options': ['--disable-e10s'], 05:04:58 INFO - 'tests': ['damp', 'tps']}, 05:04:58 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:04:58 INFO - 'tests': ['damp', 'tps']}, 05:04:58 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:04:58 INFO - 'tests': ['dromaeo_dom']}, 05:04:58 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:04:58 INFO - 'g4': {'talos_options': ['--disable-e10s'], 05:04:58 INFO - 'tests': ['basic_compositor_video']}, 05:04:58 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 05:04:58 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:04:58 INFO - 'tests': ['a11yr', 05:04:58 INFO - 'ts_paint', 05:04:58 INFO - 'tpaint', 05:04:58 INFO - 'sessionrestore', 05:04:58 INFO - 'sessionrestore_no_auto_restore', 05:04:58 INFO - 'tabpaint']}, 05:04:58 INFO - 'other-e10s': {'tests': ['a11yr', 05:04:58 INFO - 'ts_paint', 05:04:58 INFO - 'tpaint', 05:04:58 INFO - 'sessionrestore', 05:04:58 INFO - 'sessionrestore_no_auto_restore', 05:04:58 INFO - 'tabpaint']}, 05:04:58 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:04:58 INFO - 'ts_paint', 05:04:58 INFO - 'tpaint', 05:04:58 INFO - 'sessionrestore', 05:04:58 INFO - 'sessionrestore_no_auto_restore', 05:04:58 INFO - 'tabpaint']}, 05:04:58 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:04:58 INFO - 'ts_paint', 05:04:58 INFO - 'tpaint', 05:04:58 INFO - 'sessionrestore', 05:04:58 INFO - 'sessionrestore_no_auto_restore', 05:04:58 INFO - 'tabpaint']}, 05:04:58 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:04:58 INFO - 'tests': ['a11yr', 05:04:58 INFO - 'ts_paint', 05:04:58 INFO - 'tpaint', 05:04:58 INFO - 'sessionrestore', 05:04:58 INFO - 'sessionrestore_no_auto_restore', 05:04:58 INFO - 'tabpaint']}, 05:04:58 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:04:58 INFO - 'tests': ['a11yr', 05:04:58 INFO - 'ts_paint', 05:04:58 INFO - 'tpaint', 05:04:58 INFO - 'sessionrestore', 05:04:58 INFO - 'sessionrestore_no_auto_restore', 05:04:58 INFO - 'tabpaint']}, 05:04:58 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:04:58 INFO - 'tests': ['tsvgx', 05:04:58 INFO - 'tsvgr_opacity', 05:04:58 INFO - 'tart', 05:04:58 INFO - 'tscrollx', 05:04:58 INFO - 'cart']}, 05:04:58 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:04:58 INFO - 'tsvgr_opacity', 05:04:58 INFO - 'tart', 05:04:58 INFO - 'tscrollx', 05:04:58 INFO - 'cart']}, 05:04:58 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:04:58 INFO - 'talos_options': ['--disable-e10s'], 05:04:58 INFO - 'tests': ['tp5o']}, 05:04:58 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:04:58 INFO - 'tests': ['tp5o']}, 05:04:58 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:04:58 INFO - 'talos_options': ['--disable-e10s', 05:04:58 INFO - '--xperf_path', 05:04:58 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:04:58 INFO - 'tests': ['tp5n']}, 05:04:58 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:04:58 INFO - 'talos_options': ['--xperf_path', 05:04:58 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:04:58 INFO - 'tests': ['tp5n']}}, 05:04:58 INFO - 'talos.zip': {'path': '', 05:04:58 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:04:58 INFO - Running post-action listener: _resource_record_post_action 05:04:58 INFO - [mozharness: 2017-01-04 13:04:58.473120Z] Finished populate-webroot step (success) 05:04:58 INFO - [mozharness: 2017-01-04 13:04:58.473244Z] Running create-virtualenv step. 05:04:58 INFO - Running pre-action listener: _resource_record_pre_action 05:04:58 INFO - Running main action method: create_virtualenv 05:04:58 INFO - Creating virtualenv /builds/slave/test/build/venv 05:04:58 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 05:04:58 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:04:58 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:04:58 INFO - Using real prefix '/tools/python27' 05:04:58 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:04:59 INFO - Installing distribute.............................................................................................................................................................................................done. 05:05:02 INFO - Installing pip.................done. 05:05:02 INFO - Return code: 0 05:05:02 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:05:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:05:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:05:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:05:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:05:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:05:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:05:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1077c0490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107736570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcdab48bba0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1075d4d30>, '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 0x10743adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1075ccb20>, '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.p3mf5tJXCC/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.SK6cx7odb8/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/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 05:05:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 05:05:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 05:05:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.p3mf5tJXCC/Render', 05:05:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:05:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:05:02 INFO - 'HOME': '/Users/cltbld', 05:05:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:05:02 INFO - 'LOGNAME': 'cltbld', 05:05:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:05:02 INFO - 'MOZ_NO_REMOTE': '1', 05:05:02 INFO - 'NO_EM_RESTART': '1', 05:05:02 INFO - 'PAGER': '/bin/cat', 05:05:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:05:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:05:02 INFO - 'PWD': '/builds/slave/test', 05:05:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:05:02 INFO - 'SHELL': '/bin/bash', 05:05:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.SK6cx7odb8/Listeners', 05:05:02 INFO - 'TMPDIR': '/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/', 05:05:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:05:02 INFO - 'USER': 'cltbld', 05:05:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:05:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:05:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:05:02 INFO - 'XPC_FLAGS': '0x0', 05:05:02 INFO - 'XPC_SERVICE_NAME': '0', 05:05:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:05:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:05:02 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 05:05:02 INFO - Cleaning up... 05:05:02 INFO - Return code: 0 05:05:02 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:05:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:05:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:05:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:05:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:05:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:05:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:05:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1077c0490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107736570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcdab48bba0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1075d4d30>, '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 0x10743adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1075ccb20>, '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.p3mf5tJXCC/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.SK6cx7odb8/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/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 05:05:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 05:05:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 05:05:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.p3mf5tJXCC/Render', 05:05:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:05:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:05:02 INFO - 'HOME': '/Users/cltbld', 05:05:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:05:02 INFO - 'LOGNAME': 'cltbld', 05:05:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:05:02 INFO - 'MOZ_NO_REMOTE': '1', 05:05:02 INFO - 'NO_EM_RESTART': '1', 05:05:02 INFO - 'PAGER': '/bin/cat', 05:05:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:05:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:05:02 INFO - 'PWD': '/builds/slave/test', 05:05:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:05:02 INFO - 'SHELL': '/bin/bash', 05:05:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.SK6cx7odb8/Listeners', 05:05:02 INFO - 'TMPDIR': '/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/', 05:05:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:05:02 INFO - 'USER': 'cltbld', 05:05:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:05:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:05:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:05:02 INFO - 'XPC_FLAGS': '0x0', 05:05:02 INFO - 'XPC_SERVICE_NAME': '0', 05:05:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:05:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:05:02 INFO - Downloading/unpacking psutil>=3.1.1 05:05:02 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 05:05:02 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 05:05:02 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 05:05:02 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 05:05:02 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 05:05:02 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 05:05:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:05:06 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:05:06 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:05:06 INFO - Installing collected packages: psutil 05:05:06 INFO - Running setup.py install for psutil 05:05:06 INFO - building 'psutil._psutil_osx' extension 05:05:06 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 05:05:07 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 05:05:07 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 05:05:07 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 05:05:07 INFO - building 'psutil._psutil_posix' extension 05:05:07 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 05:05:07 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 05:05:07 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 05:05:07 INFO - ^ 05:05:07 INFO - 1 warning generated. 05:05:07 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 05:05:07 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:05:07 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:05:07 INFO - Successfully installed psutil 05:05:07 INFO - Cleaning up... 05:05:07 INFO - Return code: 0 05:05:07 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:05:07 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')]} 05:05:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:05:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:05:07 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')]} 05:05:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:05:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:05:07 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 0x1077c0490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107736570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcdab48bba0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1075d4d30>, '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 0x10743adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1075ccb20>, '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.p3mf5tJXCC/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.SK6cx7odb8/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/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 05:05:07 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 05:05:07 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 05:05:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.p3mf5tJXCC/Render', 05:05:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:05:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:05:07 INFO - 'HOME': '/Users/cltbld', 05:05:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:05:07 INFO - 'LOGNAME': 'cltbld', 05:05:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:05:07 INFO - 'MOZ_NO_REMOTE': '1', 05:05:07 INFO - 'NO_EM_RESTART': '1', 05:05:07 INFO - 'PAGER': '/bin/cat', 05:05:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:05:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:05:07 INFO - 'PWD': '/builds/slave/test', 05:05:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:05:07 INFO - 'SHELL': '/bin/bash', 05:05:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.SK6cx7odb8/Listeners', 05:05:07 INFO - 'TMPDIR': '/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/', 05:05:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:05:07 INFO - 'USER': 'cltbld', 05:05:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:05:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:05:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:05:07 INFO - 'XPC_FLAGS': '0x0', 05:05:07 INFO - 'XPC_SERVICE_NAME': '0', 05:05:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:05:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:05:07 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:05:07 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 05:05:07 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 05:05:07 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 05:05:07 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 05:05:07 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 05:05:07 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 05:05:10 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:05:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:05:10 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:05:10 INFO - Installing collected packages: mozsystemmonitor 05:05:10 INFO - Running setup.py install for mozsystemmonitor 05:05:10 INFO - Successfully installed mozsystemmonitor 05:05:10 INFO - Cleaning up... 05:05:10 INFO - Return code: 0 05:05:10 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 05:05: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')]} 05:05:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:05:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:05: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')]} 05:05:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:05:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:05: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', '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 0x1077c0490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107736570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcdab48bba0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1075d4d30>, '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 0x10743adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1075ccb20>, '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.p3mf5tJXCC/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.SK6cx7odb8/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/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 05:05: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', 'jsonschema==2.5.1'] in /builds/slave/test/build 05:05: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 jsonschema==2.5.1 05:05:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.p3mf5tJXCC/Render', 05:05:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:05:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:05:10 INFO - 'HOME': '/Users/cltbld', 05:05:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:05:10 INFO - 'LOGNAME': 'cltbld', 05:05:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:05:10 INFO - 'MOZ_NO_REMOTE': '1', 05:05:10 INFO - 'NO_EM_RESTART': '1', 05:05:10 INFO - 'PAGER': '/bin/cat', 05:05:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:05:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:05:10 INFO - 'PWD': '/builds/slave/test', 05:05:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:05:10 INFO - 'SHELL': '/bin/bash', 05:05:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.SK6cx7odb8/Listeners', 05:05:10 INFO - 'TMPDIR': '/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/', 05:05:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:05:10 INFO - 'USER': 'cltbld', 05:05:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:05:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:05:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:05:10 INFO - 'XPC_FLAGS': '0x0', 05:05:10 INFO - 'XPC_SERVICE_NAME': '0', 05:05:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:05:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:05:11 INFO - Downloading/unpacking jsonschema==2.5.1 05:05:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:05:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:05:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:05:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:05:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:05:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:05:13 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:05:13 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 05:05:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:05:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:05:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:05:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:05:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:05:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:05:14 INFO - Downloading functools32-3.2.3-2.tar.gz 05:05:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:05:14 INFO - warning: no files found matching '*.txt' 05:05:14 INFO - no previously-included directories found matching 'build' 05:05:14 INFO - no previously-included directories found matching 'dist' 05:05:14 INFO - no previously-included directories found matching '.git*' 05:05:14 INFO - Installing collected packages: jsonschema, functools32 05:05:14 INFO - Running setup.py install for functools32 05:05:14 INFO - warning: no files found matching '*.txt' 05:05:14 INFO - no previously-included directories found matching 'build' 05:05:14 INFO - no previously-included directories found matching 'dist' 05:05:14 INFO - no previously-included directories found matching '.git*' 05:05:14 INFO - Successfully installed jsonschema functools32 05:05:14 INFO - Cleaning up... 05:05:14 INFO - Return code: 0 05:05:14 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 05:05: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')]} 05:05:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:05:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:05: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')]} 05:05:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:05:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:05: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', '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 0x1077c0490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107736570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcdab48bba0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1075d4d30>, '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 0x10743adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1075ccb20>, '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.p3mf5tJXCC/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.SK6cx7odb8/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/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 05:05: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', 'functools32==3.2.3-2'] in /builds/slave/test/build 05:05: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 functools32==3.2.3-2 05:05:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.p3mf5tJXCC/Render', 05:05:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:05:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:05:14 INFO - 'HOME': '/Users/cltbld', 05:05:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:05:14 INFO - 'LOGNAME': 'cltbld', 05:05:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:05:14 INFO - 'MOZ_NO_REMOTE': '1', 05:05:14 INFO - 'NO_EM_RESTART': '1', 05:05:14 INFO - 'PAGER': '/bin/cat', 05:05:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:05:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:05:14 INFO - 'PWD': '/builds/slave/test', 05:05:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:05:14 INFO - 'SHELL': '/bin/bash', 05:05:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.SK6cx7odb8/Listeners', 05:05:14 INFO - 'TMPDIR': '/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/', 05:05:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:05:14 INFO - 'USER': 'cltbld', 05:05:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:05:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:05:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:05:14 INFO - 'XPC_FLAGS': '0x0', 05:05:14 INFO - 'XPC_SERVICE_NAME': '0', 05:05:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:05:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:05:14 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 05:05:14 INFO - Cleaning up... 05:05:14 INFO - Return code: 0 05:05:14 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:05: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')]} 05:05:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:05:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:05: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')]} 05:05:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:05:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:05: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', '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 0x1077c0490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107736570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcdab48bba0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1075d4d30>, '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 0x10743adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1075ccb20>, '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.p3mf5tJXCC/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.SK6cx7odb8/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/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 05:05: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 05:05: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 blobuploader==1.2.4 05:05:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.p3mf5tJXCC/Render', 05:05:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:05:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:05:14 INFO - 'HOME': '/Users/cltbld', 05:05:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:05:14 INFO - 'LOGNAME': 'cltbld', 05:05:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:05:14 INFO - 'MOZ_NO_REMOTE': '1', 05:05:14 INFO - 'NO_EM_RESTART': '1', 05:05:14 INFO - 'PAGER': '/bin/cat', 05:05:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:05:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:05:14 INFO - 'PWD': '/builds/slave/test', 05:05:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:05:14 INFO - 'SHELL': '/bin/bash', 05:05:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.SK6cx7odb8/Listeners', 05:05:14 INFO - 'TMPDIR': '/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/', 05:05:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:05:14 INFO - 'USER': 'cltbld', 05:05:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:05:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:05:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:05:14 INFO - 'XPC_FLAGS': '0x0', 05:05:14 INFO - 'XPC_SERVICE_NAME': '0', 05:05:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:05:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:05:15 INFO - Downloading/unpacking blobuploader==1.2.4 05:05: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 05:05: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 05:05: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 05:05: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 05:05: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 05:05: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 05:05:17 INFO - Downloading blobuploader-1.2.4.tar.gz 05:05:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:05:17 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:05:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:05:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:05:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:05:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:05:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:05:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:05:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:05:18 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:05:18 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 05:05:18 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 05:05:18 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 05:05:18 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 05:05:18 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 05:05:18 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 05:05:18 INFO - Downloading docopt-0.6.1.tar.gz 05:05:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:05:18 INFO - Installing collected packages: blobuploader, requests, docopt 05:05:18 INFO - Running setup.py install for blobuploader 05:05:19 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:05:19 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:05:19 INFO - Running setup.py install for requests 05:05:19 INFO - Running setup.py install for docopt 05:05:19 INFO - Successfully installed blobuploader requests docopt 05:05:19 INFO - Cleaning up... 05:05:19 INFO - Return code: 0 05:05:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:05:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:05:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:05:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:05:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:05:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:05:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:05:19 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 0x1077c0490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107736570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcdab48bba0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1075d4d30>, '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 0x10743adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1075ccb20>, '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.p3mf5tJXCC/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.SK6cx7odb8/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/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 05:05:19 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 05:05:19 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 05:05:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.p3mf5tJXCC/Render', 05:05:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:05:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:05:19 INFO - 'HOME': '/Users/cltbld', 05:05:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:05:19 INFO - 'LOGNAME': 'cltbld', 05:05:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:05:19 INFO - 'MOZ_NO_REMOTE': '1', 05:05:19 INFO - 'NO_EM_RESTART': '1', 05:05:19 INFO - 'PAGER': '/bin/cat', 05:05:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:05:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:05:19 INFO - 'PWD': '/builds/slave/test', 05:05:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:05:19 INFO - 'SHELL': '/bin/bash', 05:05:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.SK6cx7odb8/Listeners', 05:05:19 INFO - 'TMPDIR': '/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/', 05:05:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:05:19 INFO - 'USER': 'cltbld', 05:05:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:05:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:05:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:05:19 INFO - 'XPC_FLAGS': '0x0', 05:05:19 INFO - 'XPC_SERVICE_NAME': '0', 05:05:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:05:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:05:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:05:20 INFO - Running setup.py (path:/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/pip-quLdEW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:05:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:05:20 INFO - Running setup.py (path:/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/pip-tOH5pT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:05:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:05:20 INFO - Running setup.py (path:/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/pip-_7EY6f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:05:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:05:20 INFO - Running setup.py (path:/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/pip-z2XsFM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:05:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:05:20 INFO - Running setup.py (path:/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/pip-mczVNM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:05:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:05:20 INFO - Running setup.py (path:/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/pip-uuqr_7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:05:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:05:20 INFO - Running setup.py (path:/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/pip-rNDSiR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:05:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:05:20 INFO - Running setup.py (path:/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/pip-sxD67a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:05:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:05:20 INFO - Running setup.py (path:/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/pip-b7tHA0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:05:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:05:21 INFO - Running setup.py (path:/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/pip-_nie4S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:05:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:05:21 INFO - Running setup.py (path:/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/pip-b9p1fB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:05:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:05:21 INFO - Running setup.py (path:/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/pip-F_Lwu2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:05:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:05:21 INFO - Running setup.py (path:/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/pip-ftW3CQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:05:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:05:21 INFO - Running setup.py (path:/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/pip-2ibYle-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:05:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:05:21 INFO - Running setup.py (path:/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/pip-ERahsG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:05:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:05:21 INFO - Running setup.py (path:/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/pip-qmAysU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:05:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:05:21 INFO - Running setup.py (path:/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/pip-rbxQ5l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:05:21 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:05:21 INFO - Running setup.py install for manifestparser 05:05:22 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:05:22 INFO - Running setup.py install for mozcrash 05:05:22 INFO - Running setup.py install for mozdebug 05:05:22 INFO - Running setup.py install for mozdevice 05:05:22 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:05:22 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:05:22 INFO - Running setup.py install for mozfile 05:05:22 INFO - Running setup.py install for mozhttpd 05:05:22 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:05:22 INFO - Running setup.py install for mozinfo 05:05:22 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:05:22 INFO - Running setup.py install for mozInstall 05:05:23 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:05:23 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:05:23 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:05:23 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:05:23 INFO - Running setup.py install for mozleak 05:05:23 INFO - Running setup.py install for mozlog 05:05:23 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:05:23 INFO - Running setup.py install for moznetwork 05:05:23 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:05:23 INFO - Running setup.py install for mozprocess 05:05:23 INFO - Running setup.py install for mozprofile 05:05:23 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:05:23 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:05:23 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:05:23 INFO - Running setup.py install for mozrunner 05:05:24 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:05:24 INFO - Running setup.py install for mozscreenshot 05:05:24 INFO - Running setup.py install for moztest 05:05:24 INFO - Running setup.py install for mozversion 05:05:24 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:05:24 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:05:24 INFO - Cleaning up... 05:05:24 INFO - Return code: 0 05:05:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:05:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:05:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:05:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:05:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:05:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:05:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:05:24 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 0x1077c0490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107736570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcdab48bba0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1075d4d30>, '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 0x10743adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1075ccb20>, '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.p3mf5tJXCC/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.SK6cx7odb8/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/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 05:05:24 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 05:05:24 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 05:05:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.p3mf5tJXCC/Render', 05:05:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:05:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:05:24 INFO - 'HOME': '/Users/cltbld', 05:05:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:05:24 INFO - 'LOGNAME': 'cltbld', 05:05:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:05:24 INFO - 'MOZ_NO_REMOTE': '1', 05:05:24 INFO - 'NO_EM_RESTART': '1', 05:05:24 INFO - 'PAGER': '/bin/cat', 05:05:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:05:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:05:24 INFO - 'PWD': '/builds/slave/test', 05:05:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:05:24 INFO - 'SHELL': '/bin/bash', 05:05:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.SK6cx7odb8/Listeners', 05:05:24 INFO - 'TMPDIR': '/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/', 05:05:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:05:24 INFO - 'USER': 'cltbld', 05:05:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:05:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:05:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:05:24 INFO - 'XPC_FLAGS': '0x0', 05:05:24 INFO - 'XPC_SERVICE_NAME': '0', 05:05:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:05:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:05:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:05:24 INFO - Running setup.py (path:/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/pip-ds_i44-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:05:24 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)) 05:05:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:05:24 INFO - Running setup.py (path:/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/pip-UO7Sv0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:05:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:05:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:05:24 INFO - Running setup.py (path:/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/pip-iIaSWh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:05:25 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)) 05:05:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:05:25 INFO - Running setup.py (path:/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/pip-sDRMM5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:05:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:05:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:05:25 INFO - Running setup.py (path:/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/pip-bHjVU5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:05:25 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)) 05:05:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:05:25 INFO - Running setup.py (path:/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/pip-FtIiPR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:05:25 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)) 05:05:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:05:25 INFO - Running setup.py (path:/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/pip-ym4khe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:05:25 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)) 05:05:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:05:25 INFO - Running setup.py (path:/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/pip-4hvJet-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:05:25 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)) 05:05:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:05:25 INFO - Running setup.py (path:/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/pip-CEJeCe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:05:25 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)) 05:05:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:05:25 INFO - Running setup.py (path:/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/pip-0pvu7Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:05:25 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)) 05:05:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:05:25 INFO - Running setup.py (path:/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/pip-G8dNYb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:05:25 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)) 05:05:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:05:25 INFO - Running setup.py (path:/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/pip-yxXnud-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:05:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 05:05:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:05:26 INFO - Running setup.py (path:/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/pip-Nvmhpr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:05:26 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)) 05:05:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:05:26 INFO - Running setup.py (path:/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/pip-K8J_IR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:05:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 05:05:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:05:26 INFO - Running setup.py (path:/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/pip-oA5CO6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:05:26 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)) 05:05:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:05:26 INFO - Running setup.py (path:/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/pip-_9NKA5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:05:26 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 05:05:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:05:26 INFO - Running setup.py (path:/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/pip-NU2pyX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:05:26 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)) 05:05:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:05:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:05:26 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)) 05:05:26 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:05:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:05:26 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:05: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 05:05: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 05:05: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 05:05: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 05:05: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 05:05: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 05:05:29 INFO - Downloading blessings-1.6.tar.gz 05:05:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:05:29 INFO - Installing collected packages: blessings 05:05:29 INFO - Running setup.py install for blessings 05:05:29 INFO - Successfully installed blessings 05:05:29 INFO - Cleaning up... 05:05:29 INFO - Return code: 0 05:05:29 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:05:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:05:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:05:29 INFO - Reading from file tmpfile_stdout 05:05:29 INFO - Current package versions: 05:05:29 INFO - blessings == 1.6 05:05:29 INFO - blobuploader == 1.2.4 05:05:29 INFO - docopt == 0.6.1 05:05:29 INFO - functools32 == 3.2.3-2 05:05:29 INFO - jsonschema == 2.5.1 05:05:29 INFO - manifestparser == 1.1 05:05:29 INFO - mozInstall == 1.12 05:05:29 INFO - mozcrash == 0.17 05:05:29 INFO - mozdebug == 0.1 05:05:29 INFO - mozdevice == 0.48 05:05:29 INFO - mozfile == 1.2 05:05:29 INFO - mozhttpd == 0.7 05:05:29 INFO - mozinfo == 0.9 05:05:29 INFO - mozleak == 0.1 05:05:29 INFO - mozlog == 3.4 05:05:29 INFO - moznetwork == 0.27 05:05:29 INFO - mozprocess == 0.23 05:05:29 INFO - mozprofile == 0.28 05:05:29 INFO - mozrunner == 6.12 05:05:29 INFO - mozscreenshot == 0.1 05:05:29 INFO - mozsystemmonitor == 0.3 05:05:29 INFO - moztest == 0.7 05:05:29 INFO - mozversion == 1.4 05:05:29 INFO - psutil == 3.1.1 05:05:29 INFO - requests == 1.2.3 05:05:29 INFO - wsgiref == 0.1.2 05:05:29 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:05:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:05:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:05:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:05:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:05:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:05:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:05:29 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 0x1077c0490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107736570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcdab48bba0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1075d4d30>, '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 0x10743adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1075ccb20>, '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.p3mf5tJXCC/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.SK6cx7odb8/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/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 05:05:29 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 05:05:29 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 05:05:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.p3mf5tJXCC/Render', 05:05:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:05:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:05:29 INFO - 'HOME': '/Users/cltbld', 05:05:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:05:29 INFO - 'LOGNAME': 'cltbld', 05:05:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:05:29 INFO - 'MOZ_NO_REMOTE': '1', 05:05:29 INFO - 'NO_EM_RESTART': '1', 05:05:29 INFO - 'PAGER': '/bin/cat', 05:05:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:05:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:05:29 INFO - 'PWD': '/builds/slave/test', 05:05:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:05:29 INFO - 'SHELL': '/bin/bash', 05:05:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.SK6cx7odb8/Listeners', 05:05:29 INFO - 'TMPDIR': '/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/', 05:05:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:05:29 INFO - 'USER': 'cltbld', 05:05:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:05:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:05:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:05:29 INFO - 'XPC_FLAGS': '0x0', 05:05:29 INFO - 'XPC_SERVICE_NAME': '0', 05:05:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:05:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:05:30 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)) 05:05:30 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)) 05:05:30 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)) 05:05:30 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)) 05:05:30 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)) 05:05:30 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)) 05:05:30 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)) 05:05:30 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)) 05:05:30 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)) 05:05:30 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)) 05:05:30 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)) 05:05:30 INFO - Cleaning up... 05:05:30 INFO - Return code: 0 05:05:30 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:05:30 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')]} 05:05:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:05:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:05:30 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')]} 05:05:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:05:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:05:30 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 0x1077c0490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107736570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcdab48bba0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1075d4d30>, '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 0x10743adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1075ccb20>, '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.p3mf5tJXCC/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.SK6cx7odb8/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/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 05:05:30 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 05:05:30 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 05:05:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.p3mf5tJXCC/Render', 05:05:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:05:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:05:30 INFO - 'HOME': '/Users/cltbld', 05:05:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:05:30 INFO - 'LOGNAME': 'cltbld', 05:05:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:05:30 INFO - 'MOZ_NO_REMOTE': '1', 05:05:30 INFO - 'NO_EM_RESTART': '1', 05:05:30 INFO - 'PAGER': '/bin/cat', 05:05:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:05:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:05:30 INFO - 'PWD': '/builds/slave/test', 05:05:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:05:30 INFO - 'SHELL': '/bin/bash', 05:05:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.SK6cx7odb8/Listeners', 05:05:30 INFO - 'TMPDIR': '/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/', 05:05:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:05:30 INFO - 'USER': 'cltbld', 05:05:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:05:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:05:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:05:30 INFO - 'XPC_FLAGS': '0x0', 05:05:30 INFO - 'XPC_SERVICE_NAME': '0', 05:05:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:05:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:05:30 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 05:05:30 INFO - Cleaning up... 05:05:30 INFO - Return code: 0 05:05:30 INFO - Running post-action listener: _resource_record_post_action 05:05:30 INFO - Running post-action listener: _start_resource_monitoring 05:05:30 INFO - Starting resource monitoring. 05:05:30 INFO - [mozharness: 2017-01-04 13:05:30.350001Z] Finished create-virtualenv step (success) 05:05:30 INFO - [mozharness: 2017-01-04 13:05:30.350980Z] Running install step. 05:05:30 INFO - Running pre-action listener: _resource_record_pre_action 05:05:30 INFO - Running main action method: install 05:05:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:05:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:05:30 INFO - Reading from file tmpfile_stdout 05:05:30 INFO - Detecting whether we're running mozinstall >=1.0... 05:05:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:05:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:05:30 INFO - Reading from file tmpfile_stdout 05:05:30 INFO - Output received: 05:05:30 INFO - Usage: mozinstall [options] installer 05:05:30 INFO - Options: 05:05:30 INFO - -h, --help show this help message and exit 05:05:30 INFO - -d DEST, --destination=DEST 05:05:30 INFO - Directory to install application into. [default: 05:05:30 INFO - "/builds/slave/test"] 05:05:30 INFO - --app=APP Application being installed. [default: firefox] 05:05:30 INFO - mkdir: /builds/slave/test/build/application 05:05:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 05:05:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0.en-US.mac.dmg --destination /builds/slave/test/build/application 05:05:52 INFO - Reading from file tmpfile_stdout 05:05:52 INFO - Output received: 05:05:52 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 05:05:52 INFO - Running post-action listener: _resource_record_post_action 05:05:52 INFO - [mozharness: 2017-01-04 13:05:52.630219Z] Finished install step (success) 05:05:52 INFO - [mozharness: 2017-01-04 13:05:52.630355Z] Running run-tests step. 05:05:52 INFO - Running pre-action listener: _resource_record_pre_action 05:05:52 INFO - Running main action method: run_tests 05:05:52 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:05:52 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:05:52 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:05:52 INFO - 2017-01-04 05:05:52.644 screenresolution[2240:19364] starting screenresolution argv=screenresolution get 05:05:52 INFO - 2017-01-04 05:05:52.647 screenresolution[2240:19364] Display 0: 1600x1200x32@60 05:05:52 INFO - 2017-01-04 05:05:52.653 screenresolution[2241:19367] starting screenresolution argv=screenresolution list 05:05:52 INFO - Available Modes on Display 0 05:05:52 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:05:52 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:05:52 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:05:52 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:05:52 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:05:52 INFO - Intel Iris: 05:05:52 INFO - Chipset Model: Intel Iris 05:05:52 INFO - Type: GPU 05:05:52 INFO - Bus: Built-In 05:05:52 INFO - VRAM (Dynamic, Max): 1536 MB 05:05:52 INFO - Vendor: Intel (0x8086) 05:05:52 INFO - Device ID: 0x0a2e 05:05:52 INFO - Revision ID: 0x0009 05:05:52 INFO - Displays: 05:05:52 INFO - Display: 05:05:52 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:05:52 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:05:52 INFO - Display Serial Number: 1600x1200 60 05:05:52 INFO - Main Display: Yes 05:05:52 INFO - Mirror: Off 05:05:52 INFO - Online: Yes 05:05:52 INFO - Rotation: Supported 05:05:52 INFO - Return code: 0 05:05:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:05:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:05:52 INFO - Python 2.7.3 05:05:52 INFO - Return code: 0 05:05:52 INFO - grabbing minidump binary from tooltool 05:05:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:05:52 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 0x1075d4d30>, '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 0x10743adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1075ccb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:05:52 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 05:05:52 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 05:05:52 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 05:05:52 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:05:53 INFO - Return code: 0 05:05:53 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 05:05:53 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:05:53 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:05:53 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 05:05:53 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:05:53 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/Ss5zA1YgTLSzNuL2I3XhRQ/artifacts/public/build/firefox-51.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0309', '--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 05:05:53 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/Ss5zA1YgTLSzNuL2I3XhRQ/artifacts/public/build/firefox-51.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0309 --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 05:05:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.p3mf5tJXCC/Render', 05:05:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:05:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:05:53 INFO - 'HOME': '/Users/cltbld', 05:05:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:05:53 INFO - 'LOGNAME': 'cltbld', 05:05:53 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:05:53 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 05:05:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:05:53 INFO - 'MOZ_NO_REMOTE': '1', 05:05:53 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:05:53 INFO - 'NO_EM_RESTART': '1', 05:05:53 INFO - 'PAGER': '/bin/cat', 05:05:53 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:05:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:05:53 INFO - 'PWD': '/builds/slave/test', 05:05:53 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:05:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:05:53 INFO - 'SHELL': '/bin/bash', 05:05:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.SK6cx7odb8/Listeners', 05:05:53 INFO - 'TMPDIR': '/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/', 05:05:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:05:53 INFO - 'USER': 'cltbld', 05:05:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:05:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:05:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:05:53 INFO - 'XPC_FLAGS': '0x0', 05:05:53 INFO - 'XPC_SERVICE_NAME': '0', 05:05:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:05:53 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/Ss5zA1YgTLSzNuL2I3XhRQ/artifacts/public/build/firefox-51.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0309', '--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 05:05:53 INFO - mozversion application_buildid: 20170104030638 05:05:53 INFO - mozversion application_changeset: 6ef26e7b096abe026cf0c93cb4fcc6ec9f215226 05:05:53 INFO - mozversion application_display_name: Firefox 05:05:53 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:05:53 INFO - mozversion application_name: Firefox 05:05:53 INFO - mozversion application_remotingname: firefox 05:05:53 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 05:05:53 INFO - mozversion application_vendor: Mozilla 05:05:53 INFO - mozversion application_version: 51.0 05:05:53 INFO - mozversion platform_buildid: 20170104030638 05:05:53 INFO - mozversion platform_changeset: 6ef26e7b096abe026cf0c93cb4fcc6ec9f215226 05:05:53 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 05:05:53 INFO - mozversion platform_version: 51.0 05:05:53 INFO - using testdate: 1483535153 05:05:53 INFO - actual date: 1483535153 05:05:53 INFO - starting webserver on 'localhost:49473' 05:05:53 INFO - SUITE-START | Running 2 tests 05:05:53 INFO - TEST-START | dromaeo_css 05:05:53 INFO - operating with platform_type : mac_ 05:05:53 INFO - Initialising browser for dromaeo_css test... 05:05:53 INFO - TEST-INFO | started process 2251 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/tmpKBBnr2/profile http://localhost:49473/getInfo.html) 05:05:55 INFO - PROCESS | 2251 | __metrics Screen width/height:1600/1200 05:05:55 INFO - PROCESS | 2251 | colorDepth:24 05:05:55 INFO - PROCESS | 2251 | Browser inner width/height: 1024/689 05:05:55 INFO - PROCESS | 2251 | __metrics 05:05:55 INFO - PROCESS | 2251 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 05:05:55 INFO - PROCESS | 2251 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:05:56 INFO - TEST-INFO | 2251: exit 0 05:05:56 INFO - Browser initialized. 05:05:56 INFO - Running cycle 1/1 for dromaeo_css test... 05:05:56 INFO - TEST-INFO | started process 2254 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/tmpKBBnr2/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:06:08 INFO - PROCESS | 2254 | RSS: Main: 168550400 05:06:08 INFO - PROCESS | 2254 | 05:06:59 INFO - PROCESS | 2254 | 1483535219773 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 05:09:09 INFO - PROCESS | 2254 | Cycle 1(1): loaded http://localhost:49473/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49473/tests/dromaeo/cssquery-ext.html) 05:09:11 INFO - PROCESS | 2254 | RSS: Main: 268910592 05:09:11 INFO - PROCESS | 2254 | 05:12:13 INFO - PROCESS | 2254 | Cycle 1(1): loaded http://localhost:49473/tests/dromaeo/cssquery-ext.html (next: http://localhost:49473/tests/dromaeo/cssquery-jquery.html) 05:12:14 INFO - PROCESS | 2254 | RSS: Main: 300621824 05:12:14 INFO - PROCESS | 2254 | 05:15:16 INFO - PROCESS | 2254 | Cycle 1(1): loaded http://localhost:49473/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49473/tests/dromaeo/cssquery-mootools.html) 05:15:17 INFO - PROCESS | 2254 | RSS: Main: 265863168 05:15:17 INFO - PROCESS | 2254 | 05:18:19 INFO - PROCESS | 2254 | Cycle 1(1): loaded http://localhost:49473/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49473/tests/dromaeo/cssquery-prototype.html) 05:18:20 INFO - PROCESS | 2254 | RSS: Main: 270864384 05:18:20 INFO - PROCESS | 2254 | 05:21:23 INFO - PROCESS | 2254 | Cycle 1(1): loaded http://localhost:49473/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49473/tests/dromaeo/cssquery-yui.html) 05:21:24 INFO - PROCESS | 2254 | RSS: Main: 262684672 05:21:24 INFO - PROCESS | 2254 | 05:24:27 INFO - PROCESS | 2254 | Cycle 1(1): loaded http://localhost:49473/tests/dromaeo/cssquery-yui.html (next: http://localhost:49473/tests/dromaeo/cssquery-dojo.html) 05:24:27 INFO - PROCESS | 2254 | RSS: Main: 482598912 05:24:27 INFO - PROCESS | 2254 | 05:24:27 INFO - PROCESS | 2254 | __start_tp_report 05:24:27 INFO - PROCESS | 2254 | _x_x_mozilla_page_load 05:24:27 INFO - PROCESS | 2254 | _x_x_mozilla_page_load_details 05:24:27 INFO - PROCESS | 2254 | |i|pagename|runs| 05:24:27 INFO - PROCESS | 2254 | |0;dojo.html;3358.0093872307675;3359.899203023909;3397.150712321918;3426.1434641339665;3444.2250493638935;5617.354004289508;5704.600677952534;5707.315122185343;5720.22776925115;5735.369109397968;5653.378128405872;5720.342160651527;5737.627054241471;5749.367569567345;5774.2782152230975;5181.6113791465605;5202.271681964518;5205.063088644042;5208.531232189102;5255.316808814849;5143.0485360208295;5150.690958542499;5291.1798671206025;5305.310309659758;5333.973330133344;5144.43411224765;5181.963607278541;5182.455842136578;5194.818181363653;5239.554637855767;5202.115640341151;5207.427183009885;5268.446813084647;5282.392524859613;5345.786168553253;5074.13739664258;5122.206058061007;5183.067047931371;5207.583393328525;5213.4525874782985;5600.383957764642;5601.3558440779425;5629.521490673298;5661.745221465044;5682.7442765075675;6077;6120.663363515049;6145.661988590626;6213.56505044647;6226.1905952225925;6129.5116137590185;6249.312575616724;6277.089821975834;6283.151774510428;6337;5667.319921609392;5685.857853553694;5731.140328950691;5748.166515855261;5790.565707571949;6286.615367725664;6322.146510221061;6322.209723784527;6329.367063293634;6332.746690132435;6068.271807383142;6084.452399284086;6098.420650038239;6105.572609917263;6114.969425152845;6133.785317513865;6139.216166136355;6140.052774668185;6150.7847225346895;6196.287426945869;6156.199694039836;6198.566100372931;6200.3179650238435;6218.844528886723;6222.191115155091;6061.878762424727;6123.855272487581;6216.720247588869;6254.405831446005;6263.498920086382;4718.834840780556;4762.59517940972;4768.237082066853;4945.530174633404;4988.6009119270375;3701.7964011979598;4370.781460927004;4393.824247030083;4413.337999300131;4471.619912307425;5617.241672374259;5623.971880140573;5634.098544232903;5649.745761440745;5649.943500564942;6027.547933904974;6269.62382257066;6298.1812364392335;6305.369463053658;6312.52656050798;5506.697131657717;5513.724313784295;5539.529140023144;5564.805231816867;5590;5323.760430780624;5343.679379237258;5349.759260833272;5369.3556773187465;5375.354957405137;6304.495640348761;6312.495000399957;6318.147050148171;6325.304216536269;6344.492440604833;6110.144579758926;6140.600860944024;6144.941444615925;6161.075838624242;6219.813405597658;6280.214973128359;6289.6540690260645;6291.496680265659;6297.905531416941;6309.3690630936535;6166.383361663798;6190.659513726789;6193.597416167935;6209;6215.81352559424;5570.88582283553;5979.4917432018765;6100.816975490742;6129.48104857405;6219.160413344141;6036;6041.546883983631;6079.118527813531;6115.422885572139;6136.672258167471;6033.034714445667;6106.08408738675;6106.1451396803595;6121.663308518075;6134.539909506716;5812.593118481835;5959.67221802805;5979.701014949323;5995.730192141277;6009.338972712911;5955.196048533393;6098.695065246809;6108.17539632144;6139.7106607612905;6148.754049838135;5955.67243801595;5961.642301461926;5964.671943043174;5978.491828194652;5996.820095397145 05:24:27 INFO - PROCESS | 2254 | |1;ext.html;495.43272952469425;512.5361547799243;523.3771811544262;528.2050513976467;534.7246168223365;31674.524882126785;42022.78988605057;43192.704218873405;43296.134077318515;43488.56511434889;43556.3466548002;43950.560494395126;43979.560204397945;44035.77982110085;44041.8989525262;9916.801663966698;10077.647282345119;10087.596496140146;10093.243006774484;10101.141402980755;9219.585118669642;9432.764180895463;12188.451519681636;12388.504459821595;12401.751964960695;12120.515179392814;12178.025757939344;12181.756364872741;12225.205361651464;12236.571719989803;12260.632181034583;12358.62924112278;12380.00959923204;12380.257184568954;12390.938045309806;10044.799104017951;11866.762664746657;11914.46384912681;11931.701707457296;11933;41148.79425602883;41482.96292592679;41501.37747933783;41604;41729.374059389134;3319.9004029879143;3357.6642335766473;3377.4427219509;3580.0691820126694;3910.2179564087296;32157.51763723546;32264.35471290561;32482.6751732482;32514.83742581272;32573.674263257537;2942.8528573571234;3293.769436139471;3347.832608369596;3391.5590973173576;3435.656434356569;489503;492128;492619;495949;496421;60997.08504372438;61302;61442.69278653578;61463.692681536304;61492.38507614867;37518.81240593834;38003;38160.618393816265;38224.61775382211;38248.808755956044;17524.211410486558;17709.02600356993;17747.556311092067;17749.911250443663;17752.28990840352;12284.385780710929;12489.000879929585;13397.598072057854;13533.255670937997;13534.255615941021;17457.825421745874;19823.702644460343;20105.994700264928;20209.898950505154;20218.989050547414;6871.4502839772695;6939.583624982517;8183.304419124322;8187.4678145920325;8238.876416853753;878.1131057631837;943.2736792669606;975.8633791269228;1019.0675531888387;1055.525013743803;29920.700792992226;31226.68773312283;31458.685413146035;31515;31542.36915261682;922.3405265235389;953.5708930981086;1060.8090543702208;1132.5696235430485;1153.446345754026;11387.943060284812;16252.918735406247;16449.342026319053;16713.91643041777;16714.749278760828;727617;734594;735703;735824;736337;50716.23925641119;60182;60262.698686506286;60480.395196048354;60779.696101520094;1282.4805953588811;1315.2371624457792;1403.4035534897832;1408.2325132802648;1444;25054.749452505243;26365;30748.231294217825;32382.83808580942;33380.99857004294;49967;50421.24368134554;50439.74780126076;50441.495585045144;50447.74776126096;584450;586563;659274;669466;844204;26711.33221669396;27066.781994809888;27089.322766930196;27134.592981105696;27174;46872;46982;47061.52938470572;47324;47405.76297118492;37896.53672511278;38249.61750382461;39214.80392598019;39274.2145157101;40474.59525404708;38642;38901.805490972365;39256;40194.79902600585;40559.986000350225;37783.81108094442;38306.80846595749;38753.612463875;39034.80482597569;39118.2176356477;33378.833105835285;34349;34876.12809679677;34907.82546087253;35032.474512882836;24820.772035959904;25570.872145639154;25993.22020339393;26284.73715262823;26425 05:24:27 INFO - PROCESS | 2254 | |2;jquery.html;322.9531717900903;336.9587973162927;359.3639258512435;371.1945079178184;390.63475650267003;19919;21101.26145584905;21631;22180.88909555452;22465.438364040867;20800.47998800031;21071.47321316968;21265.468363290925;21532.677009844825;21761.564768704615;5066.088104141271;5345.1714984177515;5389.51494365507;5545.528630066449;5922.289325280973;5918.2898052233795;5996;5997.460228579427;5999.340072592011;6002.819915402545;5675.233843431146;5843.620164689281;5899.734511946951;5900.852478688024;5945.8810823783715;5669.433056694339;5848.976429124886;5923.970380148093;5927.733252003627;5943.970280148593;5079;5163.0190263849745;5172.948270517322;5183.015227106837;5187.273781670569;26915;27078.45843083147;27120.728792712016;27159.592606110924;27488;2353.388119089032;2396.940076498084;2576.6392705021312;2584.340993046761;2921.401112771877;15757.8969472137;16065.759013614805;16068.357265709357;16129.354825806953;16555.6688866222;1851.2409911936043;1872.6535590915723;1880.4170707080848;1884.2368840619433;1944.6596845551971;100977;125662.74337256602;128849.7115028847;130339;131280.68719312875;8675.73972780805;10094.536292237584;10745.194110441591;10777.407242601732;10893.564257429773;13294.800577991338;13369.331533423485;13417.798733019012;13440.865591344156;13451.192928424325;8012.719554815553;8607.26838218746;8839.779005524913;8954.149355811187;9014.098590140933;8487.193716596914;9087.36388452802;9154.81690366189;9244.3528952974;9266.397684150508;5326.854726233878;6612.404883560503;6711.966440167768;6725.495587830932;6835.624040677711;1499.587613406322;1671.5904603372007;1764.9382271620432;1767.5757818123557;1771.636814453034;919.8252332056887;974.0503009565617;1012.9088382045651;1014.4876837197315;1050.144132531984;20448.56860019814;22819.087236510353;22933.42666433319;23017.424564386023;23081.192158274378;970.5875003123645;992.2558081438921;995.9601615935426;1000.1498726082772;1038.309524166436;11421.771564568662;11649.534018639159;12289;12298.446569904376;12348.135630505958;577887;638372;639877;645127;663497;89447;90748.85944164587;101626.47560286602;118218;119767.8023219774;855.5551113420986;963.1331801378815;1023.6928921323722;1029.4235228272191;1029.9227557933184;20269.695954560397;20572.58854822925;21600.351989440343;21624.89187554052;21714.80568568744;39790.2041959165;48481;54037.72981135226;54631.72684136554;56904.146437804295;81223;81386.18613813785;81633.59183204046;82141;82550;6879.62652884754;7925.643346049557;8062.193780622126;8072.313853322534;8081.717139900075;13310.933445332712;13515.256660883746;13546.59360219195;13666.453341866214;14129.434822606981;11042.33745975244;11681.240719353214;11683.18217724785;11797.76404471923;11804.763904721685;10888.51001704941;11764.70588235301;11856.762864742484;12129.878701212874;12133.75732485363;11667.299962002307;11725.530978761095;11828.112891532997;11885.821712674144;12281.017518598312;7368.963155184189;7730.226977302224;8397.496150231005;8433.83132337362;8584.442011269248;11531.88468115308;11558.364289963796;11617.593384231512;12130.878691213327;12169.69575760613 05:24:27 INFO - PROCESS | 2254 | |3;mootools.html;1524.3978628441766;1535.5009621872891;1780.9198586063626;1878.690016147334;1935.7289979402885;8405.369597280205;8952.328575356858;8971.596278167483;8977.192052715254;9004.72985810425;7851.960740196291;7885.172056934025;8103.554304513249;8190.467619604721;8211.343092552597;2377.476955069886;2389.116027069978;2396.9880150599224;2401.7598240176017;2403.5433267679173;2364.8344615876895;2372.4543355028354;2409.180878501309;2414.541237164933;2422.3580751100885;2378.4886249456363;2394.0782798622567;2394.4612462195955;2413.9396515087174;2424.806015518763;2369.18263199196;2383.892724827378;2387.928362149138;2388.4267775733874;2399.3281881073326;2355.5759963206615;2380.7143142822974;2381.5951288281035;2384.0940442631863;2384.9046038158626;8889.377743557954;8934.553272336358;8982.775430614221;9018.954905225497;9051.547422628842;5274.762635681365;5401.891962160774;5432.782688692487;5437.4562543745305;5450.29146210994;3437.535932649085;3470.7049900758466;3489.4242449995722;3521.154922818531;3538.2392785550974;1063.7978784031009;1065.2596445470401;1081.8972197641212;1082.1721383141903;1097.160672085855;9971;11722.589709360216;11753.764924701458;11781;11791;4103.707332190351;4580.267157254823;4663.930041049387;4801.783919723621;4807.735574543363;10050;10062;10075.748106297255;10089.091981721533;10092.293539452168;5407.459254074561;5417.10617748075;5423.430539793344;5431.402545719968;5431.565474762009;4489.124620698933;4563.885902852388;4630.305454181832;4939.53074457926;4980.950190498121;3938;3939.3697008478507;3988.142549351903;4048.716589838683;4051.2505186539993;1241.1870225002638;1242.3353505874313;1243.7015116372006;1261.5962891874697;1263.791474406731;850.6087199887997;865.3034307382492;880.3969281042506;891.9777005574913;895.7671005538476;6085.1785009023215;6091.604045737013;6146.631202127886;6207.782727604512;6281.905771413432;893.2407453664333;903.6520939438232;938.9201917836924;989.1345073061071;1001.2040427859869;2959.5708622249654;3373.730101591867;3710.7216958727663;3914.4715463412645;4069.2878746219294;10580.523876425425;10810.783784324427;10834.458277086114;10838.187135964834;10893.509792059376;10498.212634052325;10662.41356725372;10732.463376831127;10832.295900766583;11033.393163375931;8326.66693332272;8467.915320846836;8480.83038339242;8499.66001359951;8530.530820804792;5463.96184724901;5974.253218347707;5980.581359304807;6075.210222671025;6113.694315284307;9672.226221902372;10024.949875250577;10025.699229023141;10104.69685909424;10197.388156710622;10232.539535720762;10364.792704145724;10402.635907743193;10408.959104089834;10448.738781530523;6874.621895795779;6928.930710692828;7162.677679504331;7456.47804653669;7643.7324693635455;6610.6694665267505;8360.958195208985;8502.107278735892;8542.273906718;8628.309735221043;7508.136564294958;7614.124375696866;7634.770956871303;7696.8460630788195;7782;6337.207849018872;7446.7021319146625;7453.142888567667;7619.809504762426;7658.502197357154;5975.970120149372;6850.075239842757;6996.895046574407;7003.964980175067;7004.964975175091;4929.009397779961;5024.42219144803;5102.387713474407;5127.230915362726;5141.331626888481;5092.439831618593;5111.437741848319;5144.30551875492;5182.32629758129;5263.578913686973 05:24:27 INFO - PROCESS | 2254 | |4;prototype.html;261.81803646465704;296.8026262535415;303.1753630126057;307.7953161147837;310.35136564580023;5266.078436273651;5306.204069389593;5341.385740639823;5357.866053348664;5359.490848369408;4335.4797424309045;5040.765012571916;5065.505675825631;5306.867328316794;5338.91991620126;3552.8045957472327;4080.204360149772;4081.530623978251;4118.9588104118875;4153.667706583474;3982.084120652252;4105;4112.1775644870995;4145.631941459311;4159.480064991876;3337.0656216259486;3540.256546125304;3726.9254614907686;4033.7983100844986;4065.4308396824467;4005.3591425371947;4014.3777714454304;4020.2361551305157;4025.577314381977;4029.3150164471963;3450.3789317922765;3463.809490478023;3474.270403215328;3476.5132881396626;3510.9824450877836;4384.627306678936;4455.643548516111;4878.756062196911;4915.655904086715;5220.042484068475;4573.438874230442;4582.679212455129;4595.448546174447;4619.036909313562;4620.953790462086;4933.80264789408;5362.2572663884;5601.187827764951;5622.835208444737;5636.379998200195;3158.2262345725444;3454.894433781191;3797.639224273717;3802.2395520895657;3844.75009124406;5492.533134683556;5821.883562328772;5924.022536281508;5946.524278057745;5950.345461999176;3258.6415494295607;3860.8069596520622;3863.285292220948;3885.902852428712;3892.649661530476;3955.7033222508426;3961.7226794124135;3970.900727481836;3972.900677483028;3982.38273067675;3477.1828620274214;3586.5337506124038;3892.3966785148345;3937.9606203938165;4645.6980296280635;5675.744591493392;5680.233168522197;5689.146628005832;5689.374168841424;5694.316681998104;1079.2822772855964;1164.318873459019;1313.7044165062784;1330.7823341642481;1332.6468485851062;847.7456762971084;850.9021462531888;899.150302963706;901.2294488212484;909.2498688581946;5154.793808247703;5210.921836172461;5229.267902493654;5234.345706786652;5238.319018527567;4633.814647414133;4781.85235543474;5834.737436815269;5849.970750146222;5866.413358664185;4390.44139330533;4974.204127339608;5234.633575649668;5278.577713782888;5307.6019298552765;3010.6602561859763;3056.480398332289;3057.785954983174;3069.7083777041144;3078.260782657791;5464.890702185934;5762.798302059407;5881.235439392852;5998.850028749316;6018.307894592091;4785.9042819144115;5556.610847288178;5746.2529871116485;5788.507976822018;5861.460919431097;5245.6852588844795;5251.684898906155;5985.311689155803;6001.579889407787;6008.729607167688;4794.616430685606;5740.253767010262;5884.499817515559;5920.496757775637;5990;4532.456105267389;5824.446677565625;5833.67914764692;5845.853853653693;6004.369541198286;5300.284461597635;5844.532437404912;6118.357572454828;6151;6159.23009623797;3989.72071954972;4083.9591604084767;4086.4891888513935;4095.1195492969155;4120.340745480828;5241.633085684118;5263.868403289948;5995.040793473024;5998.940010599838;5999.550033747573;5398.514133727984;5660.235868157911;5688.687122208318;5823.242978412949;5837;5701.173329867063;5721.084626459747;5726.9713651431475;5747.885042299215;5811.767529298781;5305.787768489372;5312.920306195333;5573.749181286771;5643.266375371176;5676.829695109153;4926.196957965954;5602.439756024365;5711.942880571141;5723.456271654186;5737.328110009514;4674.994876101655;4884.462709102067;5424.077906755782;5615.915761263503;5627.52166065889 05:24:27 INFO - PROCESS | 2254 | |5;yui.html;692.6225207262039;734.3941248470013;765.039874956929;788.5229436191104;811.4319976016787;16064.678706425879;17095.57261068474;17116.572085697848;17128.31486740529;17135.65728685427;15266;15290.541283761477;15317.770233446507;15366.308516116802;15447.45933892314;686.800827759949;703.7747920665389;707.6921539130469;842.3345557009955;851.1488511488511;865.6018231613465;867.3754896474528;878.7451639024707;880.7798050487378;881.1496905486205;919.1635611593451;926.3515539122608;927.7216834949522;928.9024652411501;933.1228645073643;917.8806755121825;920.1534588178891;921.663592788634;921.9815603687922;923.833709932212;689.8551304226069;691.2327316678483;692.4356649330779;693.9340762627543;695.422799076765;16237.59406014859;16394.09832459214;16422;16429.096399698014;16449.58876028097;13687.178769273876;13751.106178098391;13817.861821381757;13926.791098133535;14027;13318.805665790349;13578.524751633646;13678.658033549142;13842.515511957134;13910.956678249171;4601.608863246628;4623.86128416148;4731.881702957419;4919.08996835583;4921.876953076166;99458;102127.48936255272;103931.96068039373;114076;130418.3479082608;10984.176186786022;11315.603953861575;11410;11419.771604567863;11435.942820285845;19479.12343944526;19513.707294390595;22685.88657056737;22878.542429151657;23170;8430.241278284984;8437.40938134337;8497.957510212409;8505.53219572917;8518.361122915681;4503.81984720614;4628.490866004737;4724.598409135193;4789.449213340441;4798.2802579612635;3522.225110475691;3634.182308980511;3669.4495825625836;3681.2269423420844;3681.8527258909344;640.0942666127471;647.4076220258505;647.7668039505868;652.9347065293433;654.6824789976857;598.6647477412663;665.6239224837951;680.4352387518348;681.4990981628499;691.8339598496425;9382.24942004638;9545.140937315675;9559.235261179088;9586.258863921157;9644.614215431444;592.7066102279399;663.1544780405022;679.8878185099403;698.1866125963297;701.5334802356376;4404.4494438195225;4648.1168577970075;4664.696794708333;4678.11115887987;4766.998930224691;95021;111060.444697776;159127.40872591358;167891;172709;75094.62452687701;75257.62371188219;99004;113826.72346553023;125210;73497;114708.85291147149;124499;127217.99999999815;127665;8761.167689069529;8979.955100224457;9063.728088157366;9191.494467804336;9195.586198620944;51943;66841;69134;69658;69794.95307570288;65651.67174164098;67502;85820;86668.56665716883;96611;12456;12883.484660613845;13115.147515411849;13425.932870335586;13592.592222233348;13896.235707035805;14620.342084606005;15433.459828905934;15766.05403675783;16527.008379497267;12936.935315323362;13438.798418023933;14563.781543276647;14704.55886323412;14823.184724840237;13788.241646709528;13856;15096.965299245567;15553.222338882784;15566.84433155654;12909.483620655068;14465.27673616294;14782.298145888532;14800.125559912438;15244.16157111325;10232.33489823189;11181.32912025281;11433.859542901533;12234.449449774604;12246.448909798903;8068.709006558923;10818.459077046273;11578.305301681927;11610.106010923446;11891.940540297242 05:24:27 INFO - PROCESS | 2254 | __end_tp_report 05:24:27 INFO - PROCESS | 2254 | __start_cc_report 05:24:27 INFO - PROCESS | 2254 | _x_x_mozilla_cycle_collect,1344 05:24:27 INFO - PROCESS | 2254 | __end_cc_report 05:24:27 INFO - PROCESS | 2254 | __startTimestamp1483536267256__endTimestamp 05:24:27 INFO - PROCESS | 2254 | 05:24:27 INFO - PROCESS | 2254 | ------- Summary: start ------- 05:24:27 INFO - PROCESS | 2254 | Number of tests: 6 05:24:27 INFO - PROCESS | 2254 | 05:24:27 INFO - PROCESS | 2254 | [#0] dojo.html Cycles:165 Average:5716.56 Median:5978.49 stddev:642.85 (10.8%) stddev-sans-first:617.63 05:24:27 INFO - PROCESS | 2254 | Values: 3358.0 3359.9 3397.2 3426.1 3444.2 5617.4 5704.6 5707.3 5720.2 5735.4 5653.4 5720.3 5737.6 5749.4 5774.3 5181.6 5202.3 5205.1 5208.5 5255.3 5143.0 5150.7 5291.2 5305.3 5334.0 5144.4 5182.0 5182.5 5194.8 5239.6 5202.1 5207.4 5268.4 5282.4 5345.8 5074.1 5122.2 5183.1 5207.6 5213.5 5600.4 5601.4 5629.5 5661.7 5682.7 6077.0 6120.7 6145.7 6213.6 6226.2 6129.5 6249.3 6277.1 6283.2 6337.0 5667.3 5685.9 5731.1 5748.2 5790.6 6286.6 6322.1 6322.2 6329.4 6332.7 6068.3 6084.5 6098.4 6105.6 6115.0 6133.8 6139.2 6140.1 6150.8 6196.3 6156.2 6198.6 6200.3 6218.8 6222.2 6061.9 6123.9 6216.7 6254.4 6263.5 4718.8 4762.6 4768.2 4945.5 4988.6 3701.8 4370.8 4393.8 4413.3 4471.6 5617.2 5624.0 5634.1 5649.7 5649.9 6027.5 6269.6 6298.2 6305.4 6312.5 5506.7 5513.7 5539.5 5564.8 5590.0 5323.8 5343.7 5349.8 5369.4 5375.4 6304.5 6312.5 6318.1 6325.3 6344.5 6110.1 6140.6 6144.9 6161.1 6219.8 6280.2 6289.7 6291.5 6297.9 6309.4 6166.4 6190.7 6193.6 6209.0 6215.8 5570.9 5979.5 6100.8 6129.5 6219.2 6036.0 6041.5 6079.1 6115.4 6136.7 6033.0 6106.1 6106.1 6121.7 6134.5 5812.6 5959.7 5979.7 5995.7 6009.3 5955.2 6098.7 6108.2 6139.7 6148.8 5955.7 5961.6 5964.7 5978.5 5996.8 05:24:27 INFO - PROCESS | 2254 | 05:24:27 INFO - PROCESS | 2254 | [#1] ext.html Cycles:180 Average:75463.04 Median:19306.27 stddev:172400.58 (893.0%) stddev-sans-first:172792.32 05:24:27 INFO - PROCESS | 2254 | Values: 495.4 512.5 523.4 528.2 534.7 31674.5 42022.8 43192.7 43296.1 43488.6 43556.3 43950.6 43979.6 44035.8 44041.9 9916.8 10077.6 10087.6 10093.2 10101.1 9219.6 9432.8 12188.5 12388.5 12401.8 12120.5 12178.0 12181.8 12225.2 12236.6 12260.6 12358.6 12380.0 12380.3 12390.9 10044.8 11866.8 11914.5 11931.7 11933.0 41148.8 41483.0 41501.4 41604.0 41729.4 3319.9 3357.7 3377.4 3580.1 3910.2 32157.5 32264.4 32482.7 32514.8 32573.7 2942.9 3293.8 3347.8 3391.6 3435.7 489503.0 492128.0 492619.0 495949.0 496421.0 60997.1 61302.0 61442.7 61463.7 61492.4 37518.8 38003.0 38160.6 38224.6 38248.8 17524.2 17709.0 17747.6 17749.9 17752.3 12284.4 12489.0 13397.6 13533.3 13534.3 17457.8 19823.7 20106.0 20209.9 20219.0 6871.5 6939.6 8183.3 8187.5 8238.9 878.1 943.3 975.9 1019.1 1055.5 29920.7 31226.7 31458.7 31515.0 31542.4 922.3 953.6 1060.8 1132.6 1153.4 11387.9 16252.9 16449.3 16713.9 16714.7 727617.0 734594.0 735703.0 735824.0 736337.0 50716.2 60182.0 60262.7 60480.4 60779.7 1282.5 1315.2 1403.4 1408.2 1444.0 25054.7 26365.0 30748.2 32382.8 33381.0 49967.0 50421.2 50439.7 50441.5 50447.7 584450.0 586563.0 659274.0 669466.0 844204.0 26711.3 27066.8 27089.3 27134.6 27174.0 46872.0 46982.0 47061.5 47324.0 47405.8 37896.5 38249.6 39214.8 39274.2 40474.6 38642.0 38901.8 39256.0 40194.8 40560.0 37783.8 38306.8 38753.6 39034.8 39118.2 33378.8 34349.0 34876.1 34907.8 35032.5 24820.8 25570.9 25993.2 26284.7 26425.0 05:24:27 INFO - PROCESS | 2254 | 05:24:27 INFO - PROCESS | 2254 | [#2] jquery.html Cycles:180 Average:36019.32 Median:2375.16 stddev:105032.74 (4422.1%) stddev-sans-first:105293.19 05:24:27 INFO - PROCESS | 2254 | Values: 323.0 337.0 359.4 371.2 390.6 19919.0 21101.3 21631.0 22180.9 22465.4 20800.5 21071.5 21265.5 21532.7 21761.6 5066.1 5345.2 5389.5 5545.5 5922.3 5918.3 5996.0 5997.5 5999.3 6002.8 5675.2 5843.6 5899.7 5900.9 5945.9 5669.4 5849.0 5924.0 5927.7 5944.0 5079.0 5163.0 5172.9 5183.0 5187.3 26915.0 27078.5 27120.7 27159.6 27488.0 2353.4 2396.9 2576.6 2584.3 2921.4 15757.9 16065.8 16068.4 16129.4 16555.7 1851.2 1872.7 1880.4 1884.2 1944.7 100977.0 125662.7 128849.7 130339.0 131280.7 8675.7 10094.5 10745.2 10777.4 10893.6 13294.8 13369.3 13417.8 13440.9 13451.2 8012.7 8607.3 8839.8 8954.1 9014.1 8487.2 9087.4 9154.8 9244.4 9266.4 5326.9 6612.4 6712.0 6725.5 6835.6 1499.6 1671.6 1764.9 1767.6 1771.6 919.8 974.1 1012.9 1014.5 1050.1 20448.6 22819.1 22933.4 23017.4 23081.2 970.6 992.3 996.0 1000.1 1038.3 11421.8 11649.5 12289.0 12298.4 12348.1 577887.0 638372.0 639877.0 645127.0 663497.0 89447.0 90748.9 101626.5 118218.0 119767.8 855.6 963.1 1023.7 1029.4 1029.9 20269.7 20572.6 21600.4 21624.9 21714.8 39790.2 48481.0 54037.7 54631.7 56904.1 81223.0 81386.2 81633.6 82141.0 82550.0 6879.6 7925.6 8062.2 8072.3 8081.7 13310.9 13515.3 13546.6 13666.5 14129.4 11042.3 11681.2 11683.2 11797.8 11804.8 10888.5 11764.7 11856.8 12129.9 12133.8 11667.3 11725.5 11828.1 11885.8 12281.0 7369.0 7730.2 8397.5 8433.8 8584.4 11531.9 11558.4 11617.6 12130.9 12169.7 05:24:27 INFO - PROCESS | 2254 | 05:24:27 INFO - PROCESS | 2254 | [#3] mootools.html Cycles:180 Average:5726.99 Median:4804.76 stddev:3206.82 (66.7%) stddev-sans-first:3200.26 05:24:27 INFO - PROCESS | 2254 | Values: 1524.4 1535.5 1780.9 1878.7 1935.7 8405.4 8952.3 8971.6 8977.2 9004.7 7852.0 7885.2 8103.6 8190.5 8211.3 2377.5 2389.1 2397.0 2401.8 2403.5 2364.8 2372.5 2409.2 2414.5 2422.4 2378.5 2394.1 2394.5 2413.9 2424.8 2369.2 2383.9 2387.9 2388.4 2399.3 2355.6 2380.7 2381.6 2384.1 2384.9 8889.4 8934.6 8982.8 9019.0 9051.5 5274.8 5401.9 5432.8 5437.5 5450.3 3437.5 3470.7 3489.4 3521.2 3538.2 1063.8 1065.3 1081.9 1082.2 1097.2 9971.0 11722.6 11753.8 11781.0 11791.0 4103.7 4580.3 4663.9 4801.8 4807.7 10050.0 10062.0 10075.7 10089.1 10092.3 5407.5 5417.1 5423.4 5431.4 5431.6 4489.1 4563.9 4630.3 4939.5 4981.0 3938.0 3939.4 3988.1 4048.7 4051.3 1241.2 1242.3 1243.7 1261.6 1263.8 850.6 865.3 880.4 892.0 895.8 6085.2 6091.6 6146.6 6207.8 6281.9 893.2 903.7 938.9 989.1 1001.2 2959.6 3373.7 3710.7 3914.5 4069.3 10580.5 10810.8 10834.5 10838.2 10893.5 10498.2 10662.4 10732.5 10832.3 11033.4 8326.7 8467.9 8480.8 8499.7 8530.5 5464.0 5974.3 5980.6 6075.2 6113.7 9672.2 10024.9 10025.7 10104.7 10197.4 10232.5 10364.8 10402.6 10409.0 10448.7 6874.6 6928.9 7162.7 7456.5 7643.7 6610.7 8361.0 8502.1 8542.3 8628.3 7508.1 7614.1 7634.8 7696.8 7782.0 6337.2 7446.7 7453.1 7619.8 7658.5 5976.0 6850.1 6996.9 7004.0 7005.0 4929.0 5024.4 5102.4 5127.2 5141.3 5092.4 5111.4 5144.3 5182.3 5263.6 05:24:27 INFO - PROCESS | 2254 | 05:24:27 INFO - PROCESS | 2254 | [#4] prototype.html Cycles:180 Average:4558.27 Median:5224.66 stddev:1427.07 (27.3%) stddev-sans-first:1394.16 05:24:27 INFO - PROCESS | 2254 | Values: 261.8 296.8 303.2 307.8 310.4 5266.1 5306.2 5341.4 5357.9 5359.5 4335.5 5040.8 5065.5 5306.9 5338.9 3552.8 4080.2 4081.5 4119.0 4153.7 3982.1 4105.0 4112.2 4145.6 4159.5 3337.1 3540.3 3726.9 4033.8 4065.4 4005.4 4014.4 4020.2 4025.6 4029.3 3450.4 3463.8 3474.3 3476.5 3511.0 4384.6 4455.6 4878.8 4915.7 5220.0 4573.4 4582.7 4595.4 4619.0 4621.0 4933.8 5362.3 5601.2 5622.8 5636.4 3158.2 3454.9 3797.6 3802.2 3844.8 5492.5 5821.9 5924.0 5946.5 5950.3 3258.6 3860.8 3863.3 3885.9 3892.6 3955.7 3961.7 3970.9 3972.9 3982.4 3477.2 3586.5 3892.4 3938.0 4645.7 5675.7 5680.2 5689.1 5689.4 5694.3 1079.3 1164.3 1313.7 1330.8 1332.6 847.7 850.9 899.2 901.2 909.2 5154.8 5210.9 5229.3 5234.3 5238.3 4633.8 4781.9 5834.7 5850.0 5866.4 4390.4 4974.2 5234.6 5278.6 5307.6 3010.7 3056.5 3057.8 3069.7 3078.3 5464.9 5762.8 5881.2 5998.9 6018.3 4785.9 5556.6 5746.3 5788.5 5861.5 5245.7 5251.7 5985.3 6001.6 6008.7 4794.6 5740.3 5884.5 5920.5 5990.0 4532.5 5824.4 5833.7 5845.9 6004.4 5300.3 5844.5 6118.4 6151.0 6159.2 3989.7 4084.0 4086.5 4095.1 4120.3 5241.6 5263.9 5995.0 5998.9 5999.6 5398.5 5660.2 5688.7 5823.2 5837.0 5701.2 5721.1 5727.0 5747.9 5811.8 5305.8 5312.9 5573.7 5643.3 5676.8 4926.2 5602.4 5711.9 5723.5 5737.3 4675.0 4884.5 5424.1 5615.9 5627.5 05:24:27 INFO - PROCESS | 2254 | 05:24:27 INFO - PROCESS | 2254 | [#5] yui.html Cycles:180 Average:23968.95 Median:4612.74 stddev:37397.12 (810.7%) stddev-sans-first:37461.19 05:24:27 INFO - PROCESS | 2254 | Values: 692.6 734.4 765.0 788.5 811.4 16064.7 17095.6 17116.6 17128.3 17135.7 15266.0 15290.5 15317.8 15366.3 15447.5 686.8 703.8 707.7 842.3 851.1 865.6 867.4 878.7 880.8 881.1 919.2 926.4 927.7 928.9 933.1 917.9 920.2 921.7 922.0 923.8 689.9 691.2 692.4 693.9 695.4 16237.6 16394.1 16422.0 16429.1 16449.6 13687.2 13751.1 13817.9 13926.8 14027.0 13318.8 13578.5 13678.7 13842.5 13911.0 4601.6 4623.9 4731.9 4919.1 4921.9 99458.0 102127.5 103932.0 114076.0 130418.3 10984.2 11315.6 11410.0 11419.8 11435.9 19479.1 19513.7 22685.9 22878.5 23170.0 8430.2 8437.4 8498.0 8505.5 8518.4 4503.8 4628.5 4724.6 4789.4 4798.3 3522.2 3634.2 3669.4 3681.2 3681.9 640.1 647.4 647.8 652.9 654.7 598.7 665.6 680.4 681.5 691.8 9382.2 9545.1 9559.2 9586.3 9644.6 592.7 663.2 679.9 698.2 701.5 4404.4 4648.1 4664.7 4678.1 4767.0 95021.0 111060.4 159127.4 167891.0 172709.0 75094.6 75257.6 99004.0 113826.7 125210.0 73497.0 114708.9 124499.0 127218.0 127665.0 8761.2 8980.0 9063.7 9191.5 9195.6 51943.0 66841.0 69134.0 69658.0 69795.0 65651.7 67502.0 85820.0 86668.6 96611.0 12456.0 12883.5 13115.1 13425.9 13592.6 13896.2 14620.3 15433.5 15766.1 16527.0 12936.9 13438.8 14563.8 14704.6 14823.2 13788.2 13856.0 15097.0 15553.2 15566.8 12909.5 14465.3 14782.3 14800.1 15244.2 10232.3 11181.3 11433.9 12234.4 12246.4 8068.7 10818.5 11578.3 11610.1 11891.9 05:24:27 INFO - PROCESS | 2254 | -------- Summary: end -------- 05:24:27 INFO - PROCESS | 2254 | 05:24:27 INFO - TEST-INFO | 2254: exit 0 05:24:27 INFO - TEST-OK | dromaeo_css | took 1114587ms 05:24:27 INFO - TEST-START | kraken 05:24:27 INFO - operating with platform_type : mac_ 05:24:27 INFO - Initialising browser for kraken test... 05:24:27 INFO - TEST-INFO | started process 2257 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/tmpWUbUgD/profile http://localhost:49473/getInfo.html) 05:24:29 INFO - PROCESS | 2257 | __metrics Screen width/height:1600/1200 05:24:29 INFO - PROCESS | 2257 | colorDepth:24 05:24:29 INFO - PROCESS | 2257 | Browser inner width/height: 1024/689 05:24:29 INFO - PROCESS | 2257 | __metrics 05:24:29 INFO - PROCESS | 2257 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 05:24:29 INFO - PROCESS | 2257 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:24:30 INFO - TEST-INFO | 2257: exit 0 05:24:30 INFO - Browser initialized. 05:24:30 INFO - Running cycle 1/1 for kraken test... 05:24:30 INFO - TEST-INFO | started process 2259 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/tmpWUbUgD/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:24:42 INFO - PROCESS | 2259 | RSS: Main: 168845312 05:24:42 INFO - PROCESS | 2259 | 05:24:45 INFO - PROCESS | 2259 | Cycle 1(1): loaded http://localhost:49473/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49473/tests/kraken/driver.html?testName=audio-beat-detection) 05:24:46 INFO - PROCESS | 2259 | RSS: Main: 218689536 05:24:46 INFO - PROCESS | 2259 | 05:24:48 INFO - PROCESS | 2259 | Cycle 1(1): loaded http://localhost:49473/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49473/tests/kraken/driver.html?testName=audio-dft) 05:24:49 INFO - PROCESS | 2259 | RSS: Main: 232194048 05:24:49 INFO - PROCESS | 2259 | 05:24:52 INFO - PROCESS | 2259 | Cycle 1(1): loaded http://localhost:49473/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49473/tests/kraken/driver.html?testName=audio-fft) 05:24:53 INFO - PROCESS | 2259 | RSS: Main: 330588160 05:24:53 INFO - PROCESS | 2259 | 05:24:55 INFO - PROCESS | 2259 | Cycle 1(1): loaded http://localhost:49473/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49473/tests/kraken/driver.html?testName=audio-oscillator) 05:24:55 INFO - PROCESS | 2259 | RSS: Main: 228487168 05:24:55 INFO - PROCESS | 2259 | 05:24:57 INFO - PROCESS | 2259 | Cycle 1(1): loaded http://localhost:49473/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49473/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:24:58 INFO - PROCESS | 2259 | RSS: Main: 229097472 05:24:58 INFO - PROCESS | 2259 | 05:25:01 INFO - PROCESS | 2259 | Cycle 1(1): loaded http://localhost:49473/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49473/tests/kraken/driver.html?testName=imaging-darkroom) 05:25:01 INFO - PROCESS | 2259 | RSS: Main: 266805248 05:25:01 INFO - PROCESS | 2259 | 05:25:04 INFO - PROCESS | 2259 | Cycle 1(1): loaded http://localhost:49473/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49473/tests/kraken/driver.html?testName=imaging-desaturate) 05:25:05 INFO - PROCESS | 2259 | RSS: Main: 269078528 05:25:05 INFO - PROCESS | 2259 | 05:25:07 INFO - PROCESS | 2259 | Cycle 1(1): loaded http://localhost:49473/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49473/tests/kraken/driver.html?testName=json-parse-financial) 05:25:08 INFO - PROCESS | 2259 | RSS: Main: 266997760 05:25:08 INFO - PROCESS | 2259 | 05:25:10 INFO - PROCESS | 2259 | Cycle 1(1): loaded http://localhost:49473/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49473/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:25:10 INFO - PROCESS | 2259 | RSS: Main: 240447488 05:25:10 INFO - PROCESS | 2259 | 05:25:12 INFO - PROCESS | 2259 | Cycle 1(1): loaded http://localhost:49473/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49473/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:25:13 INFO - PROCESS | 2259 | RSS: Main: 246763520 05:25:13 INFO - PROCESS | 2259 | 05:25:15 INFO - PROCESS | 2259 | Cycle 1(1): loaded http://localhost:49473/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49473/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:25:16 INFO - PROCESS | 2259 | RSS: Main: 251105280 05:25:16 INFO - PROCESS | 2259 | 05:25:18 INFO - PROCESS | 2259 | Cycle 1(1): loaded http://localhost:49473/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49473/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:25:19 INFO - PROCESS | 2259 | RSS: Main: 268271616 05:25:19 INFO - PROCESS | 2259 | 05:25:22 INFO - PROCESS | 2259 | Cycle 1(1): loaded http://localhost:49473/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49473/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:25:23 INFO - PROCESS | 2259 | RSS: Main: 261541888 05:25:23 INFO - PROCESS | 2259 | 05:25:24 INFO - PROCESS | 2259 | Cycle 1(1): loaded http://localhost:49473/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49473/tests/kraken/driver.html?testName=ai-astar) 05:25:25 INFO - PROCESS | 2259 | RSS: Main: 305410048 05:25:25 INFO - PROCESS | 2259 | 05:25:25 INFO - PROCESS | 2259 | __start_tp_report 05:25:25 INFO - PROCESS | 2259 | _x_x_mozilla_page_load 05:25:25 INFO - PROCESS | 2259 | _x_x_mozilla_page_load_details 05:25:25 INFO - PROCESS | 2259 | |i|pagename|runs| 05:25:25 INFO - PROCESS | 2259 | |0;ai-astar;115;113;113;113;113;113;113;115;113;113 05:25:25 INFO - PROCESS | 2259 | |1;audio-beat-detection;147;109;109;144;109;111;107;109;134;108 05:25:25 INFO - PROCESS | 2259 | |2;audio-dft;183;183;186;184;182;183;196;259;208;183 05:25:25 INFO - PROCESS | 2259 | |3;audio-fft;83;59;58;92;62;59;59;60;83;57 05:25:25 INFO - PROCESS | 2259 | |4;audio-oscillator;89;70;95;69;69;69;92;67;67;90 05:25:25 INFO - PROCESS | 2259 | |5;imaging-gaussian-blur;88;87;90;86;89;85;87;71;93;128 05:25:25 INFO - PROCESS | 2259 | |6;imaging-darkroom;94;93;93;94;110;146;125;93;94;93 05:25:25 INFO - PROCESS | 2259 | |7;imaging-desaturate;84;84;83;85;83;83;82;87;83;84 05:25:25 INFO - PROCESS | 2259 | |8;json-parse-financial;56;52;54;53;56;58;59;57;56;56 05:25:25 INFO - PROCESS | 2259 | |9;json-stringify-tinderbox;66;72;69;75;75;69;69;70;70;71 05:25:25 INFO - PROCESS | 2259 | |10;stanford-crypto-aes;85;86;93;98;73;83;79;77;74;87 05:25:25 INFO - PROCESS | 2259 | |11;stanford-crypto-ccm;140;138;132;137;138;127;149;148;175;167 05:25:25 INFO - PROCESS | 2259 | |12;stanford-crypto-pbkdf2;162;159;158;183;163;161;160;161;161;162 05:25:25 INFO - PROCESS | 2259 | |13;stanford-crypto-sha256-iterative;66;66;66;66;65;64;64;66;65;66 05:25:25 INFO - PROCESS | 2259 | __end_tp_report 05:25:25 INFO - PROCESS | 2259 | __start_cc_report 05:25:25 INFO - PROCESS | 2259 | _x_x_mozilla_cycle_collect,1965 05:25:25 INFO - PROCESS | 2259 | __end_cc_report 05:25:25 INFO - PROCESS | 2259 | __startTimestamp1483536325040__endTimestamp 05:25:25 INFO - PROCESS | 2259 | 05:25:25 INFO - PROCESS | 2259 | ------- Summary: start ------- 05:25:25 INFO - PROCESS | 2259 | Number of tests: 14 05:25:25 INFO - PROCESS | 2259 | 05:25:25 INFO - PROCESS | 2259 | [#0] ai-astar Cycles:10 Average:113.40 Median:113.00 stddev:0.84 (0.7%) stddev-sans-first:0.67 05:25:25 INFO - PROCESS | 2259 | Values: 115.0 113.0 113.0 113.0 113.0 113.0 113.0 115.0 113.0 113.0 05:25:25 INFO - PROCESS | 2259 | 05:25:25 INFO - PROCESS | 2259 | [#1] audio-beat-detection Cycles:10 Average:118.70 Median:110.00 stddev:16.20 (14.7%) stddev-sans-first:13.57 05:25:25 INFO - PROCESS | 2259 | Values: 147.0 109.0 109.0 144.0 109.0 111.0 107.0 109.0 134.0 108.0 05:25:25 INFO - PROCESS | 2259 | 05:25:25 INFO - PROCESS | 2259 | [#2] audio-dft Cycles:10 Average:194.70 Median:185.00 stddev:24.06 (13.0%) stddev-sans-first:25.15 05:25:25 INFO - PROCESS | 2259 | Values: 183.0 183.0 186.0 184.0 182.0 183.0 196.0 259.0 208.0 183.0 05:25:25 INFO - PROCESS | 2259 | 05:25:25 INFO - PROCESS | 2259 | [#3] audio-fft Cycles:10 Average:67.20 Median:61.00 stddev:13.26 (21.7%) stddev-sans-first:12.78 05:25:25 INFO - PROCESS | 2259 | Values: 83.0 59.0 58.0 92.0 62.0 59.0 59.0 60.0 83.0 57.0 05:25:25 INFO - PROCESS | 2259 | 05:25:25 INFO - PROCESS | 2259 | [#4] audio-oscillator Cycles:10 Average:77.70 Median:79.50 stddev:12.01 (15.1%) stddev-sans-first:12.02 05:25:25 INFO - PROCESS | 2259 | Values: 89.0 70.0 95.0 69.0 69.0 69.0 92.0 67.0 67.0 90.0 05:25:25 INFO - PROCESS | 2259 | 05:25:25 INFO - PROCESS | 2259 | [#5] imaging-gaussian-blur Cycles:10 Average:90.40 Median:87.50 stddev:14.44 (16.5%) stddev-sans-first:15.29 05:25:25 INFO - PROCESS | 2259 | Values: 88.0 87.0 90.0 86.0 89.0 85.0 87.0 71.0 93.0 128.0 05:25:25 INFO - PROCESS | 2259 | 05:25:25 INFO - PROCESS | 2259 | [#6] imaging-darkroom Cycles:10 Average:103.50 Median:93.00 stddev:18.33 (19.7%) stddev-sans-first:19.11 05:25:25 INFO - PROCESS | 2259 | Values: 94.0 93.0 93.0 94.0 110.0 146.0 125.0 93.0 94.0 93.0 05:25:25 INFO - PROCESS | 2259 | 05:25:25 INFO - PROCESS | 2259 | [#7] imaging-desaturate Cycles:10 Average:83.80 Median:84.00 stddev:1.40 (1.7%) stddev-sans-first:1.48 05:25:25 INFO - PROCESS | 2259 | Values: 84.0 84.0 83.0 85.0 83.0 83.0 82.0 87.0 83.0 84.0 05:25:25 INFO - PROCESS | 2259 | 05:25:25 INFO - PROCESS | 2259 | [#8] json-parse-financial Cycles:10 Average:55.70 Median:56.00 stddev:2.16 (3.9%) stddev-sans-first:2.29 05:25:25 INFO - PROCESS | 2259 | Values: 56.0 52.0 54.0 53.0 56.0 58.0 59.0 57.0 56.0 56.0 05:25:25 INFO - PROCESS | 2259 | 05:25:25 INFO - PROCESS | 2259 | [#9] json-stringify-tinderbox Cycles:10 Average:70.60 Median:70.50 stddev:2.80 (4.0%) stddev-sans-first:2.42 05:25:25 INFO - PROCESS | 2259 | Values: 66.0 72.0 69.0 75.0 75.0 69.0 69.0 70.0 70.0 71.0 05:25:25 INFO - PROCESS | 2259 | 05:25:25 INFO - PROCESS | 2259 | [#10] stanford-crypto-aes Cycles:10 Average:83.50 Median:85.50 stddev:8.06 (9.4%) stddev-sans-first:8.53 05:25:25 INFO - PROCESS | 2259 | Values: 85.0 86.0 93.0 98.0 73.0 83.0 79.0 77.0 74.0 87.0 05:25:25 INFO - PROCESS | 2259 | 05:25:25 INFO - PROCESS | 2259 | [#11] stanford-crypto-ccm Cycles:10 Average:145.10 Median:144.00 stddev:15.23 (10.6%) stddev-sans-first:16.05 05:25:25 INFO - PROCESS | 2259 | Values: 140.0 138.0 132.0 137.0 138.0 127.0 149.0 148.0 175.0 167.0 05:25:25 INFO - PROCESS | 2259 | 05:25:25 INFO - PROCESS | 2259 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:163.00 Median:161.50 stddev:7.18 (4.4%) stddev-sans-first:7.61 05:25:25 INFO - PROCESS | 2259 | Values: 162.0 159.0 158.0 183.0 163.0 161.0 160.0 161.0 161.0 162.0 05:25:25 INFO - PROCESS | 2259 | 05:25:25 INFO - PROCESS | 2259 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.40 Median:66.00 stddev:0.84 (1.3%) stddev-sans-first:0.87 05:25:25 INFO - PROCESS | 2259 | Values: 66.0 66.0 66.0 66.0 65.0 64.0 64.0 66.0 65.0 66.0 05:25:25 INFO - PROCESS | 2259 | -------- Summary: end -------- 05:25:25 INFO - PROCESS | 2259 | 05:25:25 INFO - TEST-INFO | 2259: exit 0 05:25:25 INFO - TEST-OK | kraken | took 58000ms 05:25:25 INFO - SUITE-END | took 1172s 05:25:26 INFO - Completed test suite (00:19:32) 05:25:26 INFO - javascript benchmark 05:25:26 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3358.0093872307675, 3359.899203023909, 3397.150712321918, 3426.1434641339665, 3444.2250493638935, 5617.354004289508, 5704.600677952534, 5707.315122185343, 5720.22776925115, 5735.369109397968, 5653.378128405872, 5720.342160651527, 5737.627054241471, 5749.367569567345, 5774.2782152230975, 5181.6113791465605, 5202.271681964518, 5205.063088644042, 5208.531232189102, 5255.316808814849, 5143.0485360208295, 5150.690958542499, 5291.1798671206025, 5305.310309659758, 5333.973330133344, 5144.43411224765, 5181.963607278541, 5182.455842136578, 5194.818181363653, 5239.554637855767, 5202.115640341151, 5207.427183009885, 5268.446813084647, 5282.392524859613, 5345.786168553253, 5074.13739664258, 5122.206058061007, 5183.067047931371, 5207.583393328525, 5213.4525874782985, 5600.383957764642, 5601.3558440779425, 5629.521490673298, 5661.745221465044, 5682.7442765075675, 6077.0, 6120.663363515049, 6145.661988590626, 6213.56505044647, 6226.1905952225925, 6129.5116137590185, 6249.312575616724, 6277.089821975834, 6283.151774510428, 6337.0, 5667.319921609392, 5685.857853553694, 5731.140328950691, 5748.166515855261, 5790.565707571949, 6286.615367725664, 6322.146510221061, 6322.209723784527, 6329.367063293634, 6332.746690132435, 6068.271807383142, 6084.452399284086, 6098.420650038239, 6105.572609917263, 6114.969425152845, 6133.785317513865, 6139.216166136355, 6140.052774668185, 6150.7847225346895, 6196.287426945869, 6156.199694039836, 6198.566100372931, 6200.3179650238435, 6218.844528886723, 6222.191115155091, 6061.878762424727, 6123.855272487581, 6216.720247588869, 6254.405831446005, 6263.498920086382, 4718.834840780556, 4762.59517940972, 4768.237082066853, 4945.530174633404, 4988.6009119270375, 3701.7964011979598, 4370.781460927004, 4393.824247030083, 4413.337999300131, 4471.619912307425, 5617.241672374259, 5623.971880140573, 5634.098544232903, 5649.745761440745, 5649.943500564942, 6027.547933904974, 6269.62382257066, 6298.1812364392335, 6305.369463053658, 6312.52656050798, 5506.697131657717, 5513.724313784295, 5539.529140023144, 5564.805231816867, 5590.0, 5323.760430780624, 5343.679379237258, 5349.759260833272, 5369.3556773187465, 5375.354957405137, 6304.495640348761, 6312.495000399957, 6318.147050148171, 6325.304216536269, 6344.492440604833, 6110.144579758926, 6140.600860944024, 6144.941444615925, 6161.075838624242, 6219.813405597658, 6280.214973128359, 6289.6540690260645, 6291.496680265659, 6297.905531416941, 6309.3690630936535, 6166.383361663798, 6190.659513726789, 6193.597416167935, 6209.0, 6215.81352559424, 5570.88582283553, 5979.4917432018765, 6100.816975490742, 6129.48104857405, 6219.160413344141, 6036.0, 6041.546883983631, 6079.118527813531, 6115.422885572139, 6136.672258167471, 6033.034714445667, 6106.08408738675, 6106.1451396803595, 6121.663308518075, 6134.539909506716, 5812.593118481835, 5959.67221802805, 5979.701014949323, 5995.730192141277, 6009.338972712911, 5955.196048533393, 6098.695065246809, 6108.17539632144, 6139.7106607612905, 6148.754049838135, 5955.67243801595, 5961.642301461926, 5964.671943043174, 5978.491828194652, 5996.820095397145], "value": 5674.628427358661, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [495.43272952469425, 512.5361547799243, 523.3771811544262, 528.2050513976467, 534.7246168223365, 31674.524882126785, 42022.78988605057, 43192.704218873405, 43296.134077318515, 43488.56511434889, 43556.3466548002, 43950.560494395126, 43979.560204397945, 44035.77982110085, 44041.8989525262, 9916.801663966698, 10077.647282345119, 10087.596496140146, 10093.243006774484, 10101.141402980755, 9219.585118669642, 9432.764180895463, 12188.451519681636, 12388.504459821595, 12401.751964960695, 12120.515179392814, 12178.025757939344, 12181.756364872741, 12225.205361651464, 12236.571719989803, 12260.632181034583, 12358.62924112278, 12380.00959923204, 12380.257184568954, 12390.938045309806, 10044.799104017951, 11866.762664746657, 11914.46384912681, 11931.701707457296, 11933.0, 41148.79425602883, 41482.96292592679, 41501.37747933783, 41604.0, 41729.374059389134, 3319.9004029879143, 3357.6642335766473, 3377.4427219509, 3580.0691820126694, 3910.2179564087296, 32157.51763723546, 32264.35471290561, 32482.6751732482, 32514.83742581272, 32573.674263257537, 2942.8528573571234, 3293.769436139471, 3347.832608369596, 3391.5590973173576, 3435.656434356569, 489503.0, 492128.0, 492619.0, 495949.0, 496421.0, 60997.08504372438, 61302.0, 61442.69278653578, 61463.692681536304, 61492.38507614867, 37518.81240593834, 38003.0, 38160.618393816265, 38224.61775382211, 38248.808755956044, 17524.211410486558, 17709.02600356993, 17747.556311092067, 17749.911250443663, 17752.28990840352, 12284.385780710929, 12489.000879929585, 13397.598072057854, 13533.255670937997, 13534.255615941021, 17457.825421745874, 19823.702644460343, 20105.994700264928, 20209.898950505154, 20218.989050547414, 6871.4502839772695, 6939.583624982517, 8183.304419124322, 8187.4678145920325, 8238.876416853753, 878.1131057631837, 943.2736792669606, 975.8633791269228, 1019.0675531888387, 1055.525013743803, 29920.700792992226, 31226.68773312283, 31458.685413146035, 31515.0, 31542.36915261682, 922.3405265235389, 953.5708930981086, 1060.8090543702208, 1132.5696235430485, 1153.446345754026, 11387.943060284812, 16252.918735406247, 16449.342026319053, 16713.91643041777, 16714.749278760828, 727617.0, 734594.0, 735703.0, 735824.0, 736337.0, 50716.23925641119, 60182.0, 60262.698686506286, 60480.395196048354, 60779.696101520094, 1282.4805953588811, 1315.2371624457792, 1403.4035534897832, 1408.2325132802648, 1444.0, 25054.749452505243, 26365.0, 30748.231294217825, 32382.83808580942, 33380.99857004294, 49967.0, 50421.24368134554, 50439.74780126076, 50441.495585045144, 50447.74776126096, 584450.0, 586563.0, 659274.0, 669466.0, 844204.0, 26711.33221669396, 27066.781994809888, 27089.322766930196, 27134.592981105696, 27174.0, 46872.0, 46982.0, 47061.52938470572, 47324.0, 47405.76297118492, 37896.53672511278, 38249.61750382461, 39214.80392598019, 39274.2145157101, 40474.59525404708, 38642.0, 38901.805490972365, 39256.0, 40194.79902600585, 40559.986000350225, 37783.81108094442, 38306.80846595749, 38753.612463875, 39034.80482597569, 39118.2176356477, 33378.833105835285, 34349.0, 34876.12809679677, 34907.82546087253, 35032.474512882836, 24820.772035959904, 25570.872145639154, 25993.22020339393, 26284.73715262823, 26425.0], "value": 20652.03036281653, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [322.9531717900903, 336.9587973162927, 359.3639258512435, 371.1945079178184, 390.63475650267003, 19919.0, 21101.26145584905, 21631.0, 22180.88909555452, 22465.438364040867, 20800.47998800031, 21071.47321316968, 21265.468363290925, 21532.677009844825, 21761.564768704615, 5066.088104141271, 5345.1714984177515, 5389.51494365507, 5545.528630066449, 5922.289325280973, 5918.2898052233795, 5996.0, 5997.460228579427, 5999.340072592011, 6002.819915402545, 5675.233843431146, 5843.620164689281, 5899.734511946951, 5900.852478688024, 5945.8810823783715, 5669.433056694339, 5848.976429124886, 5923.970380148093, 5927.733252003627, 5943.970280148593, 5079.0, 5163.0190263849745, 5172.948270517322, 5183.015227106837, 5187.273781670569, 26915.0, 27078.45843083147, 27120.728792712016, 27159.592606110924, 27488.0, 2353.388119089032, 2396.940076498084, 2576.6392705021312, 2584.340993046761, 2921.401112771877, 15757.8969472137, 16065.759013614805, 16068.357265709357, 16129.354825806953, 16555.6688866222, 1851.2409911936043, 1872.6535590915723, 1880.4170707080848, 1884.2368840619433, 1944.6596845551971, 100977.0, 125662.74337256602, 128849.7115028847, 130339.0, 131280.68719312875, 8675.73972780805, 10094.536292237584, 10745.194110441591, 10777.407242601732, 10893.564257429773, 13294.800577991338, 13369.331533423485, 13417.798733019012, 13440.865591344156, 13451.192928424325, 8012.719554815553, 8607.26838218746, 8839.779005524913, 8954.149355811187, 9014.098590140933, 8487.193716596914, 9087.36388452802, 9154.81690366189, 9244.3528952974, 9266.397684150508, 5326.854726233878, 6612.404883560503, 6711.966440167768, 6725.495587830932, 6835.624040677711, 1499.587613406322, 1671.5904603372007, 1764.9382271620432, 1767.5757818123557, 1771.636814453034, 919.8252332056887, 974.0503009565617, 1012.9088382045651, 1014.4876837197315, 1050.144132531984, 20448.56860019814, 22819.087236510353, 22933.42666433319, 23017.424564386023, 23081.192158274378, 970.5875003123645, 992.2558081438921, 995.9601615935426, 1000.1498726082772, 1038.309524166436, 11421.771564568662, 11649.534018639159, 12289.0, 12298.446569904376, 12348.135630505958, 577887.0, 638372.0, 639877.0, 645127.0, 663497.0, 89447.0, 90748.85944164587, 101626.47560286602, 118218.0, 119767.8023219774, 855.5551113420986, 963.1331801378815, 1023.6928921323722, 1029.4235228272191, 1029.9227557933184, 20269.695954560397, 20572.58854822925, 21600.351989440343, 21624.89187554052, 21714.80568568744, 39790.2041959165, 48481.0, 54037.72981135226, 54631.72684136554, 56904.146437804295, 81223.0, 81386.18613813785, 81633.59183204046, 82141.0, 82550.0, 6879.62652884754, 7925.643346049557, 8062.193780622126, 8072.313853322534, 8081.717139900075, 13310.933445332712, 13515.256660883746, 13546.59360219195, 13666.453341866214, 14129.434822606981, 11042.33745975244, 11681.240719353214, 11683.18217724785, 11797.76404471923, 11804.763904721685, 10888.51001704941, 11764.70588235301, 11856.762864742484, 12129.878701212874, 12133.75732485363, 11667.299962002307, 11725.530978761095, 11828.112891532997, 11885.821712674144, 12281.017518598312, 7368.963155184189, 7730.226977302224, 8397.496150231005, 8433.83132337362, 8584.442011269248, 11531.88468115308, 11558.364289963796, 11617.593384231512, 12130.878691213327, 12169.69575760613], "value": 9912.179157323124, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1524.3978628441766, 1535.5009621872891, 1780.9198586063626, 1878.690016147334, 1935.7289979402885, 8405.369597280205, 8952.328575356858, 8971.596278167483, 8977.192052715254, 9004.72985810425, 7851.960740196291, 7885.172056934025, 8103.554304513249, 8190.467619604721, 8211.343092552597, 2377.476955069886, 2389.116027069978, 2396.9880150599224, 2401.7598240176017, 2403.5433267679173, 2364.8344615876895, 2372.4543355028354, 2409.180878501309, 2414.541237164933, 2422.3580751100885, 2378.4886249456363, 2394.0782798622567, 2394.4612462195955, 2413.9396515087174, 2424.806015518763, 2369.18263199196, 2383.892724827378, 2387.928362149138, 2388.4267775733874, 2399.3281881073326, 2355.5759963206615, 2380.7143142822974, 2381.5951288281035, 2384.0940442631863, 2384.9046038158626, 8889.377743557954, 8934.553272336358, 8982.775430614221, 9018.954905225497, 9051.547422628842, 5274.762635681365, 5401.891962160774, 5432.782688692487, 5437.4562543745305, 5450.29146210994, 3437.535932649085, 3470.7049900758466, 3489.4242449995722, 3521.154922818531, 3538.2392785550974, 1063.7978784031009, 1065.2596445470401, 1081.8972197641212, 1082.1721383141903, 1097.160672085855, 9971.0, 11722.589709360216, 11753.764924701458, 11781.0, 11791.0, 4103.707332190351, 4580.267157254823, 4663.930041049387, 4801.783919723621, 4807.735574543363, 10050.0, 10062.0, 10075.748106297255, 10089.091981721533, 10092.293539452168, 5407.459254074561, 5417.10617748075, 5423.430539793344, 5431.402545719968, 5431.565474762009, 4489.124620698933, 4563.885902852388, 4630.305454181832, 4939.53074457926, 4980.950190498121, 3938.0, 3939.3697008478507, 3988.142549351903, 4048.716589838683, 4051.2505186539993, 1241.1870225002638, 1242.3353505874313, 1243.7015116372006, 1261.5962891874697, 1263.791474406731, 850.6087199887997, 865.3034307382492, 880.3969281042506, 891.9777005574913, 895.7671005538476, 6085.1785009023215, 6091.604045737013, 6146.631202127886, 6207.782727604512, 6281.905771413432, 893.2407453664333, 903.6520939438232, 938.9201917836924, 989.1345073061071, 1001.2040427859869, 2959.5708622249654, 3373.730101591867, 3710.7216958727663, 3914.4715463412645, 4069.2878746219294, 10580.523876425425, 10810.783784324427, 10834.458277086114, 10838.187135964834, 10893.509792059376, 10498.212634052325, 10662.41356725372, 10732.463376831127, 10832.295900766583, 11033.393163375931, 8326.66693332272, 8467.915320846836, 8480.83038339242, 8499.66001359951, 8530.530820804792, 5463.96184724901, 5974.253218347707, 5980.581359304807, 6075.210222671025, 6113.694315284307, 9672.226221902372, 10024.949875250577, 10025.699229023141, 10104.69685909424, 10197.388156710622, 10232.539535720762, 10364.792704145724, 10402.635907743193, 10408.959104089834, 10448.738781530523, 6874.621895795779, 6928.930710692828, 7162.677679504331, 7456.47804653669, 7643.7324693635455, 6610.6694665267505, 8360.958195208985, 8502.107278735892, 8542.273906718, 8628.309735221043, 7508.136564294958, 7614.124375696866, 7634.770956871303, 7696.8460630788195, 7782.0, 6337.207849018872, 7446.7021319146625, 7453.142888567667, 7619.809504762426, 7658.502197357154, 5975.970120149372, 6850.075239842757, 6996.895046574407, 7003.964980175067, 7004.964975175091, 4929.009397779961, 5024.42219144803, 5102.387713474407, 5127.230915362726, 5141.331626888481, 5092.439831618593, 5111.437741848319, 5144.30551875492, 5182.32629758129, 5263.578913686973], "value": 4607.212291496962, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [261.81803646465704, 296.8026262535415, 303.1753630126057, 307.7953161147837, 310.35136564580023, 5266.078436273651, 5306.204069389593, 5341.385740639823, 5357.866053348664, 5359.490848369408, 4335.4797424309045, 5040.765012571916, 5065.505675825631, 5306.867328316794, 5338.91991620126, 3552.8045957472327, 4080.204360149772, 4081.530623978251, 4118.9588104118875, 4153.667706583474, 3982.084120652252, 4105.0, 4112.1775644870995, 4145.631941459311, 4159.480064991876, 3337.0656216259486, 3540.256546125304, 3726.9254614907686, 4033.7983100844986, 4065.4308396824467, 4005.3591425371947, 4014.3777714454304, 4020.2361551305157, 4025.577314381977, 4029.3150164471963, 3450.3789317922765, 3463.809490478023, 3474.270403215328, 3476.5132881396626, 3510.9824450877836, 4384.627306678936, 4455.643548516111, 4878.756062196911, 4915.655904086715, 5220.042484068475, 4573.438874230442, 4582.679212455129, 4595.448546174447, 4619.036909313562, 4620.953790462086, 4933.80264789408, 5362.2572663884, 5601.187827764951, 5622.835208444737, 5636.379998200195, 3158.2262345725444, 3454.894433781191, 3797.639224273717, 3802.2395520895657, 3844.75009124406, 5492.533134683556, 5821.883562328772, 5924.022536281508, 5946.524278057745, 5950.345461999176, 3258.6415494295607, 3860.8069596520622, 3863.285292220948, 3885.902852428712, 3892.649661530476, 3955.7033222508426, 3961.7226794124135, 3970.900727481836, 3972.900677483028, 3982.38273067675, 3477.1828620274214, 3586.5337506124038, 3892.3966785148345, 3937.9606203938165, 4645.6980296280635, 5675.744591493392, 5680.233168522197, 5689.146628005832, 5689.374168841424, 5694.316681998104, 1079.2822772855964, 1164.318873459019, 1313.7044165062784, 1330.7823341642481, 1332.6468485851062, 847.7456762971084, 850.9021462531888, 899.150302963706, 901.2294488212484, 909.2498688581946, 5154.793808247703, 5210.921836172461, 5229.267902493654, 5234.345706786652, 5238.319018527567, 4633.814647414133, 4781.85235543474, 5834.737436815269, 5849.970750146222, 5866.413358664185, 4390.44139330533, 4974.204127339608, 5234.633575649668, 5278.577713782888, 5307.6019298552765, 3010.6602561859763, 3056.480398332289, 3057.785954983174, 3069.7083777041144, 3078.260782657791, 5464.890702185934, 5762.798302059407, 5881.235439392852, 5998.850028749316, 6018.307894592091, 4785.9042819144115, 5556.610847288178, 5746.2529871116485, 5788.507976822018, 5861.460919431097, 5245.6852588844795, 5251.684898906155, 5985.311689155803, 6001.579889407787, 6008.729607167688, 4794.616430685606, 5740.253767010262, 5884.499817515559, 5920.496757775637, 5990.0, 4532.456105267389, 5824.446677565625, 5833.67914764692, 5845.853853653693, 6004.369541198286, 5300.284461597635, 5844.532437404912, 6118.357572454828, 6151.0, 6159.23009623797, 3989.72071954972, 4083.9591604084767, 4086.4891888513935, 4095.1195492969155, 4120.340745480828, 5241.633085684118, 5263.868403289948, 5995.040793473024, 5998.940010599838, 5999.550033747573, 5398.514133727984, 5660.235868157911, 5688.687122208318, 5823.242978412949, 5837.0, 5701.173329867063, 5721.084626459747, 5726.9713651431475, 5747.885042299215, 5811.767529298781, 5305.787768489372, 5312.920306195333, 5573.749181286771, 5643.266375371176, 5676.829695109153, 4926.196957965954, 5602.439756024365, 5711.942880571141, 5723.456271654186, 5737.328110009514, 4674.994876101655, 4884.462709102067, 5424.077906755782, 5615.915761263503, 5627.52166065889], "value": 4097.382332738027, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [692.6225207262039, 734.3941248470013, 765.039874956929, 788.5229436191104, 811.4319976016787, 16064.678706425879, 17095.57261068474, 17116.572085697848, 17128.31486740529, 17135.65728685427, 15266.0, 15290.541283761477, 15317.770233446507, 15366.308516116802, 15447.45933892314, 686.800827759949, 703.7747920665389, 707.6921539130469, 842.3345557009955, 851.1488511488511, 865.6018231613465, 867.3754896474528, 878.7451639024707, 880.7798050487378, 881.1496905486205, 919.1635611593451, 926.3515539122608, 927.7216834949522, 928.9024652411501, 933.1228645073643, 917.8806755121825, 920.1534588178891, 921.663592788634, 921.9815603687922, 923.833709932212, 689.8551304226069, 691.2327316678483, 692.4356649330779, 693.9340762627543, 695.422799076765, 16237.59406014859, 16394.09832459214, 16422.0, 16429.096399698014, 16449.58876028097, 13687.178769273876, 13751.106178098391, 13817.861821381757, 13926.791098133535, 14027.0, 13318.805665790349, 13578.524751633646, 13678.658033549142, 13842.515511957134, 13910.956678249171, 4601.608863246628, 4623.86128416148, 4731.881702957419, 4919.08996835583, 4921.876953076166, 99458.0, 102127.48936255272, 103931.96068039373, 114076.0, 130418.3479082608, 10984.176186786022, 11315.603953861575, 11410.0, 11419.771604567863, 11435.942820285845, 19479.12343944526, 19513.707294390595, 22685.88657056737, 22878.542429151657, 23170.0, 8430.241278284984, 8437.40938134337, 8497.957510212409, 8505.53219572917, 8518.361122915681, 4503.81984720614, 4628.490866004737, 4724.598409135193, 4789.449213340441, 4798.2802579612635, 3522.225110475691, 3634.182308980511, 3669.4495825625836, 3681.2269423420844, 3681.8527258909344, 640.0942666127471, 647.4076220258505, 647.7668039505868, 652.9347065293433, 654.6824789976857, 598.6647477412663, 665.6239224837951, 680.4352387518348, 681.4990981628499, 691.8339598496425, 9382.24942004638, 9545.140937315675, 9559.235261179088, 9586.258863921157, 9644.614215431444, 592.7066102279399, 663.1544780405022, 679.8878185099403, 698.1866125963297, 701.5334802356376, 4404.4494438195225, 4648.1168577970075, 4664.696794708333, 4678.11115887987, 4766.998930224691, 95021.0, 111060.444697776, 159127.40872591358, 167891.0, 172709.0, 75094.62452687701, 75257.62371188219, 99004.0, 113826.72346553023, 125210.0, 73497.0, 114708.85291147149, 124499.0, 127217.99999999815, 127665.0, 8761.167689069529, 8979.955100224457, 9063.728088157366, 9191.494467804336, 9195.586198620944, 51943.0, 66841.0, 69134.0, 69658.0, 69794.95307570288, 65651.67174164098, 67502.0, 85820.0, 86668.56665716883, 96611.0, 12456.0, 12883.484660613845, 13115.147515411849, 13425.932870335586, 13592.592222233348, 13896.235707035805, 14620.342084606005, 15433.459828905934, 15766.05403675783, 16527.008379497267, 12936.935315323362, 13438.798418023933, 14563.781543276647, 14704.55886323412, 14823.184724840237, 13788.241646709528, 13856.0, 15096.965299245567, 15553.222338882784, 15566.84433155654, 12909.483620655068, 14465.27673616294, 14782.298145888532, 14800.125559912438, 15244.16157111325, 10232.33489823189, 11181.32912025281, 11433.859542901533, 12234.449449774604, 12246.448909798903, 8068.709006558923, 10818.459077046273, 11578.305301681927, 11610.106010923446, 11891.940540297242], "value": 7992.113354847252, "unit": "score"}], "name": "dromaeo_css", "value": 7480.90062821023, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 113.0, 113.0, 113.0, 113.0, 113.0, 113.0, 115.0, 113.0, 113.0], "value": 113.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 109.0, 109.0, 144.0, 109.0, 111.0, 107.0, 109.0, 134.0, 108.0], "value": 118.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [183.0, 183.0, 186.0, 184.0, 182.0, 183.0, 196.0, 259.0, 208.0, 183.0], "value": 194.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 59.0, 58.0, 92.0, 62.0, 59.0, 59.0, 60.0, 83.0, 57.0], "value": 67.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 70.0, 95.0, 69.0, 69.0, 69.0, 92.0, 67.0, 67.0, 90.0], "value": 77.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 87.0, 90.0, 86.0, 89.0, 85.0, 87.0, 71.0, 93.0, 128.0], "value": 90.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 93.0, 93.0, 94.0, 110.0, 146.0, 125.0, 93.0, 94.0, 93.0], "value": 103.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 83.0, 85.0, 83.0, 83.0, 82.0, 87.0, 83.0, 84.0], "value": 83.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 52.0, 54.0, 53.0, 56.0, 58.0, 59.0, 57.0, 56.0, 56.0], "value": 55.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 72.0, 69.0, 75.0, 75.0, 69.0, 69.0, 70.0, 70.0, 71.0], "value": 70.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 86.0, 93.0, 98.0, 73.0, 83.0, 79.0, 77.0, 74.0, 87.0], "value": 83.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 138.0, 132.0, 137.0, 138.0, 127.0, 149.0, 148.0, 175.0, 167.0], "value": 145.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 159.0, 158.0, 183.0, 163.0, 161.0, 160.0, 161.0, 161.0, 162.0], "value": 163.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 66.0, 66.0, 65.0, 64.0, 64.0, 66.0, 65.0, 66.0], "value": 65.4, "unit": "score"}], "name": "kraken", "value": 1432.7, "alertThreshold": 2.0}]} 05:25:26 INFO - Return code: 0 05:25:26 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 05:25:26 INFO - # TBPL SUCCESS # 05:25:26 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:25:26 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:25:26 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:25:26 INFO - 2017-01-04 05:25:26.338 screenresolution[2263:21585] starting screenresolution argv=screenresolution get 05:25:26 INFO - 2017-01-04 05:25:26.340 screenresolution[2263:21585] Display 0: 1600x1200x32@60 05:25:26 INFO - 2017-01-04 05:25:26.346 screenresolution[2264:21588] starting screenresolution argv=screenresolution list 05:25:26 INFO - Available Modes on Display 0 05:25:26 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:25:26 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:25:26 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:25:26 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:25:26 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:25:26 INFO - Intel Iris: 05:25:26 INFO - Chipset Model: Intel Iris 05:25:26 INFO - Type: GPU 05:25:26 INFO - Bus: Built-In 05:25:26 INFO - VRAM (Dynamic, Max): 1536 MB 05:25:26 INFO - Vendor: Intel (0x8086) 05:25:26 INFO - Device ID: 0x0a2e 05:25:26 INFO - Revision ID: 0x0009 05:25:26 INFO - Displays: 05:25:26 INFO - Display: 05:25:26 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:25:26 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:25:26 INFO - Display Serial Number: 1600x1200 60 05:25:26 INFO - Main Display: Yes 05:25:26 INFO - Mirror: Off 05:25:26 INFO - Online: Yes 05:25:26 INFO - Rotation: Supported 05:25:26 INFO - Return code: 0 05:25:26 INFO - Running post-action listener: _resource_record_post_action 05:25:26 INFO - [mozharness: 2017-01-04 13:25:26.581279Z] Finished run-tests step (success) 05:25:26 INFO - Running post-run listener: _resource_record_post_run 05:25:26 INFO - Total resource usage - Wall time: 1195s; CPU: 53.0%; Read bytes: 1081344; Write bytes: 496098304; Read time: 8; Write time: 1573 05:25:26 INFO - TinderboxPrint: CPU usage
53.3% 05:25:26 INFO - TinderboxPrint: I/O read bytes / time
1,081,344 / 8 05:25:26 INFO - TinderboxPrint: I/O write bytes / time
496,098,304 / 1,573 05:25:26 INFO - TinderboxPrint: CPU idle
2,233.1 (46.7%) 05:25:26 INFO - TinderboxPrint: CPU system
960.9 (20.1%) 05:25:26 INFO - TinderboxPrint: CPU user
1,587.7 (33.2%) 05:25:26 INFO - TinderboxPrint: Swap in / out
195,784,704 / 0 05:25:26 INFO - install - Wall time: 22s; CPU: 54.0%; Read bytes: 192455168; Write bytes: 187844096; Read time: 17597; Write time: 412 05:25:26 INFO - run-tests - Wall time: 1174s; CPU: 53.0%; Read bytes: 233472; Write bytes: 297010688; Read time: 4; Write time: 1121 05:25:27 INFO - Running post-run listener: _upload_blobber_files 05:25:27 INFO - Blob upload gear active. 05:25:27 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:25:27 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 05:25:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 05:25:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 05:25:27 INFO - (blobuploader) - INFO - Open directory for files ... 05:25:27 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 05:25:27 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:25:27 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:25:28 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 05:25:28 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:25:28 INFO - (blobuploader) - INFO - Done attempting. 05:25:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 05:25:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:25:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:25:29 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 05:25:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:25:29 INFO - (blobuploader) - INFO - Done attempting. 05:25:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 05:25:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:25:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:25:31 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 05:25:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:25:31 INFO - (blobuploader) - INFO - Done attempting. 05:25:31 INFO - (blobuploader) - INFO - Iteration through files over. 05:25:31 INFO - Return code: 0 05:25:31 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:25:31 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:25:31 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/f5c8de87a7e8bad4757ae7f2cdb33174f5bd8e32373eb39b031e4e857b6c80c0e38f4a8fd70fec4202ca9530a342d9799f51edad182279bb52cb9f169f0e465a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/dd9d5e7ec669a8f9a865c6fbf008ace7549f5b6e778ccd335cd70ebf61d8b9d5884a2f58a9d9aab5a409879a947d6203038a4959c70d22796392b245a9a061d7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/46dccd01f4dba1e1edeb3614b463f3ea073fe4719c6269d40f2b79bcfa0d0316a7949ca0c6ed56893e9e80a7b6a572ef4a567a6a865a26308d5b7ba8145f79f4"} 05:25:31 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:25:31 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:25:31 INFO - Contents: 05:25:31 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/f5c8de87a7e8bad4757ae7f2cdb33174f5bd8e32373eb39b031e4e857b6c80c0e38f4a8fd70fec4202ca9530a342d9799f51edad182279bb52cb9f169f0e465a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/dd9d5e7ec669a8f9a865c6fbf008ace7549f5b6e778ccd335cd70ebf61d8b9d5884a2f58a9d9aab5a409879a947d6203038a4959c70d22796392b245a9a061d7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/46dccd01f4dba1e1edeb3614b463f3ea073fe4719c6269d40f2b79bcfa0d0316a7949ca0c6ed56893e9e80a7b6a572ef4a567a6a865a26308d5b7ba8145f79f4"} 05:25:31 INFO - Running post-run listener: copy_logs_to_upload_dir 05:25:31 INFO - Copying logs to upload dir... 05:25:31 INFO - mkdir: /builds/slave/test/build/upload/logs 05:25:31 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1254.710691 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 20 mins, 54 secs) (at 2017-01-04 05:25:31.671796) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-04 05:25:31.675492) ========= 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.p3mf5tJXCC/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.SK6cx7odb8/Listeners TMPDIR=/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/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/f5c8de87a7e8bad4757ae7f2cdb33174f5bd8e32373eb39b031e4e857b6c80c0e38f4a8fd70fec4202ca9530a342d9799f51edad182279bb52cb9f169f0e465a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/dd9d5e7ec669a8f9a865c6fbf008ace7549f5b6e778ccd335cd70ebf61d8b9d5884a2f58a9d9aab5a409879a947d6203038a4959c70d22796392b245a9a061d7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/46dccd01f4dba1e1edeb3614b463f3ea073fe4719c6269d40f2b79bcfa0d0316a7949ca0c6ed56893e9e80a7b6a572ef4a567a6a865a26308d5b7ba8145f79f4"} build_url:https://queue.taskcluster.net/v1/task/Ss5zA1YgTLSzNuL2I3XhRQ/artifacts/public/build/firefox-51.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011511 build_url: 'https://queue.taskcluster.net/v1/task/Ss5zA1YgTLSzNuL2I3XhRQ/artifacts/public/build/firefox-51.0.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/f5c8de87a7e8bad4757ae7f2cdb33174f5bd8e32373eb39b031e4e857b6c80c0e38f4a8fd70fec4202ca9530a342d9799f51edad182279bb52cb9f169f0e465a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/dd9d5e7ec669a8f9a865c6fbf008ace7549f5b6e778ccd335cd70ebf61d8b9d5884a2f58a9d9aab5a409879a947d6203038a4959c70d22796392b245a9a061d7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/46dccd01f4dba1e1edeb3614b463f3ea073fe4719c6269d40f2b79bcfa0d0316a7949ca0c6ed56893e9e80a7b6a572ef4a567a6a865a26308d5b7ba8145f79f4"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-04 05:25:31.711302) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-04 05:25:31.711671) ========= 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.p3mf5tJXCC/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.SK6cx7odb8/Listeners TMPDIR=/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/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.005338 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-04 05:25:31.761515) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-04 05:25:31.761878) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-04 05:25:31.762304) ========= ========= Total master_lag: 0.19 =========