builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0094 starttime: 1489061499.06 results: success (0) buildid: 20170309022424 builduid: 54b790976e4d422394fabbd936258307 revision: da0ea1c722078f30c6f390627d3c680d3556a7a6 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-03-09 04:11:39.060300) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-03-09 04:11:39.060716) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-09 04:11:39.060989) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-09 04:11:39.092570) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-09 04:11:39.092835) ========= 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.wQxPSeHV9x/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.HqyWDKlAjF/Listeners TMPDIR=/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2017-03-09 04:11:39-- 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% 166M=0s 2017-03-09 04:11:39 (166 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.118941 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-09 04:11:39.236964) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-09 04:11:39.237303) ========= 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.wQxPSeHV9x/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.HqyWDKlAjF/Listeners TMPDIR=/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/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.021126 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-09 04:11:39.288105) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-03-09 04:11:39.288417) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev da0ea1c722078f30c6f390627d3c680d3556a7a6 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev da0ea1c722078f30c6f390627d3c680d3556a7a6 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.wQxPSeHV9x/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.HqyWDKlAjF/Listeners TMPDIR=/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2017-03-09 04:11:39,371 truncating revision to first 12 chars 2017-03-09 04:11:39,371 Setting DEBUG logging. 2017-03-09 04:11:39,371 attempt 1/10 2017-03-09 04:11:39,371 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/da0ea1c72207?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-03-09 04:11:41,170 unpacking tar archive at: mozilla-central-da0ea1c72207/testing/mozharness/ program finished with exit code 0 elapsedTime=2.054079 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-03-09 04:11:41.366260) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-09 04:11:41.366559) ========= script_repo_revision: da0ea1c722078f30c6f390627d3c680d3556a7a6 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-09 04:11:41.366960) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-09 04:11:41.367222) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-09 04:11:41.387031) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 28 secs) (at 2017-03-09 04:11:41.387371) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 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', 'Firefox', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.wQxPSeHV9x/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.HqyWDKlAjF/Listeners TMPDIR=/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/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 04:11:41 INFO - MultiFileLogger online at 20170309 04:11:41 in /builds/slave/test 04:11:41 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 04:11:41 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:11:41 INFO - {'append_to_log': False, 04:11:41 INFO - 'base_work_dir': '/builds/slave/test', 04:11:41 INFO - 'blob_upload_branch': 'Firefox', 04:11:41 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:11:41 INFO - 'branch': 'Firefox', 04:11:41 INFO - 'buildbot_json_path': 'buildprops.json', 04:11:41 INFO - 'config_files': ('talos/mac_config.py',), 04:11:41 INFO - 'default_actions': ('clobber', 04:11:41 INFO - 'read-buildbot-config', 04:11:41 INFO - 'download-and-extract', 04:11:41 INFO - 'populate-webroot', 04:11:41 INFO - 'create-virtualenv', 04:11:41 INFO - 'install', 04:11:41 INFO - 'run-tests'), 04:11:41 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:11:41 INFO - 'download_minidump_stackwalk': True, 04:11:41 INFO - 'download_symbols': 'ondemand', 04:11:41 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:11:41 INFO - 'tooltool.py': '/tools/tooltool.py', 04:11:41 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:11:41 INFO - '/tools/misc-python/virtualenv.py')}, 04:11:41 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:11:41 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:11:41 INFO - 'gecko_profile': False, 04:11:41 INFO - 'gecko_profile_interval': 0, 04:11:41 INFO - 'installer_path': 'installer.exe', 04:11:41 INFO - 'log_level': 'info', 04:11:41 INFO - 'log_name': 'talos', 04:11:41 INFO - 'log_to_console': True, 04:11:41 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 04:11:41 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 04:11:41 INFO - 'opt_config_files': (), 04:11:41 INFO - 'pip_index': False, 04:11:41 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:11:41 INFO - 'cmd': ('bash', 04:11:41 INFO - '-c', 04:11:41 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:11:41 INFO - 'enabled': True, 04:11:41 INFO - 'halt_on_failure': False, 04:11:41 INFO - 'name': 'check_screen_resolution'},), 04:11:41 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:11:41 INFO - 'cmd': ('bash', 04:11:41 INFO - '-c', 04:11:41 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:11:41 INFO - 'enabled': True, 04:11:41 INFO - 'halt_on_failure': False, 04:11:41 INFO - 'name': 'check_screen_resolution'},), 04:11:41 INFO - 'run_cmd_checks_enabled': True, 04:11:41 INFO - 'suite': 'dromaeojs', 04:11:41 INFO - 'system_bits': '32', 04:11:41 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:11:41 INFO - 'title': 't-yosemite-r7-0094', 04:11:41 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:11:41 INFO - 'use_talos_json': True, 04:11:41 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:11:41 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:11:41 INFO - 'work_dir': 'build'} 04:11:41 INFO - [mozharness: 2017-03-09 12:11:41.599061Z] Running clobber step. 04:11:41 INFO - Running pre-action listener: _resource_record_pre_action 04:11:41 INFO - Running main action method: clobber 04:11:41 INFO - rmtree: /builds/slave/test/build 04:11:41 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:11:43 INFO - Running post-action listener: _resource_record_post_action 04:11:43 INFO - [mozharness: 2017-03-09 12:11:43.716974Z] Finished clobber step (success) 04:11:43 INFO - [mozharness: 2017-03-09 12:11:43.717101Z] Running read-buildbot-config step. 04:11:43 INFO - Running pre-action listener: _resource_record_pre_action 04:11:43 INFO - Running main action method: read_buildbot_config 04:11:43 INFO - Using buildbot properties: 04:11:43 INFO - { 04:11:43 INFO - "project": "", 04:11:43 INFO - "product": "firefox", 04:11:43 INFO - "script_repo_revision": "production", 04:11:43 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 04:11:43 INFO - "repository": "", 04:11:43 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 04:11:43 INFO - "buildid": "20170309022424", 04:11:43 INFO - "pgo_build": "False", 04:11:43 INFO - "basedir": "/builds/slave/test", 04:11:43 INFO - "buildnumber": 23, 04:11:43 INFO - "slavename": "t-yosemite-r7-0094", 04:11:43 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 04:11:43 INFO - "platform": "yosemite_r7", 04:11:43 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 04:11:43 INFO - "branch": "mozilla-central", 04:11:43 INFO - "repo_path": "mozilla-central", 04:11:43 INFO - "revision": "da0ea1c722078f30c6f390627d3c680d3556a7a6", 04:11:43 INFO - "stage_platform": "macosx64", 04:11:43 INFO - "builduid": "54b790976e4d422394fabbd936258307", 04:11:43 INFO - "slavebuilddir": "test" 04:11:43 INFO - } 04:11:43 INFO - Found installer url https://queue.taskcluster.net/v1/task/VivP9G1OTLiFoUMxDokQeg/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg. 04:11:43 INFO - Running post-action listener: _resource_record_post_action 04:11:43 INFO - [mozharness: 2017-03-09 12:11:43.720555Z] Finished read-buildbot-config step (success) 04:11:43 INFO - [mozharness: 2017-03-09 12:11:43.720664Z] Running download-and-extract step. 04:11:43 INFO - Running pre-action listener: _resource_record_pre_action 04:11:43 INFO - Running main action method: download_and_extract 04:11:43 INFO - mkdir: /builds/slave/test/build/tests 04:11:43 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')]} 04:11:43 INFO - trying https://queue.taskcluster.net/v1/task/VivP9G1OTLiFoUMxDokQeg/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json 04:11:43 INFO - Downloading https://queue.taskcluster.net/v1/task/VivP9G1OTLiFoUMxDokQeg/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 04:11:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/VivP9G1OTLiFoUMxDokQeg/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json'}, attempt #1 04:11:45 INFO - Downloaded 1199 bytes. 04:11:45 INFO - Reading from file /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 04:11:45 INFO - Using the following test package requirements: 04:11:45 INFO - {u'common': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 04:11:45 INFO - u'cppunittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:11:45 INFO - u'firefox-55.0a1.en-US.mac.cppunittest.tests.zip'], 04:11:45 INFO - u'gtest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:11:45 INFO - u'firefox-55.0a1.en-US.mac.gtest.tests.zip'], 04:11:45 INFO - u'jittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:11:45 INFO - u'jsshell-mac.zip'], 04:11:45 INFO - u'mochitest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:11:45 INFO - u'firefox-55.0a1.en-US.mac.mochitest.tests.zip'], 04:11:45 INFO - u'mozbase': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 04:11:45 INFO - u'reftest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:11:45 INFO - u'firefox-55.0a1.en-US.mac.reftest.tests.zip'], 04:11:45 INFO - u'talos': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:11:45 INFO - u'firefox-55.0a1.en-US.mac.talos.tests.zip'], 04:11:45 INFO - u'web-platform': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:11:45 INFO - u'firefox-55.0a1.en-US.mac.web-platform.tests.zip'], 04:11:45 INFO - u'xpcshell': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:11:45 INFO - u'firefox-55.0a1.en-US.mac.xpcshell.tests.zip']} 04:11:45 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip'] for test suite category: common 04:11:45 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/VivP9G1OTLiFoUMxDokQeg/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 04:11:45 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/VivP9G1OTLiFoUMxDokQeg/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 04:11:45 INFO - Fetch https://queue.taskcluster.net/v1/task/VivP9G1OTLiFoUMxDokQeg/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 04:11:46 INFO - Expected file size: 51785363 04:11:46 INFO - Obtained file size: 51785363 04:12:02 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip', u'firefox-55.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 04:12:02 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/VivP9G1OTLiFoUMxDokQeg/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 04:12:02 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/VivP9G1OTLiFoUMxDokQeg/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 04:12:02 INFO - Fetch https://queue.taskcluster.net/v1/task/VivP9G1OTLiFoUMxDokQeg/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 04:12:04 INFO - Expected file size: 51785363 04:12:04 INFO - Obtained file size: 51785363 04:12:20 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/VivP9G1OTLiFoUMxDokQeg/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip 04:12:20 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/VivP9G1OTLiFoUMxDokQeg/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip'}, attempt #1 04:12:20 INFO - Fetch https://queue.taskcluster.net/v1/task/VivP9G1OTLiFoUMxDokQeg/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip into memory 04:12:21 INFO - Expected file size: 14404424 04:12:21 INFO - Obtained file size: 14404424 04:12:21 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')]} 04:12:21 INFO - trying https://queue.taskcluster.net/v1/task/VivP9G1OTLiFoUMxDokQeg/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 04:12:21 INFO - Downloading https://queue.taskcluster.net/v1/task/VivP9G1OTLiFoUMxDokQeg/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg 04:12:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/VivP9G1OTLiFoUMxDokQeg/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg'}, attempt #1 04:12:23 INFO - Downloaded 74933209 bytes. 04:12:23 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/VivP9G1OTLiFoUMxDokQeg/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 04:12:23 INFO - mkdir: /builds/slave/test/properties 04:12:23 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:12:23 INFO - Writing to file /builds/slave/test/properties/build_url 04:12:23 INFO - Contents: 04:12:23 INFO - build_url:https://queue.taskcluster.net/v1/task/VivP9G1OTLiFoUMxDokQeg/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 04:12:24 INFO - Running post-action listener: _resource_record_post_action 04:12:24 INFO - Running post-action listener: set_extra_try_arguments 04:12:24 INFO - [mozharness: 2017-03-09 12:12:24.458919Z] Finished download-and-extract step (success) 04:12:24 INFO - [mozharness: 2017-03-09 12:12:24.459080Z] Running populate-webroot step. 04:12:24 INFO - Running pre-action listener: _resource_record_pre_action 04:12:24 INFO - Running main action method: populate_webroot 04:12:24 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:12:24 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:12:24 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:12:24 INFO - '--tppagecycles', 04:12:24 INFO - '7'], 04:12:24 INFO - 'tests': ['tsvgm']}}, 04:12:24 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:12:24 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:12:24 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:12:24 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:12:24 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:12:24 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:12:24 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 04:12:24 INFO - 'talos_options': ['--disable-e10s'], 04:12:24 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:12:24 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 04:12:24 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:12:24 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 04:12:24 INFO - 'talos_options': ['--disable-e10s'], 04:12:24 INFO - 'tests': ['damp', 'tps']}, 04:12:24 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 04:12:24 INFO - 'tests': ['damp', 'tps']}, 04:12:24 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:12:24 INFO - 'tests': ['dromaeo_dom']}, 04:12:24 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:12:24 INFO - 'g4': {'talos_options': ['--disable-e10s'], 04:12:24 INFO - 'tests': ['basic_compositor_video']}, 04:12:24 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 04:12:24 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:12:24 INFO - 'tests': ['a11yr', 04:12:24 INFO - 'ts_paint', 04:12:24 INFO - 'tpaint', 04:12:24 INFO - 'sessionrestore', 04:12:24 INFO - 'sessionrestore_no_auto_restore', 04:12:24 INFO - 'tabpaint']}, 04:12:24 INFO - 'other-e10s': {'tests': ['a11yr', 04:12:24 INFO - 'ts_paint', 04:12:24 INFO - 'tpaint', 04:12:24 INFO - 'sessionrestore', 04:12:24 INFO - 'sessionrestore_no_auto_restore', 04:12:24 INFO - 'tabpaint']}, 04:12:24 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:12:24 INFO - 'ts_paint', 04:12:24 INFO - 'tpaint', 04:12:24 INFO - 'sessionrestore', 04:12:24 INFO - 'sessionrestore_no_auto_restore', 04:12:24 INFO - 'tabpaint']}, 04:12:24 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:12:24 INFO - 'ts_paint', 04:12:24 INFO - 'tpaint', 04:12:24 INFO - 'sessionrestore', 04:12:24 INFO - 'sessionrestore_no_auto_restore', 04:12:24 INFO - 'tabpaint']}, 04:12:24 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:12:24 INFO - 'tests': ['a11yr', 04:12:24 INFO - 'ts_paint', 04:12:24 INFO - 'tpaint', 04:12:24 INFO - 'sessionrestore', 04:12:24 INFO - 'sessionrestore_no_auto_restore', 04:12:24 INFO - 'tabpaint']}, 04:12:24 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:12:24 INFO - 'tests': ['a11yr', 04:12:24 INFO - 'ts_paint', 04:12:24 INFO - 'tpaint', 04:12:24 INFO - 'sessionrestore', 04:12:24 INFO - 'sessionrestore_no_auto_restore', 04:12:24 INFO - 'tabpaint']}, 04:12:24 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:12:24 INFO - 'tests': ['tsvgx', 04:12:24 INFO - 'tsvgr_opacity', 04:12:24 INFO - 'tart', 04:12:24 INFO - 'tscrollx', 04:12:24 INFO - 'cart', 04:12:24 INFO - 'tsvg_static']}, 04:12:24 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:12:24 INFO - 'tsvgr_opacity', 04:12:24 INFO - 'tart', 04:12:24 INFO - 'tscrollx', 04:12:24 INFO - 'cart', 04:12:24 INFO - 'tsvg_static']}, 04:12:24 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 04:12:24 INFO - 'talos_options': ['--disable-e10s'], 04:12:24 INFO - 'tests': ['tp5o']}, 04:12:24 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 04:12:24 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 04:12:24 INFO - 'talos_options': ['--disable-e10s', 04:12:24 INFO - '--xperf_path', 04:12:24 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:12:24 INFO - 'tests': ['tp5n']}, 04:12:24 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 04:12:24 INFO - 'talos_options': ['--xperf_path', 04:12:24 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:12:24 INFO - 'tests': ['tp5n']}}, 04:12:24 INFO - 'talos.zip': {'path': '', 04:12:24 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:12:24 INFO - Running post-action listener: _resource_record_post_action 04:12:24 INFO - [mozharness: 2017-03-09 12:12:24.477323Z] Finished populate-webroot step (success) 04:12:24 INFO - [mozharness: 2017-03-09 12:12:24.477451Z] Running create-virtualenv step. 04:12:24 INFO - Running pre-action listener: _resource_record_pre_action 04:12:24 INFO - Running main action method: create_virtualenv 04:12:24 INFO - Creating virtualenv /builds/slave/test/build/venv 04:12:24 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 04:12:24 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:12:24 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:12:24 INFO - Using real prefix '/tools/python27' 04:12:24 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:12:25 INFO - Installing distribute.............................................................................................................................................................................................done. 04:12:28 INFO - Installing pip.................done. 04:12:28 INFO - Return code: 0 04:12:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 04:12:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 04:12:28 INFO - Reading from file tmpfile_stdout 04:12:28 INFO - Output received: 04:12:28 INFO - pip 1.5.5 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 04:12:28 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:12:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:12:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:12:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:12:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:12:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:12:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:12:28 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 0x101370b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101373768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc332c6f770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10114ed30>, '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 0x101075db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101143be8>, '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.wQxPSeHV9x/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.HqyWDKlAjF/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/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 04:12:28 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 04:12:28 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 04:12:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wQxPSeHV9x/Render', 04:12:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:12:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:12:28 INFO - 'HOME': '/Users/cltbld', 04:12:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:12:28 INFO - 'LOGNAME': 'cltbld', 04:12:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:12:28 INFO - 'MOZ_NO_REMOTE': '1', 04:12:28 INFO - 'NO_EM_RESTART': '1', 04:12:28 INFO - 'PAGER': '/bin/cat', 04:12:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:12:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:12:28 INFO - 'PWD': '/builds/slave/test', 04:12:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:12:28 INFO - 'SHELL': '/bin/bash', 04:12:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HqyWDKlAjF/Listeners', 04:12:28 INFO - 'TMPDIR': '/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/', 04:12:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:12:28 INFO - 'USER': 'cltbld', 04:12:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:12:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:12:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:12:28 INFO - 'XPC_FLAGS': '0x0', 04:12:28 INFO - 'XPC_SERVICE_NAME': '0', 04:12:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:12:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:12:28 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 04:12:28 INFO - Cleaning up... 04:12:28 INFO - Return code: 0 04:12:28 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 04:12:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:12:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:12:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:12:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:12:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:12:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:12:28 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 0x101370b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101373768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc332c6f770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10114ed30>, '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 0x101075db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101143be8>, '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.wQxPSeHV9x/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.HqyWDKlAjF/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/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 04:12:28 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 04:12:28 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 04:12:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wQxPSeHV9x/Render', 04:12:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:12:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:12:28 INFO - 'HOME': '/Users/cltbld', 04:12:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:12:28 INFO - 'LOGNAME': 'cltbld', 04:12:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:12:28 INFO - 'MOZ_NO_REMOTE': '1', 04:12:28 INFO - 'NO_EM_RESTART': '1', 04:12:28 INFO - 'PAGER': '/bin/cat', 04:12:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:12:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:12:28 INFO - 'PWD': '/builds/slave/test', 04:12:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:12:28 INFO - 'SHELL': '/bin/bash', 04:12:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HqyWDKlAjF/Listeners', 04:12:28 INFO - 'TMPDIR': '/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/', 04:12:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:12:28 INFO - 'USER': 'cltbld', 04:12:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:12:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:12:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:12:28 INFO - 'XPC_FLAGS': '0x0', 04:12:28 INFO - 'XPC_SERVICE_NAME': '0', 04:12:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:12:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:12:28 INFO - Downloading/unpacking psutil>=3.1.1 04:12:28 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 04:12:28 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 04:12:28 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 04:12:28 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 04:12:28 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 04:12:28 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 04:12:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:12:32 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:12:32 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:12:32 INFO - Installing collected packages: psutil 04:12:32 INFO - Running setup.py install for psutil 04:12:32 INFO - building 'psutil._psutil_osx' extension 04:12:32 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 04:12:33 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 04:12:33 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 04:12:33 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 04:12:33 INFO - building 'psutil._psutil_posix' extension 04:12:33 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 04:12:33 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 04:12:33 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 04:12:33 INFO - ^ 04:12:33 INFO - 1 warning generated. 04:12:33 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 04:12:33 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:12:33 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:12:33 INFO - Successfully installed psutil 04:12:33 INFO - Cleaning up... 04:12:33 INFO - Return code: 0 04:12:33 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 04:12:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:12:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:12:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:12:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:12:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:12:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:12:34 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 0x101370b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101373768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc332c6f770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10114ed30>, '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 0x101075db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101143be8>, '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.wQxPSeHV9x/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.HqyWDKlAjF/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/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 04:12:34 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 04:12:34 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 04:12:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wQxPSeHV9x/Render', 04:12:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:12:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:12:34 INFO - 'HOME': '/Users/cltbld', 04:12:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:12:34 INFO - 'LOGNAME': 'cltbld', 04:12:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:12:34 INFO - 'MOZ_NO_REMOTE': '1', 04:12:34 INFO - 'NO_EM_RESTART': '1', 04:12:34 INFO - 'PAGER': '/bin/cat', 04:12:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:12:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:12:34 INFO - 'PWD': '/builds/slave/test', 04:12:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:12:34 INFO - 'SHELL': '/bin/bash', 04:12:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HqyWDKlAjF/Listeners', 04:12:34 INFO - 'TMPDIR': '/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/', 04:12:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:12:34 INFO - 'USER': 'cltbld', 04:12:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:12:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:12:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:12:34 INFO - 'XPC_FLAGS': '0x0', 04:12:34 INFO - 'XPC_SERVICE_NAME': '0', 04:12:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:12:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:12:34 INFO - Downloading/unpacking mozsystemmonitor==0.3 04:12:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:12:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:12:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:12:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:12:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:12:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:12:37 INFO - Downloading mozsystemmonitor-0.3.tar.gz 04:12:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:12:37 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 04:12:37 INFO - Installing collected packages: mozsystemmonitor 04:12:37 INFO - Running setup.py install for mozsystemmonitor 04:12:38 INFO - Successfully installed mozsystemmonitor 04:12:38 INFO - Cleaning up... 04:12:38 INFO - Return code: 0 04:12:38 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 04:12: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')]} 04:12:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:12:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:12: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')]} 04:12:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:12:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:12:38 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x101370b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101373768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc332c6f770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10114ed30>, '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 0x101075db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101143be8>, '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.wQxPSeHV9x/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.HqyWDKlAjF/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/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 04:12:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 04:12:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 04:12:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wQxPSeHV9x/Render', 04:12:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:12:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:12:38 INFO - 'HOME': '/Users/cltbld', 04:12:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:12:38 INFO - 'LOGNAME': 'cltbld', 04:12:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:12:38 INFO - 'MOZ_NO_REMOTE': '1', 04:12:38 INFO - 'NO_EM_RESTART': '1', 04:12:38 INFO - 'PAGER': '/bin/cat', 04:12:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:12:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:12:38 INFO - 'PWD': '/builds/slave/test', 04:12:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:12:38 INFO - 'SHELL': '/bin/bash', 04:12:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HqyWDKlAjF/Listeners', 04:12:38 INFO - 'TMPDIR': '/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/', 04:12:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:12:38 INFO - 'USER': 'cltbld', 04:12:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:12:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:12:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:12:38 INFO - 'XPC_FLAGS': '0x0', 04:12:38 INFO - 'XPC_SERVICE_NAME': '0', 04:12:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:12:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:12:38 INFO - Downloading/unpacking jsonschema==2.5.1 04:12:38 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 04:12:38 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 04:12:38 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 04:12:38 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 04:12:38 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 04:12:38 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 04:12:40 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:12:41 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 04:12:41 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 04:12:41 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 04:12:41 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 04:12:41 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 04:12:41 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 04:12:41 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 04:12:41 INFO - Downloading functools32-3.2.3-2.tar.gz 04:12:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:12:41 INFO - warning: no files found matching '*.txt' 04:12:41 INFO - no previously-included directories found matching 'build' 04:12:41 INFO - no previously-included directories found matching 'dist' 04:12:41 INFO - no previously-included directories found matching '.git*' 04:12:41 INFO - Installing collected packages: jsonschema, functools32 04:12:41 INFO - Running setup.py install for functools32 04:12:41 INFO - warning: no files found matching '*.txt' 04:12:41 INFO - no previously-included directories found matching 'build' 04:12:41 INFO - no previously-included directories found matching 'dist' 04:12:41 INFO - no previously-included directories found matching '.git*' 04:12:41 INFO - Successfully installed jsonschema functools32 04:12:41 INFO - Cleaning up... 04:12:41 INFO - Return code: 0 04:12:41 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 04:12:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:12:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:12:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:12:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:12:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:12:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:12:41 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 0x101370b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101373768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc332c6f770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10114ed30>, '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 0x101075db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101143be8>, '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.wQxPSeHV9x/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.HqyWDKlAjF/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/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 04:12:41 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 04:12:41 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 04:12:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wQxPSeHV9x/Render', 04:12:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:12:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:12:41 INFO - 'HOME': '/Users/cltbld', 04:12:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:12:41 INFO - 'LOGNAME': 'cltbld', 04:12:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:12:41 INFO - 'MOZ_NO_REMOTE': '1', 04:12:41 INFO - 'NO_EM_RESTART': '1', 04:12:41 INFO - 'PAGER': '/bin/cat', 04:12:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:12:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:12:41 INFO - 'PWD': '/builds/slave/test', 04:12:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:12:41 INFO - 'SHELL': '/bin/bash', 04:12:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HqyWDKlAjF/Listeners', 04:12:41 INFO - 'TMPDIR': '/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/', 04:12:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:12:41 INFO - 'USER': 'cltbld', 04:12:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:12:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:12:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:12:41 INFO - 'XPC_FLAGS': '0x0', 04:12:41 INFO - 'XPC_SERVICE_NAME': '0', 04:12:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:12:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:12:42 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 04:12:42 INFO - Cleaning up... 04:12:42 INFO - Return code: 0 04:12:42 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:12:42 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')]} 04:12:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:12:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:12:42 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')]} 04:12:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:12:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:12:42 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 0x101370b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101373768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc332c6f770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10114ed30>, '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 0x101075db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101143be8>, '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.wQxPSeHV9x/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.HqyWDKlAjF/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/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 04:12:42 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 04:12:42 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 04:12:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wQxPSeHV9x/Render', 04:12:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:12:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:12:42 INFO - 'HOME': '/Users/cltbld', 04:12:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:12:42 INFO - 'LOGNAME': 'cltbld', 04:12:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:12:42 INFO - 'MOZ_NO_REMOTE': '1', 04:12:42 INFO - 'NO_EM_RESTART': '1', 04:12:42 INFO - 'PAGER': '/bin/cat', 04:12:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:12:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:12:42 INFO - 'PWD': '/builds/slave/test', 04:12:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:12:42 INFO - 'SHELL': '/bin/bash', 04:12:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HqyWDKlAjF/Listeners', 04:12:42 INFO - 'TMPDIR': '/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/', 04:12:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:12:42 INFO - 'USER': 'cltbld', 04:12:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:12:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:12:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:12:42 INFO - 'XPC_FLAGS': '0x0', 04:12:42 INFO - 'XPC_SERVICE_NAME': '0', 04:12:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:12:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:12:42 INFO - Downloading/unpacking blobuploader==1.2.4 04:12:42 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 04:12:42 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 04:12:42 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 04:12:42 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 04:12:42 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 04:12:42 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 04:12:44 INFO - Downloading blobuploader-1.2.4.tar.gz 04:12:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:12:45 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:12:45 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 04:12:45 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 04:12:45 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 04:12:45 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 04:12:45 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 04:12:45 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 04:12:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:12:45 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:12:45 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 04:12:45 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 04:12:45 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 04:12:45 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 04:12:45 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 04:12:45 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 04:12:46 INFO - Downloading docopt-0.6.1.tar.gz 04:12:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:12:46 INFO - Installing collected packages: blobuploader, requests, docopt 04:12:46 INFO - Running setup.py install for blobuploader 04:12:46 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:12:46 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:12:46 INFO - Running setup.py install for requests 04:12:47 INFO - Running setup.py install for docopt 04:12:47 INFO - Successfully installed blobuploader requests docopt 04:12:47 INFO - Cleaning up... 04:12:47 INFO - Return code: 0 04:12:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:12:47 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')]} 04:12:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:12:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:12:47 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')]} 04:12:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:12:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:12:47 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 0x101370b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101373768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc332c6f770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10114ed30>, '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 0x101075db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101143be8>, '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.wQxPSeHV9x/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.HqyWDKlAjF/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/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 04:12:47 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 04:12:47 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 04:12:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wQxPSeHV9x/Render', 04:12:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:12:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:12:47 INFO - 'HOME': '/Users/cltbld', 04:12:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:12:47 INFO - 'LOGNAME': 'cltbld', 04:12:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:12:47 INFO - 'MOZ_NO_REMOTE': '1', 04:12:47 INFO - 'NO_EM_RESTART': '1', 04:12:47 INFO - 'PAGER': '/bin/cat', 04:12:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:12:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:12:47 INFO - 'PWD': '/builds/slave/test', 04:12:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:12:47 INFO - 'SHELL': '/bin/bash', 04:12:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HqyWDKlAjF/Listeners', 04:12:47 INFO - 'TMPDIR': '/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/', 04:12:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:12:47 INFO - 'USER': 'cltbld', 04:12:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:12:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:12:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:12:47 INFO - 'XPC_FLAGS': '0x0', 04:12:47 INFO - 'XPC_SERVICE_NAME': '0', 04:12:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:12:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:12:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:12:47 INFO - Running setup.py (path:/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/pip-So549F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:12:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:12:47 INFO - Running setup.py (path:/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/pip-uywa3y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:12:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:12:47 INFO - Running setup.py (path:/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/pip-8xk1uh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:12:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:12:47 INFO - Running setup.py (path:/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/pip-fzIgxr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:12:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:12:47 INFO - Running setup.py (path:/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/pip-DBdfOy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:12:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:12:48 INFO - Running setup.py (path:/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/pip-tzi4JD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:12:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:12:48 INFO - Running setup.py (path:/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/pip-BrdDiW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:12:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:12:48 INFO - Running setup.py (path:/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/pip-rzXTp0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:12:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:12:48 INFO - Running setup.py (path:/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/pip-W1BQPV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:12:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:12:48 INFO - Running setup.py (path:/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/pip-md60OH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:12:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:12:48 INFO - Running setup.py (path:/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/pip-Ti9E3x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:12:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:12:48 INFO - Running setup.py (path:/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/pip-gsNhoB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:12:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:12:48 INFO - Running setup.py (path:/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/pip-YUs5fc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:12:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:12:48 INFO - Running setup.py (path:/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/pip-cZviBo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:12:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:12:49 INFO - Running setup.py (path:/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/pip-BpQnN9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:12:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:12:49 INFO - Running setup.py (path:/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/pip-S792Uh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:12:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:12:49 INFO - Running setup.py (path:/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/pip-D53rXm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:12:49 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:12:49 INFO - Running setup.py install for manifestparser 04:12:49 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:12:49 INFO - Running setup.py install for mozcrash 04:12:49 INFO - Running setup.py install for mozdebug 04:12:49 INFO - Running setup.py install for mozdevice 04:12:49 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:12:49 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:12:49 INFO - Running setup.py install for mozfile 04:12:50 INFO - Running setup.py install for mozhttpd 04:12:50 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:12:50 INFO - Running setup.py install for mozinfo 04:12:50 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:12:50 INFO - Running setup.py install for mozInstall 04:12:50 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:12:50 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:12:50 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:12:50 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:12:50 INFO - Running setup.py install for mozleak 04:12:50 INFO - Running setup.py install for mozlog 04:12:50 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:12:50 INFO - Running setup.py install for moznetwork 04:12:50 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:12:50 INFO - Running setup.py install for mozprocess 04:12:51 INFO - Running setup.py install for mozprofile 04:12:51 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:12:51 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:12:51 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:12:51 INFO - Running setup.py install for mozrunner 04:12:51 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:12:51 INFO - Running setup.py install for mozscreenshot 04:12:51 INFO - Running setup.py install for moztest 04:12:51 INFO - Running setup.py install for mozversion 04:12:51 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:12:51 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:12:51 INFO - Cleaning up... 04:12:51 INFO - Return code: 0 04:12:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:12:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:12:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:12:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:12:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:12:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:12:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:12:51 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 0x101370b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101373768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc332c6f770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10114ed30>, '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 0x101075db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101143be8>, '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.wQxPSeHV9x/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.HqyWDKlAjF/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/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 04:12:51 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 04:12:51 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 04:12:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wQxPSeHV9x/Render', 04:12:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:12:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:12:51 INFO - 'HOME': '/Users/cltbld', 04:12:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:12:51 INFO - 'LOGNAME': 'cltbld', 04:12:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:12:51 INFO - 'MOZ_NO_REMOTE': '1', 04:12:51 INFO - 'NO_EM_RESTART': '1', 04:12:51 INFO - 'PAGER': '/bin/cat', 04:12:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:12:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:12:51 INFO - 'PWD': '/builds/slave/test', 04:12:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:12:51 INFO - 'SHELL': '/bin/bash', 04:12:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HqyWDKlAjF/Listeners', 04:12:51 INFO - 'TMPDIR': '/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/', 04:12:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:12:51 INFO - 'USER': 'cltbld', 04:12:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:12:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:12:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:12:51 INFO - 'XPC_FLAGS': '0x0', 04:12:51 INFO - 'XPC_SERVICE_NAME': '0', 04:12:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:12:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:12:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:12:52 INFO - Running setup.py (path:/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/pip-pYWUBT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:12:52 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)) 04:12:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:12:52 INFO - Running setup.py (path:/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/pip-rQUmHJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:12:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:12:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:12:52 INFO - Running setup.py (path:/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/pip-exYfvK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:12:52 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)) 04:12:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:12:52 INFO - Running setup.py (path:/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/pip-QR6xPA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:12:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:12:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:12:52 INFO - Running setup.py (path:/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/pip-opGX80-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:12:52 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)) 04:12:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:12:52 INFO - Running setup.py (path:/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/pip-zpz7lr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:12:52 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)) 04:12:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:12:52 INFO - Running setup.py (path:/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/pip-hh0Y_b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:12:52 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)) 04:12:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:12:52 INFO - Running setup.py (path:/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/pip-TSJy6I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:12:53 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)) 04:12:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:12:53 INFO - Running setup.py (path:/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/pip-7k0ZHr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:12:53 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)) 04:12:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:12:53 INFO - Running setup.py (path:/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/pip-bYrWc4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:12:53 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)) 04:12:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:12:53 INFO - Running setup.py (path:/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/pip-UFYKos-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:12:53 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)) 04:12:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:12:53 INFO - Running setup.py (path:/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/pip-BWE9f_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:12:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 04:12:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:12:53 INFO - Running setup.py (path:/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/pip-KOUnwT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:12:53 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)) 04:12:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:12:53 INFO - Running setup.py (path:/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/pip-aWeIm1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:12:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 04:12:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:12:53 INFO - Running setup.py (path:/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/pip-dwh5QO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:12:53 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)) 04:12:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:12:53 INFO - Running setup.py (path:/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/pip-BhwIs7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:12:53 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 04:12:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:12:53 INFO - Running setup.py (path:/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/pip-EY0qaL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:12:54 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)) 04:12:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:12:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:12:54 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)) 04:12:54 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:12:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:12:54 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:12:54 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 04:12:54 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 04:12:54 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 04:12:54 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 04:12:54 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 04:12:54 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 04:12:56 INFO - Downloading blessings-1.6.tar.gz 04:12:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:12:56 INFO - Installing collected packages: blessings 04:12:56 INFO - Running setup.py install for blessings 04:12:56 INFO - Successfully installed blessings 04:12:56 INFO - Cleaning up... 04:12:56 INFO - Return code: 0 04:12:56 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:12:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:12:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:12:57 INFO - Reading from file tmpfile_stdout 04:12:57 INFO - Current package versions: 04:12:57 INFO - blessings == 1.6 04:12:57 INFO - blobuploader == 1.2.4 04:12:57 INFO - docopt == 0.6.1 04:12:57 INFO - functools32 == 3.2.3-2 04:12:57 INFO - jsonschema == 2.5.1 04:12:57 INFO - manifestparser == 1.1 04:12:57 INFO - mozInstall == 1.12 04:12:57 INFO - mozcrash == 1.0 04:12:57 INFO - mozdebug == 0.1 04:12:57 INFO - mozdevice == 0.49 04:12:57 INFO - mozfile == 1.2 04:12:57 INFO - mozhttpd == 0.7 04:12:57 INFO - mozinfo == 0.9 04:12:57 INFO - mozleak == 0.1 04:12:57 INFO - mozlog == 3.4 04:12:57 INFO - moznetwork == 0.27 04:12:57 INFO - mozprocess == 0.25 04:12:57 INFO - mozprofile == 0.28 04:12:57 INFO - mozrunner == 6.13 04:12:57 INFO - mozscreenshot == 0.1 04:12:57 INFO - mozsystemmonitor == 0.3 04:12:57 INFO - moztest == 0.8 04:12:57 INFO - mozversion == 1.4 04:12:57 INFO - psutil == 3.1.1 04:12:57 INFO - requests == 1.2.3 04:12:57 INFO - wsgiref == 0.1.2 04:12:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:12:57 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')]} 04:12:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:12:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:12:57 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')]} 04:12:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:12:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:12:57 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 0x101370b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101373768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc332c6f770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10114ed30>, '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 0x101075db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101143be8>, '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.wQxPSeHV9x/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.HqyWDKlAjF/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/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 04:12:57 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 04:12:57 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 04:12:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wQxPSeHV9x/Render', 04:12:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:12:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:12:57 INFO - 'HOME': '/Users/cltbld', 04:12:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:12:57 INFO - 'LOGNAME': 'cltbld', 04:12:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:12:57 INFO - 'MOZ_NO_REMOTE': '1', 04:12:57 INFO - 'NO_EM_RESTART': '1', 04:12:57 INFO - 'PAGER': '/bin/cat', 04:12:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:12:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:12:57 INFO - 'PWD': '/builds/slave/test', 04:12:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:12:57 INFO - 'SHELL': '/bin/bash', 04:12:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HqyWDKlAjF/Listeners', 04:12:57 INFO - 'TMPDIR': '/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/', 04:12:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:12:57 INFO - 'USER': 'cltbld', 04:12:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:12:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:12:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:12:57 INFO - 'XPC_FLAGS': '0x0', 04:12:57 INFO - 'XPC_SERVICE_NAME': '0', 04:12:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:12:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:12:57 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)) 04:12:57 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)) 04:12:57 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)) 04:12:57 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)) 04:12:57 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)) 04:12:57 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)) 04:12:57 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)) 04:12:57 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)) 04:12:57 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)) 04:12:57 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)) 04:12:57 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)) 04:12:57 INFO - Cleaning up... 04:12:57 INFO - Return code: 0 04:12:57 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:12:57 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')]} 04:12:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:12:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:12:57 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')]} 04:12:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:12:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:12:57 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 0x101370b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101373768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc332c6f770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10114ed30>, '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 0x101075db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101143be8>, '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.wQxPSeHV9x/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.HqyWDKlAjF/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/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 04:12:57 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 04:12:57 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 04:12:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wQxPSeHV9x/Render', 04:12:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:12:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:12:57 INFO - 'HOME': '/Users/cltbld', 04:12:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:12:57 INFO - 'LOGNAME': 'cltbld', 04:12:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:12:57 INFO - 'MOZ_NO_REMOTE': '1', 04:12:57 INFO - 'NO_EM_RESTART': '1', 04:12:57 INFO - 'PAGER': '/bin/cat', 04:12:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:12:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:12:57 INFO - 'PWD': '/builds/slave/test', 04:12:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:12:57 INFO - 'SHELL': '/bin/bash', 04:12:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HqyWDKlAjF/Listeners', 04:12:57 INFO - 'TMPDIR': '/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/', 04:12:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:12:57 INFO - 'USER': 'cltbld', 04:12:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:12:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:12:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:12:57 INFO - 'XPC_FLAGS': '0x0', 04:12:57 INFO - 'XPC_SERVICE_NAME': '0', 04:12:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:12:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:12:57 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 04:12:57 INFO - Cleaning up... 04:12:57 INFO - Return code: 0 04:12:57 INFO - Running post-action listener: _resource_record_post_action 04:12:57 INFO - Running post-action listener: _start_resource_monitoring 04:12:57 INFO - Starting resource monitoring. 04:12:57 INFO - [mozharness: 2017-03-09 12:12:57.815904Z] Finished create-virtualenv step (success) 04:12:57 INFO - [mozharness: 2017-03-09 12:12:57.816919Z] Running install step. 04:12:57 INFO - Running pre-action listener: _resource_record_pre_action 04:12:57 INFO - Running main action method: install 04:12:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:12:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:12:58 INFO - Reading from file tmpfile_stdout 04:12:58 INFO - Detecting whether we're running mozinstall >=1.0... 04:12:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:12:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:12:58 INFO - Reading from file tmpfile_stdout 04:12:58 INFO - Output received: 04:12:58 INFO - Usage: mozinstall [options] installer 04:12:58 INFO - Options: 04:12:58 INFO - -h, --help show this help message and exit 04:12:58 INFO - -d DEST, --destination=DEST 04:12:58 INFO - Directory to install application into. [default: 04:12:58 INFO - "/builds/slave/test"] 04:12:58 INFO - --app=APP Application being installed. [default: firefox] 04:12:58 INFO - mkdir: /builds/slave/test/build/application 04:12:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 04:12:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 04:13:18 INFO - Reading from file tmpfile_stdout 04:13:18 INFO - Output received: 04:13:18 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 04:13:18 INFO - Running post-action listener: _resource_record_post_action 04:13:18 INFO - [mozharness: 2017-03-09 12:13:18.505053Z] Finished install step (success) 04:13:18 INFO - [mozharness: 2017-03-09 12:13:18.505191Z] Running run-tests step. 04:13:18 INFO - Running pre-action listener: _resource_record_pre_action 04:13:18 INFO - Running main action method: run_tests 04:13:18 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:13:18 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:13:18 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:13:18 INFO - 2017-03-09 04:13:18.520 screenresolution[2530:21354] starting screenresolution argv=screenresolution get 04:13:18 INFO - 2017-03-09 04:13:18.522 screenresolution[2530:21354] Display 0: 1600x1200x32@60 04:13:18 INFO - 2017-03-09 04:13:18.529 screenresolution[2531:21356] starting screenresolution argv=screenresolution list 04:13:18 INFO - Available Modes on Display 0 04:13:18 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:13:18 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:13:18 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:13:18 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:13:18 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:13:18 INFO - Intel Iris: 04:13:18 INFO - Chipset Model: Intel Iris 04:13:18 INFO - Type: GPU 04:13:18 INFO - Bus: Built-In 04:13:18 INFO - VRAM (Dynamic, Max): 1536 MB 04:13:18 INFO - Vendor: Intel (0x8086) 04:13:18 INFO - Device ID: 0x0a2e 04:13:18 INFO - Revision ID: 0x0009 04:13:18 INFO - Displays: 04:13:18 INFO - Display: 04:13:18 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:13:18 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:13:18 INFO - Display Serial Number: 1600x1200 60 04:13:18 INFO - Main Display: Yes 04:13:18 INFO - Mirror: Off 04:13:18 INFO - Online: Yes 04:13:18 INFO - Rotation: Supported 04:13:18 INFO - Return code: 0 04:13:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:13:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:13:18 INFO - Python 2.7.3 04:13:18 INFO - Return code: 0 04:13:18 INFO - grabbing minidump binary from tooltool 04:13:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:13:18 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 0x10114ed30>, '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 0x101075db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101143be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:13:18 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 04:13:18 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 04:13:18 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 04:13:18 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:13:18 INFO - Return code: 0 04:13:18 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 04:13:18 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:13:18 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:13:18 INFO - ENV: RUST_BACKTRACE is now 1 04:13:18 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 04:13:18 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:13:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/VivP9G1OTLiFoUMxDokQeg/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0094', '--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 04:13:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/VivP9G1OTLiFoUMxDokQeg/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0094 --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 04:13:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wQxPSeHV9x/Render', 04:13:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:13:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:13:18 INFO - 'HOME': '/Users/cltbld', 04:13:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:13:18 INFO - 'LOGNAME': 'cltbld', 04:13:18 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:13:18 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 04:13:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:13:18 INFO - 'MOZ_NO_REMOTE': '1', 04:13:18 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:13:18 INFO - 'NO_EM_RESTART': '1', 04:13:18 INFO - 'PAGER': '/bin/cat', 04:13:18 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:13:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:13:18 INFO - 'PWD': '/builds/slave/test', 04:13:18 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:13:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:13:18 INFO - 'RUST_BACKTRACE': '1', 04:13:18 INFO - 'SHELL': '/bin/bash', 04:13:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HqyWDKlAjF/Listeners', 04:13:18 INFO - 'TMPDIR': '/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/', 04:13:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:13:18 INFO - 'USER': 'cltbld', 04:13:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:13:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:13:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:13:18 INFO - 'XPC_FLAGS': '0x0', 04:13:18 INFO - 'XPC_SERVICE_NAME': '0', 04:13:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:13:18 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/VivP9G1OTLiFoUMxDokQeg/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0094', '--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 04:13:19 INFO - mozversion application_buildid: 20170309022424 04:13:19 INFO - mozversion application_changeset: da0ea1c722078f30c6f390627d3c680d3556a7a6 04:13:19 INFO - mozversion application_display_name: Nightly 04:13:19 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:13:19 INFO - mozversion application_name: Firefox 04:13:19 INFO - mozversion application_remotingname: firefox 04:13:19 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 04:13:19 INFO - mozversion application_vendor: Mozilla 04:13:19 INFO - mozversion application_version: 55.0a1 04:13:19 INFO - mozversion platform_buildid: 20170309022424 04:13:19 INFO - mozversion platform_changeset: da0ea1c722078f30c6f390627d3c680d3556a7a6 04:13:19 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 04:13:19 INFO - mozversion platform_version: 55.0a1 04:13:19 INFO - using testdate: 1489061599 04:13:19 INFO - actual date: 1489061599 04:13:19 INFO - starting webserver on 'localhost:52635' 04:13:19 INFO - SUITE-START | Running 2 tests 04:13:19 INFO - TEST-START | dromaeo_css 04:13:19 INFO - operating with platform_type : mac_ 04:13:19 INFO - Initialising browser for dromaeo_css test... 04:13:19 INFO - TEST-INFO | started process 2541 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/tmpdQ5HpR/profile http://localhost:52635/getInfo.html) 04:13:21 INFO - PROCESS | 2541 | __metrics Screen width/height:1600/1200 04:13:21 INFO - PROCESS | 2541 | colorDepth:24 04:13:21 INFO - PROCESS | 2541 | Browser inner width/height: 1024/689 04:13:21 INFO - PROCESS | 2541 | __metrics 04:13:21 INFO - PROCESS | 2541 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 673: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 04:13:21 INFO - PROCESS | 2541 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:13:22 INFO - TEST-INFO | 2541: exit 0 04:13:22 INFO - Browser initialized. 04:13:22 INFO - Running cycle 1/1 for dromaeo_css test... 04:13:22 INFO - TEST-INFO | started process 2543 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/tmpdQ5HpR/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:13:34 INFO - PROCESS | 2543 | RSS: Main: 232812544 04:13:34 INFO - PROCESS | 2543 | 04:16:38 INFO - PROCESS | 2543 | Cycle 1(1): loaded http://localhost:52635/tests/dromaeo/cssquery-dojo.html (next: http://localhost:52635/tests/dromaeo/cssquery-ext.html) 04:16:42 INFO - PROCESS | 2543 | RSS: Main: 539074560 04:16:42 INFO - PROCESS | 2543 | 04:18:24 INFO - PROCESS | 2543 | ************************* 04:18:24 INFO - PROCESS | 2543 | A coding exception was thrown and uncaught in a Task. 04:18:24 INFO - PROCESS | 2543 | 04:18:24 ERROR - PROCESS | 2543 | Full message: TypeError: NetworkError when attempting to fetch resource. 04:18:24 INFO - PROCESS | 2543 | Full stack: 04:18:24 INFO - PROCESS | 2543 | ************************* 04:19:45 INFO - PROCESS | 2543 | Cycle 1(1): loaded http://localhost:52635/tests/dromaeo/cssquery-ext.html (next: http://localhost:52635/tests/dromaeo/cssquery-jquery.html) 04:19:46 INFO - PROCESS | 2543 | RSS: Main: 371376128 04:19:46 INFO - PROCESS | 2543 | 04:22:48 INFO - PROCESS | 2543 | Cycle 1(1): loaded http://localhost:52635/tests/dromaeo/cssquery-jquery.html (next: http://localhost:52635/tests/dromaeo/cssquery-mootools.html) 04:22:49 INFO - PROCESS | 2543 | RSS: Main: 360394752 04:22:49 INFO - PROCESS | 2543 | 04:25:51 INFO - PROCESS | 2543 | Cycle 1(1): loaded http://localhost:52635/tests/dromaeo/cssquery-mootools.html (next: http://localhost:52635/tests/dromaeo/cssquery-prototype.html) 04:25:52 INFO - PROCESS | 2543 | RSS: Main: 340975616 04:25:52 INFO - PROCESS | 2543 | 04:28:56 INFO - PROCESS | 2543 | Cycle 1(1): loaded http://localhost:52635/tests/dromaeo/cssquery-prototype.html (next: http://localhost:52635/tests/dromaeo/cssquery-yui.html) 04:28:57 INFO - PROCESS | 2543 | RSS: Main: 335790080 04:28:57 INFO - PROCESS | 2543 | 04:32:00 INFO - PROCESS | 2543 | Cycle 1(1): loaded http://localhost:52635/tests/dromaeo/cssquery-yui.html (next: http://localhost:52635/tests/dromaeo/cssquery-dojo.html) 04:32:01 INFO - PROCESS | 2543 | RSS: Main: 429727744 04:32:01 INFO - PROCESS | 2543 | 04:32:01 INFO - PROCESS | 2543 | __start_tp_report 04:32:01 INFO - PROCESS | 2543 | _x_x_mozilla_page_load 04:32:01 INFO - PROCESS | 2543 | _x_x_mozilla_page_load_details 04:32:01 INFO - PROCESS | 2543 | |i|pagename|runs| 04:32:01 INFO - PROCESS | 2543 | |0;dojo.html;3370.090075679567;3371.15394143586;3403.0471467988964;3426.0407086015925;3443.431833747432;5698.34469036061;5804.390538993408;6060.393960603943;6075.392460753922;6076.453119219269;5610;5750.769969201227;5867.618604790686;5894.351621321651;6010.939890601104;5235.58115350771;5284.630075894689;5285.814996475124;5301.496357846017;5317.521423071923;5425.403205647375;5455.890882182354;5464.808731694391;5486.396496385394;5520.309961254843;5103.132467480537;5151.45909679482;5177.326947496839;5207;5381.488758567949;4296.52738198801;4435.957549975753;5144.305518754958;5210.088234558975;5216.5305122538775;4311.482622085338;5128.820491282787;5152;5166.664166829144;5200.401953775327;5688.857778555528;5688.943110568883;5698.34469036062;5702.087665973424;5719.885602287973;6192.473639740628;6204.720787564571;6209.627422354673;6215.813525594194;6216.689165541705;4676.766161691936;6247.437730604267;6273.780417685405;6295;6337;5933.436323549256;5953.970230148865;6037.547183961176;6044.788432404933;6061.575689701678;6472.449841763409;6524;6528.183977002875;6529.967350163219;6531.836704082436;6144.586745048664;6187.443130118221;6234.719437625317;6304.905426418607;6328.525360597973;6313.210848643919;6315.55791094619;6321.494280457552;6335.556511044275;6336.239651241881;6286.528510361742;6287.151234583364;6299.905501417483;6300.9684951574945;6304.3695630437505;6258.15514905491;6284.340144284875;6301.684915754194;6307.747690092345;6334.461570766536;4963;5092.516210959953;5095.184770436712;5096;5138.254953031864;4484.461864576272;4484.663650226246;4494.820207191741;4595.333676616872;4621.653375996813;4954.083494553519;5781.855453613609;5817.621854579439;5990.311114221833;5997.010493268649;6285.622862628257;6364.109024736541;6381.936180638227;6382.170317858649;6393;6009.939900601025;6029.487493563096;6029.6683682397015;6037.849053773603;6053.303870054912;5460.863478413072;5500.477454641723;5642.181883626933;5643.971780141073;5695.914561281584;6386.808395748135;6399.488040956805;6402.071699603438;6427.164468619049;6442.291347951628;6249.50003999688;6275.246970363585;6280.1207830902795;6281.623102613858;6282.340354262919;6494.383033611988;6551.0173473979285;6558.704858281293;6577.6053436793945;6585.012248162814;6312.9899216125195;6319.210098737658;6324.747010119544;6338.080978258219;6338.366163383625;5735.311762588516;6235.469985051322;6297.653629050446;6355.459785918249;6360.840978975378;6204.844878878064;6209.782657606962;6211.223597050369;6214.4407003369915;6214.471769899609;6144.41628045335;6198.907016394848;6201.348858369806;6203.4416902479;6225.8132256032395;6208.81373558794;6222.160008398808;6230.034344676583;6236.968815155895;6254.874902502015;6112.473085128157;6121.3572574879;6184.165137706352;6308.369163083655;6313.3686631336495;6065.636061836304;6069.453749162597;6074.787382441594;6080.422359875804;6083.965725826709 04:32:01 INFO - PROCESS | 2543 | |1;ext.html;686.8317262270743;737.3732327521604;785.4423359414815;869.991300086999;869.991300086999;28879.566806497918;37254;37678.0580485488;37844.24311513768;37929.810350948275;37207.62792372082;37571;39083.21833563327;39087.41368879469;39257.41113883294;7160.785176444715;7769.689212431496;9072.00207977122;9086.818263634723;9110.681126160585;7195.640217989106;7278.417726581887;7282.198958114604;7289.38040266578;10594.841077383846;10799.814054853838;10820.783584328308;10825.458727063655;10827.512761925733;10851.728706782354;10711.517981690804;10741.140708743282;10752.086072683831;10753.193510486666;10764.946175269151;7055.3650171484815;7238.52949558277;8903.33225008127;10340.017698318648;10437.895621043768;36241.45637815435;36729.63270367289;38002.23995520102;38085.619143808486;38106.42840357397;3703.6852017444508;3726.5900750917376;3761.6990640748672;3766.4915236443003;3792.6586607205486;26179.607305890426;26670.066547670933;26670.5999410009;27025.729742702715;27307.86346068277;3109.8445077746023;3112.447792809897;3150.6534281229046;3223.9677603224136;3258.446064169097;333992;337347.62652373407;337465;337470;337957;39341;40989.590104099174;41054.76835694934;45010.32484512735;45292;53796;55416;55433;55486;58245.41754582485;14407.711845763026;14523.346449409803;14708.92645536787;14713.92643036778;14722.852771472148;11775.411229438665;11838.171328006956;11899.821502677467;11936.761264774656;11947.880521194851;13290.401931912893;13314.40085196149;13341.066125371324;13426.932865335611;13493.662658433617;5824.796132135355;5828.271466066742;5862.237909071879;5864.501517371071;5881.470667639933;983.331334692416;1006.7634105985088;1008.742770593494;1024.51335615582;1061.7982583309147;15123.092614443169;15225.390984360723;15507.457238996582;15623.687526249638;15681.921590391976;1090.8800031996475;1095.780843831237;1099.0987390339844;1127.4531852051748;1135.7217481716866;6751.291114432914;6989.580625162404;7788.649510772028;8009.839803203903;8018.278354948083;473158;473554;473804;475894;476342;52871;53197.734011329696;53231.73384133055;53280.467195327554;53289;1311.5737385349798;1398.2030242761732;1410.5556749623836;1411.8094057302337;1412.4209074279702;15009.324580394126;15059.397624095353;15260.389584416498;15548.84451155474;15594.688106238038;43715.78142109396;43797;43839.56160438482;43876.12247755091;43948.56051439573;365619;425552;425596.8720156379;427261;428167;27316.453670926072;27732.44535109327;27855.72144278612;33270.33459330751;33379.666203337656;41159.1768164629;41734.373984389655;41776.58223417727;42148.57851421447;42361;32525.349493009533;33951.66048339485;34217;35004.82497587496;35496.82251588725;33723.3255334887;34074.48888266629;35099.47350789689;35121.47317790184;35167.47248791321;33228.50157247595;33756.83121584376;34063.65936340605;34090.318193636485;34093.14767130841;22744.31767046991;27859.582106268826;28431.436271005292;28997.13008609745;30054.84972575123;19765;20091.68825991582;23118.1908633197;23192.76807231906;23270.41823954347 04:32:01 INFO - PROCESS | 2543 | |2;jquery.html;373.0357027084985;388.5104767992329;398.8324903540513;412.1221797571174;426.0647877907993;13979.063338888493;14315.78526322106;22061.779382206194;23291.76708232917;23551.76448235517;22285.888570557167;22507.437314067156;23323.650145247793;23369;23415;5274.630775845692;6674.733010679567;6734.480520445714;6904.9654751726175;6905.309469053104;6761.4590832733265;6790.898136527956;6816.352446517573;6816.454683625323;6820.147481564804;6655.401013908747;6697.631630260334;6785.898211526806;6846.691898864538;6860.5197636165485;6730.596164230113;6748.021536877125;6757.1891373035305;6833.487488438363;6833.521653484283;5758.913616295759;6402.583832050902;6586.901196482057;6604.438622717074;6612.173478315211;25851.870740646176;26410.471790564083;26547.46905061907;26593.867030664722;27205.863970680217;3335.7331413486863;3348.7823291485975;3365.6970872621337;3415.470602056685;3474.4267195912644;16546.10583554112;16947.322107115702;17044;17256.74114888278;17555.29778808846;2006.7090271910638;2036.1091227232882;2041.4896275931017;2062.1957436599737;2134.3810295014428;118188;135640.64359356478;139771;140138;142907.14185716226;15631.296591653403;21533.56932861334;22049;22918.885405572866;23521.529569408514;35264.82367588145;35500.46749298763;35580.822095889875;37303.440448393296;37309.62690373061;10553.577856885791;10579.312344697724;10636.042756151983;10799.082078023455;10852.689929571556;8607.26838218746;8632.266257368068;8648.481091134552;8765.123487651312;8846.601902914384;8988.280937525113;10606.310589811792;10746.408947507962;10757.246992710436;10861.230386251455;3481.014238696678;4058.73618214821;4073.307537718595;4134.937975930364;4148.2947898857265;1070.5022164693455;1076.7577295108538;1083.8428427877914;1094.1574987259764;1123.4045955643521;22807.087716491485;23263.302100937;23508.764912351;23521.52956940886;23615.527689446113;949.6059135458845;1084.2681190196586;1097.912167026652;1122.4948773052158;1124.7637996020928;10343.793124137475;11849.940750296366;12010.279383237033;12044.006948465569;12044.156909016285;578383.2161678413;673219;695223;712219.4613457811;717406;159007;162100;162307;164466;165225;1311.167408695466;1359.2456186816214;1389.8471168171493;1395.3302414840932;1399.8880089592808;19405;20102;20331.79668203299;20510.69233961462;20568.177272909514;55143.72428137834;62018;62755.686221570424;63541.3645863554;64151.35848641454;88673.66989495292;90608;91187;92071;92396.70160893691;9522.238220942447;12020.879791202326;12089.758204835678;12351.93824030874;12383;10314.742131446774;11389.715257118638;13187.483439404592;13595.45618175262;13986.580402587939;11583.710407239549;11601.82597261025;12011.939940300592;12039.458224379749;12081;11049.39228342449;11614.70963225926;11681.824772628588;11749.942505174575;12232.816507752214;11703.76592468163;11945.223560468541;12039.638810835339;12068.698282542655;12218.327991960172;11901.047916166513;11921.403929803302;12068.939655301667;12278.14053016316;12363.69090772738;11563.5952741657;11589.768204636028;11980.58067967617;11996.700082498008;11997.160198786001 04:32:01 INFO - PROCESS | 2543 | |3;mootools.html;1494.7533656946605;1522.3225664579268;1542.8071491063617;1552.107538165555;1567.6864627074585;10495.73760655984;10992.230543861933;11004.229703920728;11012.449377531131;11055.502502387402;9151.862722059175;10318.484075796217;10813.243072984895;10815.459227038637;10822.080123189538;2322.465832858448;2358.811295096388;2362.5274945011065;2362.61016932206;2366.976330236693;2302.643090321003;2329.4292898239955;2338.240071976606;2341.800946919514;2345.26124270855;2307.7230732312064;2325.162941341116;2334.311378143443;2337.6026075567192;2338.8890277118403;2272.670462782887;2297.6094064009158;2300.2869110575775;2303.424143964009;2308.134449581407;2266.2294819761196;2332.055517515409;2341.07527526626;2343.1915988983774;2348.2016114520975;10696.78606427867;10798.67603971882;10802.243842930999;10814.837777433344;10820.783584328348;5477.67133971963;5652.378238393773;5658;5664.745086471119;5666.886662266773;3310.9503357449657;3400.659934006604;3612.1692010837655;3621.3119507293795;3645.198056427608;1024.497995981971;1064.3401091323428;1096.8738595061511;1142.8114361130486;1234.388977456156;11999.880001199963;13917.86082139186;13926.51257205993;14777;14947.626309342244;4135.855245066408;4244.957550424518;4249.171411574714;4251.404803327537;4264.253755592821;10027.247956403298;10217.284790064625;10230.539625716861;10244.334118282288;10301.04280186777;5179.171332586768;5208.7916483341;5230.476952304815;5236.162214045735;5237.895242095136;4397.516273209944;4897.1185186666025;5157.381114266237;5161.974190129025;5238.633295669267;3401.965980340165;3475.2528206435736;3476.8783092592143;3485.790852548855;3486.8430920608635;987.9407235565745;1011.0849681038671;1013.690824298596;1016.9491525423699;1025.179856115105;866.8006358537572;901.6032945503957;902.0631344957258;905.8278927003848;961.2022021721954;6377.7448902044325;6508.21901371829;6612.537122401386;6698.129243198353;6749.628770417576;969.3941286695815;980.7401038724744;998.7602975285879;1005.7707340632622;1006.1699098243978;3969.325214713506;4079.5920407958965;4088.2436749201493;4092.815823287959;4226.809793559236;10276.486175691334;11935.820962685566;12274.693132671755;12287.324197169242;12289.754204915851;11832.585859494877;12124.39378031095;13159.802602960963;13168.341582920815;13233.404496797668;9687.225021998223;9977.351472154432;9978.700638980843;10033.949830250802;10048.538108163546;5416.417016177384;6416.518761092843;6476.902846457213;6640.701168447528;6700.4639628830555;11776.352300623548;12124.27254364741;12126.636200913987;12165.635030949086;12169.02647788157;11816.881831181921;12154.878451215729;12334.568290109803;12350.62948111558;12355.135140540076;9621.663241786504;10003.649872254437;10018.749531261778;10025.699229023141;10028.498575071071;9590.472524011246;9817.607295708378;9901.851472228067;9927;9928.851067234142;8754.25588824957;8863;8946.597403117006;9005.369624126248;9077.046910074347;8594.78513037179;8641.049484556568;8648.913510864812;8726.389152759246;8762.868556971524;7663.31030207284;7687.346575541142;7768.300852923264;7772;7772.611369431619;4623.306504024423;5344.732763361739;5676.318841739017;5864.296284445893;6024.33732289439;4987.376577927759;5766.389337881697;5906.852328691817;5958.255218097738;6044.848878778066 04:32:01 INFO - PROCESS | 2543 | |4;prototype.html;343.3082339086739;371.1111887030562;372.2629194195493;377.85263747138623;383.5110234451075;4616.976915115428;4959.68568329393;5017.749112544368;5035.571976382007;5053.696778193306;3989.5611482736876;4703.247480403128;4881.5118488151165;4884.3149113555855;4941.851744447663;3413.6857309935604;4133.297339452285;4135.937960930573;4147.668186545069;4163.542010378871;4148.045949431633;4153.8161623937185;4160.667146628262;4167.437395951553;4171.707980441355;3452.8446219920165;4034.899127521821;4162.41726158338;4213.988642725754;4246.80889359978;3791.0901383667997;3881.68946484282;3949.7755695734413;4097.631213190827;4208.600182982627;3791.905202369935;3795.544534655859;3802.9351781501223;3829.6744776693736;3845.1540661054523;4910.582600478963;4919.704817710949;4922.0402021605805;4928.556429921288;4936.481669424695;3965.524137103537;3999.900002499961;4308.375285583604;4778.307145463923;4797.7601119943865;4863.294822250789;4938.9753051234875;4940.060663904971;5316.840494785162;5331.493508116722;3524.1674329348593;3642.817859107034;3951.881443556698;4264.893377665552;4283.464566929134;4985.925211121836;5058.519440653169;5089.898202035939;5313.495217954288;5456.945430545684;3739.6447337502896;4265.957340426618;4283.800535849905;4320.978395108004;4357.651387888961;4380.5838445347645;4405.625521830616;4408.501109622744;4424.977875110604;4442;3757.7369584129397;3996.760194388346;4112.362583799516;4517.10905020787;4754.572088512051;4710.6938049027385;4999.000199960023;5219.6689844089515;5303.946960530346;5327.0556246970355;1368.1927662679068;1468.6842328899338;1471.6762312291278;1523.8323784383708;1549.4499452694356;906.5920335848895;965.99034009659;1033.4419413516766;1044;1144.9391096027118;4659.92633278188;5009.5741861941415;5015.774290156952;5032.622553308516;5048.5203905628905;5024.447310795809;5410.024486532391;5506.531944784738;5543.722813859291;5556.527695145877;4618.630509559294;4624.838130665411;4985.675931064542;5029.094762942632;5059.139946209153;2647.880845361963;2691.730826917332;2827.052937266039;2838.361368692069;2854.5004624190683;4739.478657347689;5012.624053195952;5454.59090568209;5555.999920014437;5756.798512052058;5047.848564543069;5102.821401250939;5351.518363347317;5401.9736250112355;5627.352854421712;4928.581070608967;5617.045102332613;5660;5676.999999999917;5684.488396044376;4889.154947546144;5190.740462976912;5436.7553460093595;5480.205370221216;5486.7902277168305;4926.48271931442;5131;5265.761556642714;5275.736213189249;5382.569394448513;5133.845984620468;5372.5970552207955;5405.378381486179;5491.945080549143;5759.9136012959;4075.5313138989395;4097.684808083423;4338.826446942213;4343.761093139908;4390.3414487827085;4980.601551875914;5127.692338459704;5152.320793187597;5500.1749737539685;5528.474794894479;4714.245720684674;5091.261767043832;5275.8129420879995;5365.812196573102;5375;4704.976475117603;5234.0633965433035;5268.130758424817;5301.231321458444;5417.918731219113;4755.5984227964655;4943.233798761198;5005.874853128701;5127.513290962182;5310.787568497217;4570.840020599263;4937.013107070171;5338.145896656516;5382.4886635769535;5394.703291319015;4455.443069616298;4896.534829191221;5215.6609820361555;5245.272458321728;5268.341457317835 04:32:01 INFO - PROCESS | 2543 | |5;yui.html;703.3458883238586;722.2668990974162;722.9566226026438;761.2425636491688;815.4984684419084;15260.389584416624;16132.354705811782;16146.757798633;16158.353665853367;16199.75700364494;14647.194404307758;14886.702265954675;16267.593310167253;17036.91481542594;17321.30714771411;953.9379940303876;967.1247520993477;969.1713584884927;970.5486948568949;970.7912798748267;938.755923459902;968.467342961372;969.4328817641688;971.2133172130597;973.3089506450393;1034.8395998620188;1039.3088596083633;1039.5477967084305;1041.9062284394404;1042.9009244121796;1030.7423144213947;1034.493098381795;1034.7102811212872;1036.29014125324;1038.4340534408766;754.935830454412;760.1068744225513;761.1931352766086;761.8819083042138;764.1861417590248;15237.314320855477;15651.452199173089;15719.764203536955;15728.977616455008;16019.91990040054;14482.203478808662;14657.486987955477;14685.632859178499;14735.484258051023;14749.573022997154;9673.516324183833;11512.76974460506;11542.884571154265;11785;12038.27770333774;3586.9956412204624;3617.1861331200535;3882.398228274622;3898.629630185156;3908.9804550977346;105546.99999999923;108665.45667271691;108827.45586272098;111324;111565;11024.50389732464;11224.494897729623;11463.885361146282;11606.76786464266;11830;24780.876095619406;24949;24996.625050624254;25008.37479063038;25079.74920250774;7611.695532178762;7634.083909930844;7715.691372345043;7895.368370530344;7992.280694737501;4149.336106223051;4236.512801027921;4254.106637606075;4445.644348452116;4462.665300102505;3341.2315167511124;3403.2512847173584;3408.471686888536;3442.3115376924216;3445.13871532117;622.1662971618053;628.0924064726427;628.0924064726518;636.1761518833122;637.8947473666885;654.3619970528697;658.404144249455;663.8970959501285;690.7202582953912;735.1141874041767;9136.406133601295;9474.336796424323;9858.063483969012;9968.507873031742;10191.776986761488;642.6240649220165;679.6499802601664;689.4312192441256;690.9463068820089;692.7713854428026;4713.410823647044;4807.879803004953;4813.772488015534;4864.537868902448;4868.925065836674;82783;92284.6157307641;100070;101210;104866;85662;86830.56584717036;87848.56075719581;90063.54968225247;90835;62078.68960655168;76854;77613.61193193997;78519;79328;10301.845472318071;10774.299670521392;10845.837312440162;10853.565857365616;10964.451777410937;46624.53375466202;47068.58794236178;48369.51630483791;48846;50290.49709503005;66658.66682666416;66982;67301.66349168222;67597.6480470378;68144.97782533366;12639.3680315982;12659.303738294113;12904.677383065498;13042.673933151367;13244.80132798028;14304.499342522962;14308.230652563847;14432.681827004895;14452.855471445571;14620.488282910048;13527.256000920044;13636.386362613905;13700.45198192061;13747.931260343634;14482.203478808766;13585.388657510239;13603.659908502366;13746.65633359174;13789;13790.517331893336;13450.798238026242;13631;13642.917516034484;13820.170789752647;14057;10899.618513351994;11013.669589912315;11206.327620342805;11247.831282530606;11370.658880233606;9469.289803264921;11175.832362514731;11184.94407527957;11237.550497980315;11281.605143819927 04:32:01 INFO - PROCESS | 2543 | __end_tp_report 04:32:01 INFO - PROCESS | 2543 | __start_cc_report 04:32:01 INFO - PROCESS | 2543 | _x_x_mozilla_cycle_collect,4170 04:32:01 INFO - PROCESS | 2543 | __end_cc_report 04:32:01 INFO - PROCESS | 2543 | __startTimestamp1489062721051__endTimestamp 04:32:01 INFO - PROCESS | 2543 | 04:32:01 INFO - PROCESS | 2543 | ------- Summary: start ------- 04:32:01 INFO - PROCESS | 2543 | Number of tests: 6 04:32:01 INFO - PROCESS | 2543 | 04:32:01 INFO - PROCESS | 2543 | [#0] dojo.html Cycles:165 Average:5834.06 Median:6112.47 stddev:689.81 (11.3%) stddev-sans-first:664.29 04:32:01 INFO - PROCESS | 2543 | Values: 3370.1 3371.2 3403.0 3426.0 3443.4 5698.3 5804.4 6060.4 6075.4 6076.5 5610.0 5750.8 5867.6 5894.4 6010.9 5235.6 5284.6 5285.8 5301.5 5317.5 5425.4 5455.9 5464.8 5486.4 5520.3 5103.1 5151.5 5177.3 5207.0 5381.5 4296.5 4436.0 5144.3 5210.1 5216.5 4311.5 5128.8 5152.0 5166.7 5200.4 5688.9 5688.9 5698.3 5702.1 5719.9 6192.5 6204.7 6209.6 6215.8 6216.7 4676.8 6247.4 6273.8 6295.0 6337.0 5933.4 5954.0 6037.5 6044.8 6061.6 6472.4 6524.0 6528.2 6530.0 6531.8 6144.6 6187.4 6234.7 6304.9 6328.5 6313.2 6315.6 6321.5 6335.6 6336.2 6286.5 6287.2 6299.9 6301.0 6304.4 6258.2 6284.3 6301.7 6307.7 6334.5 4963.0 5092.5 5095.2 5096.0 5138.3 4484.5 4484.7 4494.8 4595.3 4621.7 4954.1 5781.9 5817.6 5990.3 5997.0 6285.6 6364.1 6381.9 6382.2 6393.0 6009.9 6029.5 6029.7 6037.8 6053.3 5460.9 5500.5 5642.2 5644.0 5695.9 6386.8 6399.5 6402.1 6427.2 6442.3 6249.5 6275.2 6280.1 6281.6 6282.3 6494.4 6551.0 6558.7 6577.6 6585.0 6313.0 6319.2 6324.7 6338.1 6338.4 5735.3 6235.5 6297.7 6355.5 6360.8 6204.8 6209.8 6211.2 6214.4 6214.5 6144.4 6198.9 6201.3 6203.4 6225.8 6208.8 6222.2 6230.0 6237.0 6254.9 6112.5 6121.4 6184.2 6308.4 6313.4 6065.6 6069.5 6074.8 6080.4 6084.0 04:32:01 INFO - PROCESS | 2543 | 04:32:01 INFO - PROCESS | 2543 | [#1] ext.html Cycles:180 Average:53480.94 Median:34091.73 stddev:109799.49 (322.1%) stddev-sans-first:110035.96 04:32:01 INFO - PROCESS | 2543 | Values: 686.8 737.4 785.4 870.0 870.0 28879.6 37254.0 37678.1 37844.2 37929.8 37207.6 37571.0 39083.2 39087.4 39257.4 7160.8 7769.7 9072.0 9086.8 9110.7 7195.6 7278.4 7282.2 7289.4 10594.8 10799.8 10820.8 10825.5 10827.5 10851.7 10711.5 10741.1 10752.1 10753.2 10764.9 7055.4 7238.5 8903.3 10340.0 10437.9 36241.5 36729.6 38002.2 38085.6 38106.4 3703.7 3726.6 3761.7 3766.5 3792.7 26179.6 26670.1 26670.6 27025.7 27307.9 3109.8 3112.4 3150.7 3224.0 3258.4 333992.0 337347.6 337465.0 337470.0 337957.0 39341.0 40989.6 41054.8 45010.3 45292.0 53796.0 55416.0 55433.0 55486.0 58245.4 14407.7 14523.3 14708.9 14713.9 14722.9 11775.4 11838.2 11899.8 11936.8 11947.9 13290.4 13314.4 13341.1 13426.9 13493.7 5824.8 5828.3 5862.2 5864.5 5881.5 983.3 1006.8 1008.7 1024.5 1061.8 15123.1 15225.4 15507.5 15623.7 15681.9 1090.9 1095.8 1099.1 1127.5 1135.7 6751.3 6989.6 7788.6 8009.8 8018.3 473158.0 473554.0 473804.0 475894.0 476342.0 52871.0 53197.7 53231.7 53280.5 53289.0 1311.6 1398.2 1410.6 1411.8 1412.4 15009.3 15059.4 15260.4 15548.8 15594.7 43715.8 43797.0 43839.6 43876.1 43948.6 365619.0 425552.0 425596.9 427261.0 428167.0 27316.5 27732.4 27855.7 33270.3 33379.7 41159.2 41734.4 41776.6 42148.6 42361.0 32525.3 33951.7 34217.0 35004.8 35496.8 33723.3 34074.5 35099.5 35121.5 35167.5 33228.5 33756.8 34063.7 34090.3 34093.1 22744.3 27859.6 28431.4 28997.1 30054.8 19765.0 20091.7 23118.2 23192.8 23270.4 04:32:01 INFO - PROCESS | 2543 | 04:32:01 INFO - PROCESS | 2543 | [#2] jquery.html Cycles:180 Average:41229.80 Median:21791.28 stddev:113435.32 (520.6%) stddev-sans-first:113712.05 04:32:01 INFO - PROCESS | 2543 | Values: 373.0 388.5 398.8 412.1 426.1 13979.1 14315.8 22061.8 23291.8 23551.8 22285.9 22507.4 23323.7 23369.0 23415.0 5274.6 6674.7 6734.5 6905.0 6905.3 6761.5 6790.9 6816.4 6816.5 6820.1 6655.4 6697.6 6785.9 6846.7 6860.5 6730.6 6748.0 6757.2 6833.5 6833.5 5758.9 6402.6 6586.9 6604.4 6612.2 25851.9 26410.5 26547.5 26593.9 27205.9 3335.7 3348.8 3365.7 3415.5 3474.4 16546.1 16947.3 17044.0 17256.7 17555.3 2006.7 2036.1 2041.5 2062.2 2134.4 118188.0 135640.6 139771.0 140138.0 142907.1 15631.3 21533.6 22049.0 22918.9 23521.5 35264.8 35500.5 35580.8 37303.4 37309.6 10553.6 10579.3 10636.0 10799.1 10852.7 8607.3 8632.3 8648.5 8765.1 8846.6 8988.3 10606.3 10746.4 10757.2 10861.2 3481.0 4058.7 4073.3 4134.9 4148.3 1070.5 1076.8 1083.8 1094.2 1123.4 22807.1 23263.3 23508.8 23521.5 23615.5 949.6 1084.3 1097.9 1122.5 1124.8 10343.8 11849.9 12010.3 12044.0 12044.2 578383.2 673219.0 695223.0 712219.5 717406.0 159007.0 162100.0 162307.0 164466.0 165225.0 1311.2 1359.2 1389.8 1395.3 1399.9 19405.0 20102.0 20331.8 20510.7 20568.2 55143.7 62018.0 62755.7 63541.4 64151.4 88673.7 90608.0 91187.0 92071.0 92396.7 9522.2 12020.9 12089.8 12351.9 12383.0 10314.7 11389.7 13187.5 13595.5 13986.6 11583.7 11601.8 12011.9 12039.5 12081.0 11049.4 11614.7 11681.8 11749.9 12232.8 11703.8 11945.2 12039.6 12068.7 12218.3 11901.0 11921.4 12068.9 12278.1 12363.7 11563.6 11589.8 11980.6 11996.7 11997.2 04:32:01 INFO - PROCESS | 2543 | 04:32:01 INFO - PROCESS | 2543 | [#3] mootools.html Cycles:180 Average:6458.86 Median:2838.96 stddev:3990.63 (140.6%) stddev-sans-first:3984.40 04:32:01 INFO - PROCESS | 2543 | Values: 1494.8 1522.3 1542.8 1552.1 1567.7 10495.7 10992.2 11004.2 11012.4 11055.5 9151.9 10318.5 10813.2 10815.5 10822.1 2322.5 2358.8 2362.5 2362.6 2367.0 2302.6 2329.4 2338.2 2341.8 2345.3 2307.7 2325.2 2334.3 2337.6 2338.9 2272.7 2297.6 2300.3 2303.4 2308.1 2266.2 2332.1 2341.1 2343.2 2348.2 10696.8 10798.7 10802.2 10814.8 10820.8 5477.7 5652.4 5658.0 5664.7 5666.9 3311.0 3400.7 3612.2 3621.3 3645.2 1024.5 1064.3 1096.9 1142.8 1234.4 11999.9 13917.9 13926.5 14777.0 14947.6 4135.9 4245.0 4249.2 4251.4 4264.3 10027.2 10217.3 10230.5 10244.3 10301.0 5179.2 5208.8 5230.5 5236.2 5237.9 4397.5 4897.1 5157.4 5162.0 5238.6 3402.0 3475.3 3476.9 3485.8 3486.8 987.9 1011.1 1013.7 1016.9 1025.2 866.8 901.6 902.1 905.8 961.2 6377.7 6508.2 6612.5 6698.1 6749.6 969.4 980.7 998.8 1005.8 1006.2 3969.3 4079.6 4088.2 4092.8 4226.8 10276.5 11935.8 12274.7 12287.3 12289.8 11832.6 12124.4 13159.8 13168.3 13233.4 9687.2 9977.4 9978.7 10033.9 10048.5 5416.4 6416.5 6476.9 6640.7 6700.5 11776.4 12124.3 12126.6 12165.6 12169.0 11816.9 12154.9 12334.6 12350.6 12355.1 9621.7 10003.6 10018.7 10025.7 10028.5 9590.5 9817.6 9901.9 9927.0 9928.9 8754.3 8863.0 8946.6 9005.4 9077.0 8594.8 8641.0 8648.9 8726.4 8762.9 7663.3 7687.3 7768.3 7772.0 7772.6 4623.3 5344.7 5676.3 5864.3 6024.3 4987.4 5766.4 5906.9 5958.3 6044.8 04:32:01 INFO - PROCESS | 2543 | 04:32:01 INFO - PROCESS | 2543 | [#4] prototype.html Cycles:180 Average:4415.73 Median:4903.56 stddev:1230.95 (25.1%) stddev-sans-first:1195.85 04:32:01 INFO - PROCESS | 2543 | Values: 343.3 371.1 372.3 377.9 383.5 4617.0 4959.7 5017.7 5035.6 5053.7 3989.6 4703.2 4881.5 4884.3 4941.9 3413.7 4133.3 4135.9 4147.7 4163.5 4148.0 4153.8 4160.7 4167.4 4171.7 3452.8 4034.9 4162.4 4214.0 4246.8 3791.1 3881.7 3949.8 4097.6 4208.6 3791.9 3795.5 3802.9 3829.7 3845.2 4910.6 4919.7 4922.0 4928.6 4936.5 3965.5 3999.9 4308.4 4778.3 4797.8 4863.3 4939.0 4940.1 5316.8 5331.5 3524.2 3642.8 3951.9 4264.9 4283.5 4985.9 5058.5 5089.9 5313.5 5456.9 3739.6 4266.0 4283.8 4321.0 4357.7 4380.6 4405.6 4408.5 4425.0 4442.0 3757.7 3996.8 4112.4 4517.1 4754.6 4710.7 4999.0 5219.7 5303.9 5327.1 1368.2 1468.7 1471.7 1523.8 1549.4 906.6 966.0 1033.4 1044.0 1144.9 4659.9 5009.6 5015.8 5032.6 5048.5 5024.4 5410.0 5506.5 5543.7 5556.5 4618.6 4624.8 4985.7 5029.1 5059.1 2647.9 2691.7 2827.1 2838.4 2854.5 4739.5 5012.6 5454.6 5556.0 5756.8 5047.8 5102.8 5351.5 5402.0 5627.4 4928.6 5617.0 5660.0 5677.0 5684.5 4889.2 5190.7 5436.8 5480.2 5486.8 4926.5 5131.0 5265.8 5275.7 5382.6 5133.8 5372.6 5405.4 5491.9 5759.9 4075.5 4097.7 4338.8 4343.8 4390.3 4980.6 5127.7 5152.3 5500.2 5528.5 4714.2 5091.3 5275.8 5365.8 5375.0 4705.0 5234.1 5268.1 5301.2 5417.9 4755.6 4943.2 5005.9 5127.5 5310.8 4570.8 4937.0 5338.1 5382.5 5394.7 4455.4 4896.5 5215.7 5245.3 5268.3 04:32:01 INFO - PROCESS | 2543 | 04:32:01 INFO - PROCESS | 2543 | [#5] yui.html Cycles:180 Average:20467.13 Median:25044.06 stddev:28880.45 (115.3%) stddev-sans-first:28923.34 04:32:01 INFO - PROCESS | 2543 | Values: 703.3 722.3 723.0 761.2 815.5 15260.4 16132.4 16146.8 16158.4 16199.8 14647.2 14886.7 16267.6 17036.9 17321.3 953.9 967.1 969.2 970.5 970.8 938.8 968.5 969.4 971.2 973.3 1034.8 1039.3 1039.5 1041.9 1042.9 1030.7 1034.5 1034.7 1036.3 1038.4 754.9 760.1 761.2 761.9 764.2 15237.3 15651.5 15719.8 15729.0 16019.9 14482.2 14657.5 14685.6 14735.5 14749.6 9673.5 11512.8 11542.9 11785.0 12038.3 3587.0 3617.2 3882.4 3898.6 3909.0 105547.0 108665.5 108827.5 111324.0 111565.0 11024.5 11224.5 11463.9 11606.8 11830.0 24780.9 24949.0 24996.6 25008.4 25079.7 7611.7 7634.1 7715.7 7895.4 7992.3 4149.3 4236.5 4254.1 4445.6 4462.7 3341.2 3403.3 3408.5 3442.3 3445.1 622.2 628.1 628.1 636.2 637.9 654.4 658.4 663.9 690.7 735.1 9136.4 9474.3 9858.1 9968.5 10191.8 642.6 679.6 689.4 690.9 692.8 4713.4 4807.9 4813.8 4864.5 4868.9 82783.0 92284.6 100070.0 101210.0 104866.0 85662.0 86830.6 87848.6 90063.5 90835.0 62078.7 76854.0 77613.6 78519.0 79328.0 10301.8 10774.3 10845.8 10853.6 10964.5 46624.5 47068.6 48369.5 48846.0 50290.5 66658.7 66982.0 67301.7 67597.6 68145.0 12639.4 12659.3 12904.7 13042.7 13244.8 14304.5 14308.2 14432.7 14452.9 14620.5 13527.3 13636.4 13700.5 13747.9 14482.2 13585.4 13603.7 13746.7 13789.0 13790.5 13450.8 13631.0 13642.9 13820.2 14057.0 10899.6 11013.7 11206.3 11247.8 11370.7 9469.3 11175.8 11184.9 11237.6 11281.6 04:32:01 INFO - PROCESS | 2543 | -------- Summary: end -------- 04:32:01 INFO - PROCESS | 2543 | 04:32:01 INFO - TEST-INFO | 2543: exit 0 04:32:01 INFO - TEST-OK | dromaeo_css | took 1122668ms 04:32:01 INFO - TEST-START | kraken 04:32:01 INFO - operating with platform_type : mac_ 04:32:01 INFO - Initialising browser for kraken test... 04:32:01 INFO - TEST-INFO | started process 2547 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/tmplWkLlY/profile http://localhost:52635/getInfo.html) 04:32:04 INFO - PROCESS | 2547 | __metrics Screen width/height:1600/1200 04:32:04 INFO - PROCESS | 2547 | colorDepth:24 04:32:04 INFO - PROCESS | 2547 | Browser inner width/height: 1024/689 04:32:04 INFO - PROCESS | 2547 | __metrics 04:32:04 INFO - PROCESS | 2547 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 673: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 04:32:04 INFO - PROCESS | 2547 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:32:05 INFO - TEST-INFO | 2547: exit 0 04:32:05 INFO - Browser initialized. 04:32:05 INFO - Running cycle 1/1 for kraken test... 04:32:05 INFO - TEST-INFO | started process 2548 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/tmplWkLlY/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:32:17 INFO - PROCESS | 2548 | RSS: Main: 232693760 04:32:17 INFO - PROCESS | 2548 | 04:32:20 INFO - PROCESS | 2548 | Cycle 1(1): loaded http://localhost:52635/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:52635/tests/kraken/driver.html?testName=audio-beat-detection) 04:32:21 INFO - PROCESS | 2548 | RSS: Main: 284651520 04:32:21 INFO - PROCESS | 2548 | 04:32:23 INFO - PROCESS | 2548 | Cycle 1(1): loaded http://localhost:52635/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:52635/tests/kraken/driver.html?testName=audio-dft) 04:32:24 INFO - PROCESS | 2548 | RSS: Main: 286695424 04:32:24 INFO - PROCESS | 2548 | 04:32:27 INFO - PROCESS | 2548 | Cycle 1(1): loaded http://localhost:52635/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:52635/tests/kraken/driver.html?testName=audio-fft) 04:32:28 INFO - PROCESS | 2548 | RSS: Main: 378155008 04:32:28 INFO - PROCESS | 2548 | 04:32:30 INFO - PROCESS | 2548 | Cycle 1(1): loaded http://localhost:52635/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:52635/tests/kraken/driver.html?testName=audio-oscillator) 04:32:31 INFO - PROCESS | 2548 | RSS: Main: 280080384 04:32:31 INFO - PROCESS | 2548 | 04:32:33 INFO - PROCESS | 2548 | Cycle 1(1): loaded http://localhost:52635/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:52635/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:32:33 INFO - PROCESS | 2548 | RSS: Main: 283029504 04:32:33 INFO - PROCESS | 2548 | 04:32:37 INFO - PROCESS | 2548 | Cycle 1(1): loaded http://localhost:52635/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:52635/tests/kraken/driver.html?testName=imaging-darkroom) 04:32:37 INFO - PROCESS | 2548 | RSS: Main: 324591616 04:32:37 INFO - PROCESS | 2548 | 04:32:40 INFO - PROCESS | 2548 | Cycle 1(1): loaded http://localhost:52635/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:52635/tests/kraken/driver.html?testName=imaging-desaturate) 04:32:41 INFO - PROCESS | 2548 | RSS: Main: 328531968 04:32:41 INFO - PROCESS | 2548 | 04:32:44 INFO - PROCESS | 2548 | Cycle 1(1): loaded http://localhost:52635/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:52635/tests/kraken/driver.html?testName=json-parse-financial) 04:32:45 INFO - PROCESS | 2548 | RSS: Main: 326651904 04:32:45 INFO - PROCESS | 2548 | 04:32:46 INFO - PROCESS | 2548 | Cycle 1(1): loaded http://localhost:52635/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:52635/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:32:47 INFO - PROCESS | 2548 | RSS: Main: 302804992 04:32:47 INFO - PROCESS | 2548 | 04:32:49 INFO - PROCESS | 2548 | Cycle 1(1): loaded http://localhost:52635/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:52635/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:32:50 INFO - PROCESS | 2548 | RSS: Main: 308371456 04:32:50 INFO - PROCESS | 2548 | 04:32:52 INFO - PROCESS | 2548 | Cycle 1(1): loaded http://localhost:52635/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:52635/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:32:52 INFO - PROCESS | 2548 | RSS: Main: 309919744 04:32:52 INFO - PROCESS | 2548 | 04:32:55 INFO - PROCESS | 2548 | Cycle 1(1): loaded http://localhost:52635/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:52635/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:32:56 INFO - PROCESS | 2548 | RSS: Main: 323399680 04:32:56 INFO - PROCESS | 2548 | 04:32:59 INFO - PROCESS | 2548 | Cycle 1(1): loaded http://localhost:52635/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:52635/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:33:00 INFO - PROCESS | 2548 | RSS: Main: 318070784 04:33:00 INFO - PROCESS | 2548 | 04:33:02 INFO - PROCESS | 2548 | Cycle 1(1): loaded http://localhost:52635/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:52635/tests/kraken/driver.html?testName=ai-astar) 04:33:02 INFO - PROCESS | 2548 | RSS: Main: 362995712 04:33:02 INFO - PROCESS | 2548 | 04:33:02 INFO - PROCESS | 2548 | __start_tp_report 04:33:02 INFO - PROCESS | 2548 | _x_x_mozilla_page_load 04:33:02 INFO - PROCESS | 2548 | _x_x_mozilla_page_load_details 04:33:02 INFO - PROCESS | 2548 | |i|pagename|runs| 04:33:02 INFO - PROCESS | 2548 | |0;ai-astar;115;116;116;116;117;115;116;115;115;116 04:33:02 INFO - PROCESS | 2548 | |1;audio-beat-detection;167;111;110;151;113;111;111;109;133;112 04:33:02 INFO - PROCESS | 2548 | |2;audio-dft;188;185;187;184;185;186;189;182;188;188 04:33:02 INFO - PROCESS | 2548 | |3;audio-fft;87;76;82;115;67;61;62;60;79;61 04:33:02 INFO - PROCESS | 2548 | |4;audio-oscillator;93;71;91;71;69;69;85;69;68;84 04:33:02 INFO - PROCESS | 2548 | |5;imaging-gaussian-blur;92;91;90;90;90;90;91;91;91;91 04:33:02 INFO - PROCESS | 2548 | |6;imaging-darkroom;96;95;97;98;95;99;97;96;95;100 04:33:02 INFO - PROCESS | 2548 | |7;imaging-desaturate;84;86;84;83;84;87;84;88;103;85 04:33:02 INFO - PROCESS | 2548 | |8;json-parse-financial;64;62;64;63;65;64;64;64;63;63 04:33:02 INFO - PROCESS | 2548 | |9;json-stringify-tinderbox;60;67;69;61;60;59;59;59;58;60 04:33:02 INFO - PROCESS | 2548 | |10;stanford-crypto-aes;87;86;88;85;86;86;86;85;86;87 04:33:02 INFO - PROCESS | 2548 | |11;stanford-crypto-ccm;143;141;142;142;137;137;147;148;177;145 04:33:02 INFO - PROCESS | 2548 | |12;stanford-crypto-pbkdf2;173;174;172;169;171;170;171;169;171;171 04:33:02 INFO - PROCESS | 2548 | |13;stanford-crypto-sha256-iterative;66;67;69;65;65;66;66;65;66;67 04:33:02 INFO - PROCESS | 2548 | __end_tp_report 04:33:02 INFO - PROCESS | 2548 | __start_cc_report 04:33:02 INFO - PROCESS | 2548 | _x_x_mozilla_cycle_collect,2240 04:33:02 INFO - PROCESS | 2548 | __end_cc_report 04:33:02 INFO - PROCESS | 2548 | __startTimestamp1489062782319__endTimestamp 04:33:02 INFO - PROCESS | 2548 | 04:33:02 INFO - PROCESS | 2548 | ------- Summary: start ------- 04:33:02 INFO - PROCESS | 2548 | Number of tests: 14 04:33:02 INFO - PROCESS | 2548 | 04:33:02 INFO - PROCESS | 2548 | [#0] ai-astar Cycles:10 Average:115.70 Median:116.00 stddev:0.67 (0.6%) stddev-sans-first:0.67 04:33:02 INFO - PROCESS | 2548 | Values: 115.0 116.0 116.0 116.0 117.0 115.0 116.0 115.0 115.0 116.0 04:33:02 INFO - PROCESS | 2548 | 04:33:02 INFO - PROCESS | 2548 | [#1] audio-beat-detection Cycles:10 Average:122.80 Median:112.50 stddev:20.65 (18.4%) stddev-sans-first:14.43 04:33:02 INFO - PROCESS | 2548 | Values: 167.0 111.0 110.0 151.0 113.0 111.0 111.0 109.0 133.0 112.0 04:33:02 INFO - PROCESS | 2548 | 04:33:02 INFO - PROCESS | 2548 | [#2] audio-dft Cycles:10 Average:186.20 Median:187.50 stddev:2.20 (1.2%) stddev-sans-first:2.24 04:33:02 INFO - PROCESS | 2548 | Values: 188.0 185.0 187.0 184.0 185.0 186.0 189.0 182.0 188.0 188.0 04:33:02 INFO - PROCESS | 2548 | 04:33:02 INFO - PROCESS | 2548 | [#3] audio-fft Cycles:10 Average:75.00 Median:71.50 stddev:17.19 (24.0%) stddev-sans-first:17.68 04:33:02 INFO - PROCESS | 2548 | Values: 87.0 76.0 82.0 115.0 67.0 61.0 62.0 60.0 79.0 61.0 04:33:02 INFO - PROCESS | 2548 | 04:33:02 INFO - PROCESS | 2548 | [#4] audio-oscillator Cycles:10 Average:77.00 Median:77.50 stddev:10.06 (13.0%) stddev-sans-first:8.84 04:33:02 INFO - PROCESS | 2548 | Values: 93.0 71.0 91.0 71.0 69.0 69.0 85.0 69.0 68.0 84.0 04:33:02 INFO - PROCESS | 2548 | 04:33:02 INFO - PROCESS | 2548 | [#5] imaging-gaussian-blur Cycles:10 Average:90.70 Median:91.00 stddev:0.67 (0.7%) stddev-sans-first:0.53 04:33:02 INFO - PROCESS | 2548 | Values: 92.0 91.0 90.0 90.0 90.0 90.0 91.0 91.0 91.0 91.0 04:33:02 INFO - PROCESS | 2548 | 04:33:02 INFO - PROCESS | 2548 | [#6] imaging-darkroom Cycles:10 Average:96.80 Median:96.50 stddev:1.75 (1.8%) stddev-sans-first:1.83 04:33:02 INFO - PROCESS | 2548 | Values: 96.0 95.0 97.0 98.0 95.0 99.0 97.0 96.0 95.0 100.0 04:33:02 INFO - PROCESS | 2548 | 04:33:02 INFO - PROCESS | 2548 | [#7] imaging-desaturate Cycles:10 Average:86.80 Median:84.50 stddev:5.90 (7.0%) stddev-sans-first:6.17 04:33:02 INFO - PROCESS | 2548 | Values: 84.0 86.0 84.0 83.0 84.0 87.0 84.0 88.0 103.0 85.0 04:33:02 INFO - PROCESS | 2548 | 04:33:02 INFO - PROCESS | 2548 | [#8] json-parse-financial Cycles:10 Average:63.60 Median:64.00 stddev:0.84 (1.3%) stddev-sans-first:0.88 04:33:02 INFO - PROCESS | 2548 | Values: 64.0 62.0 64.0 63.0 65.0 64.0 64.0 64.0 63.0 63.0 04:33:02 INFO - PROCESS | 2548 | 04:33:02 INFO - PROCESS | 2548 | [#9] json-stringify-tinderbox Cycles:10 Average:61.20 Median:60.00 stddev:3.71 (6.2%) stddev-sans-first:3.91 04:33:02 INFO - PROCESS | 2548 | Values: 60.0 67.0 69.0 61.0 60.0 59.0 59.0 59.0 58.0 60.0 04:33:02 INFO - PROCESS | 2548 | 04:33:02 INFO - PROCESS | 2548 | [#10] stanford-crypto-aes Cycles:10 Average:86.20 Median:86.00 stddev:0.92 (1.1%) stddev-sans-first:0.93 04:33:02 INFO - PROCESS | 2548 | Values: 87.0 86.0 88.0 85.0 86.0 86.0 86.0 85.0 86.0 87.0 04:33:02 INFO - PROCESS | 2548 | 04:33:02 INFO - PROCESS | 2548 | [#11] stanford-crypto-ccm Cycles:10 Average:145.90 Median:144.00 stddev:11.52 (8.0%) stddev-sans-first:12.17 04:33:02 INFO - PROCESS | 2548 | Values: 143.0 141.0 142.0 142.0 137.0 137.0 147.0 148.0 177.0 145.0 04:33:02 INFO - PROCESS | 2548 | 04:33:02 INFO - PROCESS | 2548 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:171.10 Median:171.00 stddev:1.60 (0.9%) stddev-sans-first:1.54 04:33:02 INFO - PROCESS | 2548 | Values: 173.0 174.0 172.0 169.0 171.0 170.0 171.0 169.0 171.0 171.0 04:33:02 INFO - PROCESS | 2548 | 04:33:02 INFO - PROCESS | 2548 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.20 Median:66.00 stddev:1.23 (1.9%) stddev-sans-first:1.30 04:33:02 INFO - PROCESS | 2548 | Values: 66.0 67.0 69.0 65.0 65.0 66.0 66.0 65.0 66.0 67.0 04:33:02 INFO - PROCESS | 2548 | -------- Summary: end -------- 04:33:02 INFO - PROCESS | 2548 | 04:33:03 INFO - TEST-INFO | 2548: exit 0 04:33:03 INFO - TEST-OK | kraken | took 61593ms 04:33:03 INFO - SUITE-END | took 1184s 04:33:03 INFO - Completed test suite (00:19:44) 04:33:03 INFO - javascript benchmark 04:33:03 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7546.1108236677155, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3370.090075679567, 3371.15394143586, 3403.0471467988964, 3426.0407086015925, 3443.431833747432, 5698.34469036061, 5804.390538993408, 6060.393960603943, 6075.392460753922, 6076.453119219269, 5610.0, 5750.769969201227, 5867.618604790686, 5894.351621321651, 6010.939890601104, 5235.58115350771, 5284.630075894689, 5285.814996475124, 5301.496357846017, 5317.521423071923, 5425.403205647375, 5455.890882182354, 5464.808731694391, 5486.396496385394, 5520.309961254843, 5103.132467480537, 5151.45909679482, 5177.326947496839, 5207.0, 5381.488758567949, 4296.52738198801, 4435.957549975753, 5144.305518754958, 5210.088234558975, 5216.5305122538775, 4311.482622085338, 5128.820491282787, 5152.0, 5166.664166829144, 5200.401953775327, 5688.857778555528, 5688.943110568883, 5698.34469036062, 5702.087665973424, 5719.885602287973, 6192.473639740628, 6204.720787564571, 6209.627422354673, 6215.813525594194, 6216.689165541705, 4676.766161691936, 6247.437730604267, 6273.780417685405, 6295.0, 6337.0, 5933.436323549256, 5953.970230148865, 6037.547183961176, 6044.788432404933, 6061.575689701678, 6472.449841763409, 6524.0, 6528.183977002875, 6529.967350163219, 6531.836704082436, 6144.586745048664, 6187.443130118221, 6234.719437625317, 6304.905426418607, 6328.525360597973, 6313.210848643919, 6315.55791094619, 6321.494280457552, 6335.556511044275, 6336.239651241881, 6286.528510361742, 6287.151234583364, 6299.905501417483, 6300.9684951574945, 6304.3695630437505, 6258.15514905491, 6284.340144284875, 6301.684915754194, 6307.747690092345, 6334.461570766536, 4963.0, 5092.516210959953, 5095.184770436712, 5096.0, 5138.254953031864, 4484.461864576272, 4484.663650226246, 4494.820207191741, 4595.333676616872, 4621.653375996813, 4954.083494553519, 5781.855453613609, 5817.621854579439, 5990.311114221833, 5997.010493268649, 6285.622862628257, 6364.109024736541, 6381.936180638227, 6382.170317858649, 6393.0, 6009.939900601025, 6029.487493563096, 6029.6683682397015, 6037.849053773603, 6053.303870054912, 5460.863478413072, 5500.477454641723, 5642.181883626933, 5643.971780141073, 5695.914561281584, 6386.808395748135, 6399.488040956805, 6402.071699603438, 6427.164468619049, 6442.291347951628, 6249.50003999688, 6275.246970363585, 6280.1207830902795, 6281.623102613858, 6282.340354262919, 6494.383033611988, 6551.0173473979285, 6558.704858281293, 6577.6053436793945, 6585.012248162814, 6312.9899216125195, 6319.210098737658, 6324.747010119544, 6338.080978258219, 6338.366163383625, 5735.311762588516, 6235.469985051322, 6297.653629050446, 6355.459785918249, 6360.840978975378, 6204.844878878064, 6209.782657606962, 6211.223597050369, 6214.4407003369915, 6214.471769899609, 6144.41628045335, 6198.907016394848, 6201.348858369806, 6203.4416902479, 6225.8132256032395, 6208.81373558794, 6222.160008398808, 6230.034344676583, 6236.968815155895, 6254.874902502015, 6112.473085128157, 6121.3572574879, 6184.165137706352, 6308.369163083655, 6313.3686631336495, 6065.636061836304, 6069.453749162597, 6074.787382441594, 6080.422359875804, 6083.965725826709], "value": 5788.970594529913, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [686.8317262270743, 737.3732327521604, 785.4423359414815, 869.991300086999, 869.991300086999, 28879.566806497918, 37254.0, 37678.0580485488, 37844.24311513768, 37929.810350948275, 37207.62792372082, 37571.0, 39083.21833563327, 39087.41368879469, 39257.41113883294, 7160.785176444715, 7769.689212431496, 9072.00207977122, 9086.818263634723, 9110.681126160585, 7195.640217989106, 7278.417726581887, 7282.198958114604, 7289.38040266578, 10594.841077383846, 10799.814054853838, 10820.783584328308, 10825.458727063655, 10827.512761925733, 10851.728706782354, 10711.517981690804, 10741.140708743282, 10752.086072683831, 10753.193510486666, 10764.946175269151, 7055.3650171484815, 7238.52949558277, 8903.33225008127, 10340.017698318648, 10437.895621043768, 36241.45637815435, 36729.63270367289, 38002.23995520102, 38085.619143808486, 38106.42840357397, 3703.6852017444508, 3726.5900750917376, 3761.6990640748672, 3766.4915236443003, 3792.6586607205486, 26179.607305890426, 26670.066547670933, 26670.5999410009, 27025.729742702715, 27307.86346068277, 3109.8445077746023, 3112.447792809897, 3150.6534281229046, 3223.9677603224136, 3258.446064169097, 333992.0, 337347.62652373407, 337465.0, 337470.0, 337957.0, 39341.0, 40989.590104099174, 41054.76835694934, 45010.32484512735, 45292.0, 53796.0, 55416.0, 55433.0, 55486.0, 58245.41754582485, 14407.711845763026, 14523.346449409803, 14708.92645536787, 14713.92643036778, 14722.852771472148, 11775.411229438665, 11838.171328006956, 11899.821502677467, 11936.761264774656, 11947.880521194851, 13290.401931912893, 13314.40085196149, 13341.066125371324, 13426.932865335611, 13493.662658433617, 5824.796132135355, 5828.271466066742, 5862.237909071879, 5864.501517371071, 5881.470667639933, 983.331334692416, 1006.7634105985088, 1008.742770593494, 1024.51335615582, 1061.7982583309147, 15123.092614443169, 15225.390984360723, 15507.457238996582, 15623.687526249638, 15681.921590391976, 1090.8800031996475, 1095.780843831237, 1099.0987390339844, 1127.4531852051748, 1135.7217481716866, 6751.291114432914, 6989.580625162404, 7788.649510772028, 8009.839803203903, 8018.278354948083, 473158.0, 473554.0, 473804.0, 475894.0, 476342.0, 52871.0, 53197.734011329696, 53231.73384133055, 53280.467195327554, 53289.0, 1311.5737385349798, 1398.2030242761732, 1410.5556749623836, 1411.8094057302337, 1412.4209074279702, 15009.324580394126, 15059.397624095353, 15260.389584416498, 15548.84451155474, 15594.688106238038, 43715.78142109396, 43797.0, 43839.56160438482, 43876.12247755091, 43948.56051439573, 365619.0, 425552.0, 425596.8720156379, 427261.0, 428167.0, 27316.453670926072, 27732.44535109327, 27855.72144278612, 33270.33459330751, 33379.666203337656, 41159.1768164629, 41734.373984389655, 41776.58223417727, 42148.57851421447, 42361.0, 32525.349493009533, 33951.66048339485, 34217.0, 35004.82497587496, 35496.82251588725, 33723.3255334887, 34074.48888266629, 35099.47350789689, 35121.47317790184, 35167.47248791321, 33228.50157247595, 33756.83121584376, 34063.65936340605, 34090.318193636485, 34093.14767130841, 22744.31767046991, 27859.582106268826, 28431.436271005292, 28997.13008609745, 30054.84972575123, 19765.0, 20091.68825991582, 23118.1908633197, 23192.76807231906, 23270.41823954347], "value": 17302.059822558556, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [373.0357027084985, 388.5104767992329, 398.8324903540513, 412.1221797571174, 426.0647877907993, 13979.063338888493, 14315.78526322106, 22061.779382206194, 23291.76708232917, 23551.76448235517, 22285.888570557167, 22507.437314067156, 23323.650145247793, 23369.0, 23415.0, 5274.630775845692, 6674.733010679567, 6734.480520445714, 6904.9654751726175, 6905.309469053104, 6761.4590832733265, 6790.898136527956, 6816.352446517573, 6816.454683625323, 6820.147481564804, 6655.401013908747, 6697.631630260334, 6785.898211526806, 6846.691898864538, 6860.5197636165485, 6730.596164230113, 6748.021536877125, 6757.1891373035305, 6833.487488438363, 6833.521653484283, 5758.913616295759, 6402.583832050902, 6586.901196482057, 6604.438622717074, 6612.173478315211, 25851.870740646176, 26410.471790564083, 26547.46905061907, 26593.867030664722, 27205.863970680217, 3335.7331413486863, 3348.7823291485975, 3365.6970872621337, 3415.470602056685, 3474.4267195912644, 16546.10583554112, 16947.322107115702, 17044.0, 17256.74114888278, 17555.29778808846, 2006.7090271910638, 2036.1091227232882, 2041.4896275931017, 2062.1957436599737, 2134.3810295014428, 118188.0, 135640.64359356478, 139771.0, 140138.0, 142907.14185716226, 15631.296591653403, 21533.56932861334, 22049.0, 22918.885405572866, 23521.529569408514, 35264.82367588145, 35500.46749298763, 35580.822095889875, 37303.440448393296, 37309.62690373061, 10553.577856885791, 10579.312344697724, 10636.042756151983, 10799.082078023455, 10852.689929571556, 8607.26838218746, 8632.266257368068, 8648.481091134552, 8765.123487651312, 8846.601902914384, 8988.280937525113, 10606.310589811792, 10746.408947507962, 10757.246992710436, 10861.230386251455, 3481.014238696678, 4058.73618214821, 4073.307537718595, 4134.937975930364, 4148.2947898857265, 1070.5022164693455, 1076.7577295108538, 1083.8428427877914, 1094.1574987259764, 1123.4045955643521, 22807.087716491485, 23263.302100937, 23508.764912351, 23521.52956940886, 23615.527689446113, 949.6059135458845, 1084.2681190196586, 1097.912167026652, 1122.4948773052158, 1124.7637996020928, 10343.793124137475, 11849.940750296366, 12010.279383237033, 12044.006948465569, 12044.156909016285, 578383.2161678413, 673219.0, 695223.0, 712219.4613457811, 717406.0, 159007.0, 162100.0, 162307.0, 164466.0, 165225.0, 1311.167408695466, 1359.2456186816214, 1389.8471168171493, 1395.3302414840932, 1399.8880089592808, 19405.0, 20102.0, 20331.79668203299, 20510.69233961462, 20568.177272909514, 55143.72428137834, 62018.0, 62755.686221570424, 63541.3645863554, 64151.35848641454, 88673.66989495292, 90608.0, 91187.0, 92071.0, 92396.70160893691, 9522.238220942447, 12020.879791202326, 12089.758204835678, 12351.93824030874, 12383.0, 10314.742131446774, 11389.715257118638, 13187.483439404592, 13595.45618175262, 13986.580402587939, 11583.710407239549, 11601.82597261025, 12011.939940300592, 12039.458224379749, 12081.0, 11049.39228342449, 11614.70963225926, 11681.824772628588, 11749.942505174575, 12232.816507752214, 11703.76592468163, 11945.223560468541, 12039.638810835339, 12068.698282542655, 12218.327991960172, 11901.047916166513, 11921.403929803302, 12068.939655301667, 12278.14053016316, 12363.69090772738, 11563.5952741657, 11589.768204636028, 11980.58067967617, 11996.700082498008, 11997.160198786001], "value": 11915.476340045816, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1494.7533656946605, 1522.3225664579268, 1542.8071491063617, 1552.107538165555, 1567.6864627074585, 10495.73760655984, 10992.230543861933, 11004.229703920728, 11012.449377531131, 11055.502502387402, 9151.862722059175, 10318.484075796217, 10813.243072984895, 10815.459227038637, 10822.080123189538, 2322.465832858448, 2358.811295096388, 2362.5274945011065, 2362.61016932206, 2366.976330236693, 2302.643090321003, 2329.4292898239955, 2338.240071976606, 2341.800946919514, 2345.26124270855, 2307.7230732312064, 2325.162941341116, 2334.311378143443, 2337.6026075567192, 2338.8890277118403, 2272.670462782887, 2297.6094064009158, 2300.2869110575775, 2303.424143964009, 2308.134449581407, 2266.2294819761196, 2332.055517515409, 2341.07527526626, 2343.1915988983774, 2348.2016114520975, 10696.78606427867, 10798.67603971882, 10802.243842930999, 10814.837777433344, 10820.783584328348, 5477.67133971963, 5652.378238393773, 5658.0, 5664.745086471119, 5666.886662266773, 3310.9503357449657, 3400.659934006604, 3612.1692010837655, 3621.3119507293795, 3645.198056427608, 1024.497995981971, 1064.3401091323428, 1096.8738595061511, 1142.8114361130486, 1234.388977456156, 11999.880001199963, 13917.86082139186, 13926.51257205993, 14777.0, 14947.626309342244, 4135.855245066408, 4244.957550424518, 4249.171411574714, 4251.404803327537, 4264.253755592821, 10027.247956403298, 10217.284790064625, 10230.539625716861, 10244.334118282288, 10301.04280186777, 5179.171332586768, 5208.7916483341, 5230.476952304815, 5236.162214045735, 5237.895242095136, 4397.516273209944, 4897.1185186666025, 5157.381114266237, 5161.974190129025, 5238.633295669267, 3401.965980340165, 3475.2528206435736, 3476.8783092592143, 3485.790852548855, 3486.8430920608635, 987.9407235565745, 1011.0849681038671, 1013.690824298596, 1016.9491525423699, 1025.179856115105, 866.8006358537572, 901.6032945503957, 902.0631344957258, 905.8278927003848, 961.2022021721954, 6377.7448902044325, 6508.21901371829, 6612.537122401386, 6698.129243198353, 6749.628770417576, 969.3941286695815, 980.7401038724744, 998.7602975285879, 1005.7707340632622, 1006.1699098243978, 3969.325214713506, 4079.5920407958965, 4088.2436749201493, 4092.815823287959, 4226.809793559236, 10276.486175691334, 11935.820962685566, 12274.693132671755, 12287.324197169242, 12289.754204915851, 11832.585859494877, 12124.39378031095, 13159.802602960963, 13168.341582920815, 13233.404496797668, 9687.225021998223, 9977.351472154432, 9978.700638980843, 10033.949830250802, 10048.538108163546, 5416.417016177384, 6416.518761092843, 6476.902846457213, 6640.701168447528, 6700.4639628830555, 11776.352300623548, 12124.27254364741, 12126.636200913987, 12165.635030949086, 12169.02647788157, 11816.881831181921, 12154.878451215729, 12334.568290109803, 12350.62948111558, 12355.135140540076, 9621.663241786504, 10003.649872254437, 10018.749531261778, 10025.699229023141, 10028.498575071071, 9590.472524011246, 9817.607295708378, 9901.851472228067, 9927.0, 9928.851067234142, 8754.25588824957, 8863.0, 8946.597403117006, 9005.369624126248, 9077.046910074347, 8594.78513037179, 8641.049484556568, 8648.913510864812, 8726.389152759246, 8762.868556971524, 7663.31030207284, 7687.346575541142, 7768.300852923264, 7772.0, 7772.611369431619, 4623.306504024423, 5344.732763361739, 5676.318841739017, 5864.296284445893, 6024.33732289439, 4987.376577927759, 5766.389337881697, 5906.852328691817, 5958.255218097738, 6044.848878778066], "value": 4943.20220724803, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [343.3082339086739, 371.1111887030562, 372.2629194195493, 377.85263747138623, 383.5110234451075, 4616.976915115428, 4959.68568329393, 5017.749112544368, 5035.571976382007, 5053.696778193306, 3989.5611482736876, 4703.247480403128, 4881.5118488151165, 4884.3149113555855, 4941.851744447663, 3413.6857309935604, 4133.297339452285, 4135.937960930573, 4147.668186545069, 4163.542010378871, 4148.045949431633, 4153.8161623937185, 4160.667146628262, 4167.437395951553, 4171.707980441355, 3452.8446219920165, 4034.899127521821, 4162.41726158338, 4213.988642725754, 4246.80889359978, 3791.0901383667997, 3881.68946484282, 3949.7755695734413, 4097.631213190827, 4208.600182982627, 3791.905202369935, 3795.544534655859, 3802.9351781501223, 3829.6744776693736, 3845.1540661054523, 4910.582600478963, 4919.704817710949, 4922.0402021605805, 4928.556429921288, 4936.481669424695, 3965.524137103537, 3999.900002499961, 4308.375285583604, 4778.307145463923, 4797.7601119943865, 4863.294822250789, 4938.9753051234875, 4940.060663904971, 5316.840494785162, 5331.493508116722, 3524.1674329348593, 3642.817859107034, 3951.881443556698, 4264.893377665552, 4283.464566929134, 4985.925211121836, 5058.519440653169, 5089.898202035939, 5313.495217954288, 5456.945430545684, 3739.6447337502896, 4265.957340426618, 4283.800535849905, 4320.978395108004, 4357.651387888961, 4380.5838445347645, 4405.625521830616, 4408.501109622744, 4424.977875110604, 4442.0, 3757.7369584129397, 3996.760194388346, 4112.362583799516, 4517.10905020787, 4754.572088512051, 4710.6938049027385, 4999.000199960023, 5219.6689844089515, 5303.946960530346, 5327.0556246970355, 1368.1927662679068, 1468.6842328899338, 1471.6762312291278, 1523.8323784383708, 1549.4499452694356, 906.5920335848895, 965.99034009659, 1033.4419413516766, 1044.0, 1144.9391096027118, 4659.92633278188, 5009.5741861941415, 5015.774290156952, 5032.622553308516, 5048.5203905628905, 5024.447310795809, 5410.024486532391, 5506.531944784738, 5543.722813859291, 5556.527695145877, 4618.630509559294, 4624.838130665411, 4985.675931064542, 5029.094762942632, 5059.139946209153, 2647.880845361963, 2691.730826917332, 2827.052937266039, 2838.361368692069, 2854.5004624190683, 4739.478657347689, 5012.624053195952, 5454.59090568209, 5555.999920014437, 5756.798512052058, 5047.848564543069, 5102.821401250939, 5351.518363347317, 5401.9736250112355, 5627.352854421712, 4928.581070608967, 5617.045102332613, 5660.0, 5676.999999999917, 5684.488396044376, 4889.154947546144, 5190.740462976912, 5436.7553460093595, 5480.205370221216, 5486.7902277168305, 4926.48271931442, 5131.0, 5265.761556642714, 5275.736213189249, 5382.569394448513, 5133.845984620468, 5372.5970552207955, 5405.378381486179, 5491.945080549143, 5759.9136012959, 4075.5313138989395, 4097.684808083423, 4338.826446942213, 4343.761093139908, 4390.3414487827085, 4980.601551875914, 5127.692338459704, 5152.320793187597, 5500.1749737539685, 5528.474794894479, 4714.245720684674, 5091.261767043832, 5275.8129420879995, 5365.812196573102, 5375.0, 4704.976475117603, 5234.0633965433035, 5268.130758424817, 5301.231321458444, 5417.918731219113, 4755.5984227964655, 4943.233798761198, 5005.874853128701, 5127.513290962182, 5310.787568497217, 4570.840020599263, 4937.013107070171, 5338.145896656516, 5382.4886635769535, 5394.703291319015, 4455.443069616298, 4896.534829191221, 5215.6609820361555, 5245.272458321728, 5268.341457317835], "value": 4052.6068419311177, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [703.3458883238586, 722.2668990974162, 722.9566226026438, 761.2425636491688, 815.4984684419084, 15260.389584416624, 16132.354705811782, 16146.757798633, 16158.353665853367, 16199.75700364494, 14647.194404307758, 14886.702265954675, 16267.593310167253, 17036.91481542594, 17321.30714771411, 953.9379940303876, 967.1247520993477, 969.1713584884927, 970.5486948568949, 970.7912798748267, 938.755923459902, 968.467342961372, 969.4328817641688, 971.2133172130597, 973.3089506450393, 1034.8395998620188, 1039.3088596083633, 1039.5477967084305, 1041.9062284394404, 1042.9009244121796, 1030.7423144213947, 1034.493098381795, 1034.7102811212872, 1036.29014125324, 1038.4340534408766, 754.935830454412, 760.1068744225513, 761.1931352766086, 761.8819083042138, 764.1861417590248, 15237.314320855477, 15651.452199173089, 15719.764203536955, 15728.977616455008, 16019.91990040054, 14482.203478808662, 14657.486987955477, 14685.632859178499, 14735.484258051023, 14749.573022997154, 9673.516324183833, 11512.76974460506, 11542.884571154265, 11785.0, 12038.27770333774, 3586.9956412204624, 3617.1861331200535, 3882.398228274622, 3898.629630185156, 3908.9804550977346, 105546.99999999923, 108665.45667271691, 108827.45586272098, 111324.0, 111565.0, 11024.50389732464, 11224.494897729623, 11463.885361146282, 11606.76786464266, 11830.0, 24780.876095619406, 24949.0, 24996.625050624254, 25008.37479063038, 25079.74920250774, 7611.695532178762, 7634.083909930844, 7715.691372345043, 7895.368370530344, 7992.280694737501, 4149.336106223051, 4236.512801027921, 4254.106637606075, 4445.644348452116, 4462.665300102505, 3341.2315167511124, 3403.2512847173584, 3408.471686888536, 3442.3115376924216, 3445.13871532117, 622.1662971618053, 628.0924064726427, 628.0924064726518, 636.1761518833122, 637.8947473666885, 654.3619970528697, 658.404144249455, 663.8970959501285, 690.7202582953912, 735.1141874041767, 9136.406133601295, 9474.336796424323, 9858.063483969012, 9968.507873031742, 10191.776986761488, 642.6240649220165, 679.6499802601664, 689.4312192441256, 690.9463068820089, 692.7713854428026, 4713.410823647044, 4807.879803004953, 4813.772488015534, 4864.537868902448, 4868.925065836674, 82783.0, 92284.6157307641, 100070.0, 101210.0, 104866.0, 85662.0, 86830.56584717036, 87848.56075719581, 90063.54968225247, 90835.0, 62078.68960655168, 76854.0, 77613.61193193997, 78519.0, 79328.0, 10301.845472318071, 10774.299670521392, 10845.837312440162, 10853.565857365616, 10964.451777410937, 46624.53375466202, 47068.58794236178, 48369.51630483791, 48846.0, 50290.49709503005, 66658.66682666416, 66982.0, 67301.66349168222, 67597.6480470378, 68144.97782533366, 12639.3680315982, 12659.303738294113, 12904.677383065498, 13042.673933151367, 13244.80132798028, 14304.499342522962, 14308.230652563847, 14432.681827004895, 14452.855471445571, 14620.488282910048, 13527.256000920044, 13636.386362613905, 13700.45198192061, 13747.931260343634, 14482.203478808766, 13585.388657510239, 13603.659908502366, 13746.65633359174, 13789.0, 13790.517331893336, 13450.798238026242, 13631.0, 13642.917516034484, 13820.170789752647, 14057.0, 10899.618513351994, 11013.669589912315, 11206.327620342805, 11247.831282530606, 11370.658880233606, 9469.289803264921, 11175.832362514731, 11184.94407527957, 11237.550497980315, 11281.605143819927], "value": 7722.237551446159, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1445.2, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 116.0, 116.0, 116.0, 117.0, 115.0, 116.0, 115.0, 115.0, 116.0], "value": 115.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 111.0, 110.0, 151.0, 113.0, 111.0, 111.0, 109.0, 133.0, 112.0], "value": 122.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [188.0, 185.0, 187.0, 184.0, 185.0, 186.0, 189.0, 182.0, 188.0, 188.0], "value": 186.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 76.0, 82.0, 115.0, 67.0, 61.0, 62.0, 60.0, 79.0, 61.0], "value": 75.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 71.0, 91.0, 71.0, 69.0, 69.0, 85.0, 69.0, 68.0, 84.0], "value": 77.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 91.0, 90.0, 90.0, 90.0, 90.0, 91.0, 91.0, 91.0, 91.0], "value": 90.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 97.0, 98.0, 95.0, 99.0, 97.0, 96.0, 95.0, 100.0], "value": 96.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 86.0, 84.0, 83.0, 84.0, 87.0, 84.0, 88.0, 103.0, 85.0], "value": 86.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 62.0, 64.0, 63.0, 65.0, 64.0, 64.0, 64.0, 63.0, 63.0], "value": 63.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 67.0, 69.0, 61.0, 60.0, 59.0, 59.0, 59.0, 58.0, 60.0], "value": 61.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 86.0, 88.0, 85.0, 86.0, 86.0, 86.0, 85.0, 86.0, 87.0], "value": 86.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 141.0, 142.0, 142.0, 137.0, 137.0, 147.0, 148.0, 177.0, 145.0], "value": 145.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [173.0, 174.0, 172.0, 169.0, 171.0, 170.0, 171.0, 169.0, 171.0, 171.0], "value": 171.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 67.0, 69.0, 65.0, 65.0, 66.0, 66.0, 65.0, 66.0, 67.0], "value": 66.2, "unit": "score"}]}]} 04:33:03 INFO - Return code: 0 04:33:03 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 04:33:03 ERROR - # TBPL SUCCESS # 04:33:03 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:33:03 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:33:03 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:33:03 INFO - 2017-03-09 04:33:03.665 screenresolution[2552:23763] starting screenresolution argv=screenresolution get 04:33:03 INFO - 2017-03-09 04:33:03.668 screenresolution[2552:23763] Display 0: 1600x1200x32@60 04:33:03 INFO - 2017-03-09 04:33:03.675 screenresolution[2553:23766] starting screenresolution argv=screenresolution list 04:33:03 INFO - Available Modes on Display 0 04:33:03 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:33:03 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:33:03 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:33:03 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:33:03 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:33:03 INFO - Intel Iris: 04:33:03 INFO - Chipset Model: Intel Iris 04:33:03 INFO - Type: GPU 04:33:03 INFO - Bus: Built-In 04:33:03 INFO - VRAM (Dynamic, Max): 1536 MB 04:33:03 INFO - Vendor: Intel (0x8086) 04:33:03 INFO - Device ID: 0x0a2e 04:33:03 INFO - Revision ID: 0x0009 04:33:03 INFO - Displays: 04:33:03 INFO - Display: 04:33:03 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:33:03 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:33:03 INFO - Display Serial Number: 1600x1200 60 04:33:03 INFO - Main Display: Yes 04:33:03 INFO - Mirror: Off 04:33:03 INFO - Online: Yes 04:33:03 INFO - Rotation: Supported 04:33:03 INFO - Return code: 0 04:33:03 INFO - Running post-action listener: _resource_record_post_action 04:33:03 INFO - [mozharness: 2017-03-09 12:33:03.917396Z] Finished run-tests step (success) 04:33:03 INFO - Running post-run listener: _resource_record_post_run 04:33:03 INFO - Total resource usage - Wall time: 1206s; CPU: 54.0%; Read bytes: 274432; Write bytes: 511191040; Read time: 3; Write time: 1839 04:33:03 INFO - TinderboxPrint: CPU usage
54.1% 04:33:03 INFO - TinderboxPrint: I/O read bytes / time
274,432 / 3 04:33:03 INFO - TinderboxPrint: I/O write bytes / time
511,191,040 / 1,839 04:33:03 INFO - TinderboxPrint: CPU idle
2,212.1 (45.9%) 04:33:03 INFO - TinderboxPrint: CPU system
966.1 (20.0%) 04:33:03 INFO - TinderboxPrint: CPU user
1,643.6 (34.1%) 04:33:03 INFO - TinderboxPrint: Swap in / out
209,526,784 / 0 04:33:03 INFO - install - Wall time: 21s; CPU: 54.0%; Read bytes: 203069952; Write bytes: 203257344; Read time: 15754; Write time: 433 04:33:03 INFO - run-tests - Wall time: 1185s; CPU: 54.0%; Read bytes: 274432; Write bytes: 298025472; Read time: 3; Write time: 1351 04:33:04 INFO - Running post-run listener: _upload_blobber_files 04:33:04 INFO - Blob upload gear active. 04:33:04 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:33:04 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 04:33:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 04:33:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 04:33:04 INFO - (blobuploader) - INFO - Open directory for files ... 04:33:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 04:33:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:33:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:33:05 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 04:33:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:33:05 INFO - (blobuploader) - INFO - Done attempting. 04:33:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 04:33:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:33:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:33:06 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 04:33:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:33:06 INFO - (blobuploader) - INFO - Done attempting. 04:33:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 04:33:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:33:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:33:07 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 04:33:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:33:07 INFO - (blobuploader) - INFO - Done attempting. 04:33:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 04:33:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:33:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:33:09 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 04:33:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:33:09 INFO - (blobuploader) - INFO - Done attempting. 04:33:09 INFO - (blobuploader) - INFO - Iteration through files over. 04:33:09 INFO - Return code: 0 04:33:09 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:33:09 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:33:09 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3e8d5339bff24ffc88f2a02db08f78d00a3b4b6742dabae32c67b52806986c32f1a678ede66d6c0e11bcebc9368d00a6430fce24c7a58e0331659310647ce7dd", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f64da53c4ba2fe1f141a19628e22a3f47eaff7aac432979cfe147ea57dd3aebde18f93269173a52573ff94404eef47e78a6ee631b0afc805e51c99c5873d7ab4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b8a17d7872376980d7301ede5bfd162b3bf7fd161dce5921ba586f7de29e53dc32e3d35788d6f16fac3d6a892f7dfd688fade9d2f32d6c3aa72ac6d61ed34798", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/46dfa57abb60420e716ed1369acda62a77bf5fb301f3bb309bd93510b1185220886d56819c79da10aa2835bd554967bf9142541a632e2c8f07a7805570f80f9a"} 04:33:09 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:33:09 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:33:09 INFO - Contents: 04:33:09 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3e8d5339bff24ffc88f2a02db08f78d00a3b4b6742dabae32c67b52806986c32f1a678ede66d6c0e11bcebc9368d00a6430fce24c7a58e0331659310647ce7dd", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f64da53c4ba2fe1f141a19628e22a3f47eaff7aac432979cfe147ea57dd3aebde18f93269173a52573ff94404eef47e78a6ee631b0afc805e51c99c5873d7ab4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b8a17d7872376980d7301ede5bfd162b3bf7fd161dce5921ba586f7de29e53dc32e3d35788d6f16fac3d6a892f7dfd688fade9d2f32d6c3aa72ac6d61ed34798", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/46dfa57abb60420e716ed1369acda62a77bf5fb301f3bb309bd93510b1185220886d56819c79da10aa2835bd554967bf9142541a632e2c8f07a7805570f80f9a"} 04:33:09 INFO - Running post-run listener: copy_logs_to_upload_dir 04:33:09 INFO - Copying logs to upload dir... 04:33:09 INFO - mkdir: /builds/slave/test/build/upload/logs 04:33:09 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1288.235808 ========= master_lag: 0.09 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 28 secs) (at 2017-03-09 04:33:09.716598) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-09 04:33:09.720175) ========= 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.wQxPSeHV9x/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.HqyWDKlAjF/Listeners TMPDIR=/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/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/Firefox/sha512/3e8d5339bff24ffc88f2a02db08f78d00a3b4b6742dabae32c67b52806986c32f1a678ede66d6c0e11bcebc9368d00a6430fce24c7a58e0331659310647ce7dd", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f64da53c4ba2fe1f141a19628e22a3f47eaff7aac432979cfe147ea57dd3aebde18f93269173a52573ff94404eef47e78a6ee631b0afc805e51c99c5873d7ab4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b8a17d7872376980d7301ede5bfd162b3bf7fd161dce5921ba586f7de29e53dc32e3d35788d6f16fac3d6a892f7dfd688fade9d2f32d6c3aa72ac6d61ed34798", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/46dfa57abb60420e716ed1369acda62a77bf5fb301f3bb309bd93510b1185220886d56819c79da10aa2835bd554967bf9142541a632e2c8f07a7805570f80f9a"} build_url:https://queue.taskcluster.net/v1/task/VivP9G1OTLiFoUMxDokQeg/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011506 build_url: 'https://queue.taskcluster.net/v1/task/VivP9G1OTLiFoUMxDokQeg/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3e8d5339bff24ffc88f2a02db08f78d00a3b4b6742dabae32c67b52806986c32f1a678ede66d6c0e11bcebc9368d00a6430fce24c7a58e0331659310647ce7dd", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f64da53c4ba2fe1f141a19628e22a3f47eaff7aac432979cfe147ea57dd3aebde18f93269173a52573ff94404eef47e78a6ee631b0afc805e51c99c5873d7ab4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b8a17d7872376980d7301ede5bfd162b3bf7fd161dce5921ba586f7de29e53dc32e3d35788d6f16fac3d6a892f7dfd688fade9d2f32d6c3aa72ac6d61ed34798", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/46dfa57abb60420e716ed1369acda62a77bf5fb301f3bb309bd93510b1185220886d56819c79da10aa2835bd554967bf9142541a632e2c8f07a7805570f80f9a"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-09 04:33:09.755667) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-09 04:33:09.756013) ========= 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.wQxPSeHV9x/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.HqyWDKlAjF/Listeners TMPDIR=/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/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.005495 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-09 04:33:09.804803) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-09 04:33:09.805123) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-09 04:33:09.805488) ========= ========= Total master_lag: 0.24 =========