builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0320 starttime: 1493328220.93 results: success (0) buildid: 20170427124424 builduid: a58e52cab71f44cfaec5eb331a0887d6 revision: ffdedb9c5aadf033a6a230bbc0338bc0e0760db0 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-04-27 14:23:40.927004) ========= master: http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-04-27 14:23:40.927450) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-27 14:23:40.927724) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-27 14:23:40.952047) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-27 14:23:40.952386) ========= 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.bnkoMrF2l6/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.VwqSGJXvEj/Listeners TMPDIR=/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2017-04-27 14:23:40-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 197M=0s 2017-04-27 14:23:41 (197 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.140465 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-27 14:23:41.117686) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-27 14:23:41.117998) ========= 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.bnkoMrF2l6/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.VwqSGJXvEj/Listeners TMPDIR=/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/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.022640 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-27 14:23:41.166392) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-04-27 14:23:41.166759) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev ffdedb9c5aadf033a6a230bbc0338bc0e0760db0 --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 ffdedb9c5aadf033a6a230bbc0338bc0e0760db0 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.bnkoMrF2l6/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.VwqSGJXvEj/Listeners TMPDIR=/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2017-04-27 14:23:41,260 truncating revision to first 12 chars 2017-04-27 14:23:41,260 Setting DEBUG logging. 2017-04-27 14:23:41,260 attempt 1/10 2017-04-27 14:23:41,260 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/ffdedb9c5aad?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-04-27 14:23:42,272 unpacking tar archive at: mozilla-central-ffdedb9c5aad/testing/mozharness/ program finished with exit code 0 elapsedTime=1.278118 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-04-27 14:23:42.470777) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-27 14:23:42.471096) ========= script_repo_revision: ffdedb9c5aadf033a6a230bbc0338bc0e0760db0 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-27 14:23:42.471489) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-27 14:23:42.471756) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-27 14:23:42.492376) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 22 secs) (at 2017-04-27 14:23:42.492809) ========= /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.bnkoMrF2l6/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.VwqSGJXvEj/Listeners TMPDIR=/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/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 14:23:42 INFO - MultiFileLogger online at 20170427 14:23:42 in /builds/slave/test 14:23:42 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 14:23:42 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 14:23:42 INFO - {'append_to_log': False, 14:23:42 INFO - 'base_work_dir': '/builds/slave/test', 14:23:42 INFO - 'blob_upload_branch': 'Firefox', 14:23:42 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 14:23:42 INFO - 'branch': 'Firefox', 14:23:42 INFO - 'buildbot_json_path': 'buildprops.json', 14:23:42 INFO - 'config_files': ('talos/mac_config.py',), 14:23:42 INFO - 'default_actions': ('clobber', 14:23:42 INFO - 'read-buildbot-config', 14:23:42 INFO - 'download-and-extract', 14:23:42 INFO - 'populate-webroot', 14:23:42 INFO - 'create-virtualenv', 14:23:42 INFO - 'install', 14:23:42 INFO - 'run-tests'), 14:23:42 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:23:42 INFO - 'download_minidump_stackwalk': True, 14:23:42 INFO - 'download_symbols': 'ondemand', 14:23:42 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:23:42 INFO - 'tooltool.py': '/tools/tooltool.py', 14:23:42 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:23:42 INFO - '/tools/misc-python/virtualenv.py')}, 14:23:42 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:23:42 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:23:42 INFO - 'gecko_profile': False, 14:23:42 INFO - 'gecko_profile_interval': 0, 14:23:42 INFO - 'installer_path': 'installer.exe', 14:23:42 INFO - 'log_level': 'info', 14:23:42 INFO - 'log_name': 'talos', 14:23:42 INFO - 'log_to_console': True, 14:23:42 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 14:23:42 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 14:23:42 INFO - 'opt_config_files': (), 14:23:42 INFO - 'pip_index': False, 14:23:42 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 14:23:42 INFO - 'cmd': ('bash', 14:23:42 INFO - '-c', 14:23:42 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 14:23:42 INFO - 'enabled': True, 14:23:42 INFO - 'halt_on_failure': False, 14:23:42 INFO - 'name': 'check_screen_resolution'},), 14:23:42 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 14:23:42 INFO - 'cmd': ('bash', 14:23:42 INFO - '-c', 14:23:42 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 14:23:42 INFO - 'enabled': True, 14:23:42 INFO - 'halt_on_failure': False, 14:23:42 INFO - 'name': 'check_screen_resolution'},), 14:23:42 INFO - 'run_cmd_checks_enabled': True, 14:23:42 INFO - 'suite': 'dromaeojs', 14:23:42 INFO - 'system_bits': '32', 14:23:42 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:23:42 INFO - 'title': 't-yosemite-r7-0320', 14:23:42 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:23:42 INFO - 'use_talos_json': True, 14:23:42 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 14:23:42 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:23:42 INFO - 'work_dir': 'build'} 14:23:42 INFO - [mozharness: 2017-04-27 21:23:42.707783Z] Running clobber step. 14:23:42 INFO - Running pre-action listener: _resource_record_pre_action 14:23:42 INFO - Running main action method: clobber 14:23:42 INFO - rmtree: /builds/slave/test/build 14:23:42 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 14:23:44 INFO - Running post-action listener: _resource_record_post_action 14:23:44 INFO - [mozharness: 2017-04-27 21:23:44.563324Z] Finished clobber step (success) 14:23:44 INFO - [mozharness: 2017-04-27 21:23:44.563533Z] Running read-buildbot-config step. 14:23:44 INFO - Running pre-action listener: _resource_record_pre_action 14:23:44 INFO - Running main action method: read_buildbot_config 14:23:44 INFO - Using buildbot properties: 14:23:44 INFO - { 14:23:44 INFO - "project": "", 14:23:44 INFO - "product": "firefox", 14:23:44 INFO - "script_repo_revision": "production", 14:23:44 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 14:23:44 INFO - "repository": "", 14:23:44 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 14:23:44 INFO - "buildid": "20170427124424", 14:23:44 INFO - "pgo_build": "False", 14:23:44 INFO - "basedir": "/builds/slave/test", 14:23:44 INFO - "buildnumber": 36, 14:23:44 INFO - "slavename": "t-yosemite-r7-0320", 14:23:44 INFO - "master": "http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/", 14:23:44 INFO - "platform": "yosemite_r7", 14:23:44 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 14:23:44 INFO - "branch": "mozilla-central", 14:23:44 INFO - "repo_path": "mozilla-central", 14:23:44 INFO - "revision": "ffdedb9c5aadf033a6a230bbc0338bc0e0760db0", 14:23:44 INFO - "stage_platform": "macosx64", 14:23:44 INFO - "builduid": "a58e52cab71f44cfaec5eb331a0887d6", 14:23:44 INFO - "slavebuilddir": "test" 14:23:44 INFO - } 14:23:44 INFO - Found installer url https://queue.taskcluster.net/v1/task/Wss_kS7IS9iPcMBhbOHEgA/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg. 14:23:44 INFO - Running post-action listener: _resource_record_post_action 14:23:44 INFO - [mozharness: 2017-04-27 21:23:44.567700Z] Finished read-buildbot-config step (success) 14:23:44 INFO - [mozharness: 2017-04-27 21:23:44.567924Z] Running download-and-extract step. 14:23:44 INFO - Running pre-action listener: _resource_record_pre_action 14:23:44 INFO - Running main action method: download_and_extract 14:23:44 INFO - mkdir: /builds/slave/test/build/tests 14:23:44 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')]} 14:23:44 INFO - trying https://queue.taskcluster.net/v1/task/Wss_kS7IS9iPcMBhbOHEgA/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json 14:23:44 INFO - Downloading https://queue.taskcluster.net/v1/task/Wss_kS7IS9iPcMBhbOHEgA/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 14:23:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Wss_kS7IS9iPcMBhbOHEgA/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 14:23:45 INFO - Downloaded 1325 bytes. 14:23:45 INFO - Reading from file /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 14:23:45 INFO - Using the following test package requirements: 14:23:45 INFO - {u'awsy': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 14:23:45 INFO - u'firefox-55.0a1.en-US.mac.awsy.tests.zip'], 14:23:45 INFO - u'common': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 14:23:45 INFO - u'cppunittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 14:23:45 INFO - u'firefox-55.0a1.en-US.mac.cppunittest.tests.zip'], 14:23:45 INFO - u'gtest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 14:23:45 INFO - u'firefox-55.0a1.en-US.mac.gtest.tests.zip'], 14:23:45 INFO - u'jittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 14:23:45 INFO - u'jsshell-mac.zip'], 14:23:45 INFO - u'mochitest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 14:23:45 INFO - u'firefox-55.0a1.en-US.mac.mochitest.tests.zip'], 14:23:45 INFO - u'mozbase': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 14:23:45 INFO - u'reftest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 14:23:45 INFO - u'firefox-55.0a1.en-US.mac.reftest.tests.zip'], 14:23:45 INFO - u'talos': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 14:23:45 INFO - u'firefox-55.0a1.en-US.mac.talos.tests.zip'], 14:23:45 INFO - u'web-platform': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 14:23:45 INFO - u'firefox-55.0a1.en-US.mac.web-platform.tests.zip'], 14:23:45 INFO - u'xpcshell': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 14:23:45 INFO - u'firefox-55.0a1.en-US.mac.xpcshell.tests.zip']} 14:23:45 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip'] for test suite category: common 14:23:45 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Wss_kS7IS9iPcMBhbOHEgA/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 14:23:45 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Wss_kS7IS9iPcMBhbOHEgA/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 14:23:45 INFO - Fetch https://queue.taskcluster.net/v1/task/Wss_kS7IS9iPcMBhbOHEgA/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 14:23:47 INFO - Content-Length response header: 52697277 14:23:47 INFO - Bytes received: 52697277 14:24:03 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 14:24:03 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Wss_kS7IS9iPcMBhbOHEgA/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 14:24:03 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Wss_kS7IS9iPcMBhbOHEgA/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 14:24:03 INFO - Fetch https://queue.taskcluster.net/v1/task/Wss_kS7IS9iPcMBhbOHEgA/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 14:24:05 INFO - Content-Length response header: 52697277 14:24:05 INFO - Bytes received: 52697277 14:24:20 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Wss_kS7IS9iPcMBhbOHEgA/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip 14:24:20 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Wss_kS7IS9iPcMBhbOHEgA/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip'}, attempt #1 14:24:20 INFO - Fetch https://queue.taskcluster.net/v1/task/Wss_kS7IS9iPcMBhbOHEgA/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip into memory 14:24:22 INFO - Content-Length response header: 14408809 14:24:22 INFO - Bytes received: 14408809 14:24:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:24:22 INFO - trying https://queue.taskcluster.net/v1/task/Wss_kS7IS9iPcMBhbOHEgA/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 14:24:22 INFO - Downloading https://queue.taskcluster.net/v1/task/Wss_kS7IS9iPcMBhbOHEgA/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg 14:24:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Wss_kS7IS9iPcMBhbOHEgA/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 14:24:24 INFO - Downloaded 71237753 bytes. 14:24:24 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Wss_kS7IS9iPcMBhbOHEgA/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 14:24:24 INFO - mkdir: /builds/slave/test/properties 14:24:24 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 14:24:24 INFO - Writing to file /builds/slave/test/properties/build_url 14:24:24 INFO - Contents: 14:24:24 INFO - build_url:https://queue.taskcluster.net/v1/task/Wss_kS7IS9iPcMBhbOHEgA/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 14:24:25 INFO - Running post-action listener: _resource_record_post_action 14:24:25 INFO - Running post-action listener: set_extra_try_arguments 14:24:25 INFO - [mozharness: 2017-04-27 21:24:25.466106Z] Finished download-and-extract step (success) 14:24:25 INFO - [mozharness: 2017-04-27 21:24:25.466247Z] Running populate-webroot step. 14:24:25 INFO - Running pre-action listener: _resource_record_pre_action 14:24:25 INFO - Running main action method: populate_webroot 14:24:25 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:24:25 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:24:25 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:24:25 INFO - '--tppagecycles', 14:24:25 INFO - '7'], 14:24:25 INFO - 'tests': ['tsvgm']}}, 14:24:25 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 14:24:25 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:24:25 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 14:24:25 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 14:24:25 INFO - 'tests': ['dromaeo_css', 'kraken']}, 14:24:25 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 14:24:25 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 14:24:25 INFO - 'talos_options': ['--disable-e10s'], 14:24:25 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:24:25 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 14:24:25 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:24:25 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 14:24:25 INFO - 'talos_options': ['--disable-e10s'], 14:24:25 INFO - 'tests': ['damp', 'tps']}, 14:24:25 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 14:24:25 INFO - 'tests': ['damp', 'tps']}, 14:24:25 INFO - 'g3': {'talos_options': ['--disable-e10s'], 14:24:25 INFO - 'tests': ['dromaeo_dom']}, 14:24:25 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:24:25 INFO - 'g4': {'talos_options': ['--disable-e10s'], 14:24:25 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 14:24:25 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 14:24:25 INFO - 'other': {'talos_options': ['--disable-e10s'], 14:24:25 INFO - 'tests': ['a11yr', 14:24:25 INFO - 'ts_paint', 14:24:25 INFO - 'tpaint', 14:24:25 INFO - 'sessionrestore', 14:24:25 INFO - 'sessionrestore_no_auto_restore', 14:24:25 INFO - 'tabpaint']}, 14:24:25 INFO - 'other-e10s': {'tests': ['a11yr', 14:24:25 INFO - 'ts_paint', 14:24:25 INFO - 'tpaint', 14:24:25 INFO - 'sessionrestore', 14:24:25 INFO - 'sessionrestore_no_auto_restore', 14:24:25 INFO - 'tabpaint']}, 14:24:25 INFO - 'other-e10s_l64': {'tests': ['a11yr', 14:24:25 INFO - 'ts_paint', 14:24:25 INFO - 'tpaint', 14:24:25 INFO - 'sessionrestore', 14:24:25 INFO - 'sessionrestore_no_auto_restore', 14:24:25 INFO - 'tabpaint']}, 14:24:25 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 14:24:25 INFO - 'ts_paint', 14:24:25 INFO - 'tpaint', 14:24:25 INFO - 'sessionrestore', 14:24:25 INFO - 'sessionrestore_no_auto_restore', 14:24:25 INFO - 'tabpaint']}, 14:24:25 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 14:24:25 INFO - 'tests': ['a11yr', 14:24:25 INFO - 'ts_paint', 14:24:25 INFO - 'tpaint', 14:24:25 INFO - 'sessionrestore', 14:24:25 INFO - 'sessionrestore_no_auto_restore', 14:24:25 INFO - 'tabpaint']}, 14:24:25 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 14:24:25 INFO - 'tests': ['a11yr', 14:24:25 INFO - 'ts_paint', 14:24:25 INFO - 'tpaint', 14:24:25 INFO - 'sessionrestore', 14:24:25 INFO - 'sessionrestore_no_auto_restore', 14:24:25 INFO - 'tabpaint']}, 14:24:25 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 14:24:25 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 14:24:25 INFO - 'bloom_basic_ref']}, 14:24:25 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 14:24:25 INFO - 'tests': ['tsvgx', 14:24:25 INFO - 'tsvgr_opacity', 14:24:25 INFO - 'tart', 14:24:25 INFO - 'tscrollx', 14:24:25 INFO - 'cart', 14:24:25 INFO - 'tsvg_static']}, 14:24:25 INFO - 'svgr-e10s': {'tests': ['tsvgx', 14:24:25 INFO - 'tsvgr_opacity', 14:24:25 INFO - 'tart', 14:24:25 INFO - 'tscrollx', 14:24:25 INFO - 'cart', 14:24:25 INFO - 'tsvg_static']}, 14:24:25 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 14:24:25 INFO - 'talos_options': ['--disable-e10s'], 14:24:25 INFO - 'tests': ['tp5o']}, 14:24:25 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 14:24:25 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 14:24:25 INFO - 'talos_options': ['--disable-e10s', 14:24:25 INFO - '--xperf_path', 14:24:25 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:24:25 INFO - 'tests': ['tp5n']}, 14:24:25 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 14:24:25 INFO - 'talos_options': ['--xperf_path', 14:24:25 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:24:25 INFO - 'tests': ['tp5n']}}, 14:24:25 INFO - 'talos.zip': {'path': '', 14:24:25 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:24:25 INFO - Running post-action listener: _resource_record_post_action 14:24:25 INFO - [mozharness: 2017-04-27 21:24:25.485696Z] Finished populate-webroot step (success) 14:24:25 INFO - [mozharness: 2017-04-27 21:24:25.485829Z] Running create-virtualenv step. 14:24:25 INFO - Running pre-action listener: _resource_record_pre_action 14:24:25 INFO - Running main action method: create_virtualenv 14:24:25 INFO - Creating virtualenv /builds/slave/test/build/venv 14:24:25 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 14:24:25 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 14:24:25 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:24:25 INFO - Using real prefix '/tools/python27' 14:24:25 INFO - New python executable in /builds/slave/test/build/venv/bin/python 14:24:26 INFO - Installing distribute.............................................................................................................................................................................................done. 14:24:29 INFO - Installing pip.................done. 14:24:29 INFO - Return code: 0 14:24:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 14:24:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 14:24:29 INFO - Reading from file tmpfile_stdout 14:24:29 INFO - Output received: 14:24:29 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) 14:24:29 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 14:24:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:24:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:24:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:24:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:24:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:24:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:24:29 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 0x10ce10b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ce13768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdff2d77bb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cbeed30>, '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 0x10cb14db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cbe3be8>, '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.bnkoMrF2l6/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.VwqSGJXvEj/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/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 14:24:29 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 14:24:29 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 14:24:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bnkoMrF2l6/Render', 14:24:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:24:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:24:29 INFO - 'HOME': '/Users/cltbld', 14:24:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:24:29 INFO - 'LOGNAME': 'cltbld', 14:24:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:24:29 INFO - 'MOZ_NO_REMOTE': '1', 14:24:29 INFO - 'NO_EM_RESTART': '1', 14:24:29 INFO - 'PAGER': '/bin/cat', 14:24:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:24:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:24:29 INFO - 'PWD': '/builds/slave/test', 14:24:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:24:29 INFO - 'SHELL': '/bin/bash', 14:24:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.VwqSGJXvEj/Listeners', 14:24:29 INFO - 'TMPDIR': '/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/', 14:24:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:24:29 INFO - 'USER': 'cltbld', 14:24:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:24:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:24:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:24:29 INFO - 'XPC_FLAGS': '0x0', 14:24:29 INFO - 'XPC_SERVICE_NAME': '0', 14:24:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:24:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:24:29 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 14:24:29 INFO - Cleaning up... 14:24:29 INFO - Return code: 0 14:24:29 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 14:24:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:24:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:24:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:24:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:24:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:24:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:24:29 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 0x10ce10b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ce13768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdff2d77bb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cbeed30>, '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 0x10cb14db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cbe3be8>, '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.bnkoMrF2l6/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.VwqSGJXvEj/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/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 14:24:29 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 14:24:29 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 14:24:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bnkoMrF2l6/Render', 14:24:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:24:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:24:29 INFO - 'HOME': '/Users/cltbld', 14:24:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:24:29 INFO - 'LOGNAME': 'cltbld', 14:24:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:24:29 INFO - 'MOZ_NO_REMOTE': '1', 14:24:29 INFO - 'NO_EM_RESTART': '1', 14:24:29 INFO - 'PAGER': '/bin/cat', 14:24:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:24:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:24:29 INFO - 'PWD': '/builds/slave/test', 14:24:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:24:29 INFO - 'SHELL': '/bin/bash', 14:24:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.VwqSGJXvEj/Listeners', 14:24:29 INFO - 'TMPDIR': '/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/', 14:24:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:24:29 INFO - 'USER': 'cltbld', 14:24:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:24:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:24:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:24:29 INFO - 'XPC_FLAGS': '0x0', 14:24:29 INFO - 'XPC_SERVICE_NAME': '0', 14:24:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:24:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:24:30 INFO - Downloading/unpacking psutil>=3.1.1 14:24:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:24:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:24:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:24:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:24:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:24:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:24:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 14:24:33 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:24:33 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:24:33 INFO - Installing collected packages: psutil 14:24:33 INFO - Running setup.py install for psutil 14:24:33 INFO - building 'psutil._psutil_osx' extension 14:24: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_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 14:24:34 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 14:24:34 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 14:24:34 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 14:24:34 INFO - building 'psutil._psutil_posix' extension 14:24:34 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 14:24:34 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 14:24:34 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 14:24:34 INFO - ^ 14:24:34 INFO - 1 warning generated. 14:24:34 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 14:24:34 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:24:34 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:24:34 INFO - Successfully installed psutil 14:24:34 INFO - Cleaning up... 14:24:34 INFO - Return code: 0 14:24:34 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 14:24: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')]} 14:24:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:24:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:24: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')]} 14:24:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:24:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:24: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 0x10ce10b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ce13768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdff2d77bb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cbeed30>, '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 0x10cb14db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cbe3be8>, '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.bnkoMrF2l6/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.VwqSGJXvEj/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/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 14:24: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 14:24: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 14:24:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bnkoMrF2l6/Render', 14:24:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:24:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:24:34 INFO - 'HOME': '/Users/cltbld', 14:24:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:24:34 INFO - 'LOGNAME': 'cltbld', 14:24:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:24:34 INFO - 'MOZ_NO_REMOTE': '1', 14:24:34 INFO - 'NO_EM_RESTART': '1', 14:24:34 INFO - 'PAGER': '/bin/cat', 14:24:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:24:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:24:34 INFO - 'PWD': '/builds/slave/test', 14:24:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:24:34 INFO - 'SHELL': '/bin/bash', 14:24:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.VwqSGJXvEj/Listeners', 14:24:34 INFO - 'TMPDIR': '/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/', 14:24:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:24:34 INFO - 'USER': 'cltbld', 14:24:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:24:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:24:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:24:34 INFO - 'XPC_FLAGS': '0x0', 14:24:34 INFO - 'XPC_SERVICE_NAME': '0', 14:24:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:24:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:24:34 INFO - Downloading/unpacking mozsystemmonitor==0.3 14:24: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 14:24: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 14:24: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 14:24: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 14:24: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 14:24: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 14:24:37 INFO - Downloading mozsystemmonitor-0.3.tar.gz 14:24:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:24:37 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 14:24:37 INFO - Installing collected packages: mozsystemmonitor 14:24:37 INFO - Running setup.py install for mozsystemmonitor 14:24:37 INFO - Successfully installed mozsystemmonitor 14:24:37 INFO - Cleaning up... 14:24:37 INFO - Return code: 0 14:24:37 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 14:24:37 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')]} 14:24:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:24:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:24: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')]} 14:24:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:24:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:24: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 0x10ce10b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ce13768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdff2d77bb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cbeed30>, '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 0x10cb14db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cbe3be8>, '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.bnkoMrF2l6/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.VwqSGJXvEj/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/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 14:24: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 14:24: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 14:24:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bnkoMrF2l6/Render', 14:24:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:24:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:24:38 INFO - 'HOME': '/Users/cltbld', 14:24:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:24:38 INFO - 'LOGNAME': 'cltbld', 14:24:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:24:38 INFO - 'MOZ_NO_REMOTE': '1', 14:24:38 INFO - 'NO_EM_RESTART': '1', 14:24:38 INFO - 'PAGER': '/bin/cat', 14:24:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:24:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:24:38 INFO - 'PWD': '/builds/slave/test', 14:24:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:24:38 INFO - 'SHELL': '/bin/bash', 14:24:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.VwqSGJXvEj/Listeners', 14:24:38 INFO - 'TMPDIR': '/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/', 14:24:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:24:38 INFO - 'USER': 'cltbld', 14:24:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:24:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:24:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:24:38 INFO - 'XPC_FLAGS': '0x0', 14:24:38 INFO - 'XPC_SERVICE_NAME': '0', 14:24:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:24:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:24:38 INFO - Downloading/unpacking jsonschema==2.5.1 14:24: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 14:24: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 14:24: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 14:24: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 14:24: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 14:24: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 14:24:41 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:24:41 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 14:24: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 14:24: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 14:24: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 14:24: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 14:24: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 14:24: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 14:24:42 INFO - Downloading functools32-3.2.3-2.tar.gz 14:24:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 14:24:42 INFO - warning: no files found matching '*.txt' 14:24:42 INFO - no previously-included directories found matching 'build' 14:24:42 INFO - no previously-included directories found matching 'dist' 14:24:42 INFO - no previously-included directories found matching '.git*' 14:24:42 INFO - Installing collected packages: jsonschema, functools32 14:24:42 INFO - Running setup.py install for functools32 14:24:42 INFO - warning: no files found matching '*.txt' 14:24:42 INFO - no previously-included directories found matching 'build' 14:24:42 INFO - no previously-included directories found matching 'dist' 14:24:42 INFO - no previously-included directories found matching '.git*' 14:24:42 INFO - Successfully installed jsonschema functools32 14:24:42 INFO - Cleaning up... 14:24:42 INFO - Return code: 0 14:24:42 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 14:24: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')]} 14:24:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:24:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:24: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')]} 14:24:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:24:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:24: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', '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 0x10ce10b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ce13768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdff2d77bb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cbeed30>, '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 0x10cb14db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cbe3be8>, '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.bnkoMrF2l6/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.VwqSGJXvEj/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/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 14:24: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', 'functools32==3.2.3-2'] in /builds/slave/test/build 14:24: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 functools32==3.2.3-2 14:24:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bnkoMrF2l6/Render', 14:24:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:24:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:24:42 INFO - 'HOME': '/Users/cltbld', 14:24:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:24:42 INFO - 'LOGNAME': 'cltbld', 14:24:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:24:42 INFO - 'MOZ_NO_REMOTE': '1', 14:24:42 INFO - 'NO_EM_RESTART': '1', 14:24:42 INFO - 'PAGER': '/bin/cat', 14:24:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:24:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:24:42 INFO - 'PWD': '/builds/slave/test', 14:24:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:24:42 INFO - 'SHELL': '/bin/bash', 14:24:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.VwqSGJXvEj/Listeners', 14:24:42 INFO - 'TMPDIR': '/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/', 14:24:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:24:42 INFO - 'USER': 'cltbld', 14:24:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:24:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:24:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:24:42 INFO - 'XPC_FLAGS': '0x0', 14:24:42 INFO - 'XPC_SERVICE_NAME': '0', 14:24:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:24:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:24:42 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 14:24:42 INFO - Cleaning up... 14:24:42 INFO - Return code: 0 14:24:42 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 14:24: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')]} 14:24:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:24:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:24: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')]} 14:24:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:24:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:24: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 0x10ce10b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ce13768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdff2d77bb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cbeed30>, '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 0x10cb14db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cbe3be8>, '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.bnkoMrF2l6/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.VwqSGJXvEj/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/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 14:24: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 14:24: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 14:24:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bnkoMrF2l6/Render', 14:24:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:24:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:24:42 INFO - 'HOME': '/Users/cltbld', 14:24:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:24:42 INFO - 'LOGNAME': 'cltbld', 14:24:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:24:42 INFO - 'MOZ_NO_REMOTE': '1', 14:24:42 INFO - 'NO_EM_RESTART': '1', 14:24:42 INFO - 'PAGER': '/bin/cat', 14:24:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:24:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:24:42 INFO - 'PWD': '/builds/slave/test', 14:24:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:24:42 INFO - 'SHELL': '/bin/bash', 14:24:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.VwqSGJXvEj/Listeners', 14:24:42 INFO - 'TMPDIR': '/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/', 14:24:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:24:42 INFO - 'USER': 'cltbld', 14:24:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:24:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:24:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:24:42 INFO - 'XPC_FLAGS': '0x0', 14:24:42 INFO - 'XPC_SERVICE_NAME': '0', 14:24:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:24:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:24:43 INFO - Downloading/unpacking blobuploader==1.2.4 14:24:43 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 14:24:43 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 14:24:43 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 14:24:43 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 14:24:43 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 14:24:43 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 14:24:45 INFO - Downloading blobuploader-1.2.4.tar.gz 14:24:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:24:45 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:24: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 14:24: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 14:24: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 14:24: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 14:24: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 14:24: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 14:24:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 14:24:46 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:24:46 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 14:24:46 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 14:24:46 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 14:24:46 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 14:24:46 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 14:24:46 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 14:24:46 INFO - Downloading docopt-0.6.1.tar.gz 14:24:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 14:24:47 INFO - Installing collected packages: blobuploader, requests, docopt 14:24:47 INFO - Running setup.py install for blobuploader 14:24:47 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:24:47 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 14:24:47 INFO - Running setup.py install for requests 14:24:47 INFO - Running setup.py install for docopt 14:24:47 INFO - Successfully installed blobuploader requests docopt 14:24:47 INFO - Cleaning up... 14:24:47 INFO - Return code: 0 14:24:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:24: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')]} 14:24:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:24:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:24: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')]} 14:24:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:24:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:24: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 0x10ce10b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ce13768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdff2d77bb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cbeed30>, '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 0x10cb14db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cbe3be8>, '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.bnkoMrF2l6/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.VwqSGJXvEj/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/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 14:24: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 14:24: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 14:24:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bnkoMrF2l6/Render', 14:24:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:24:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:24:47 INFO - 'HOME': '/Users/cltbld', 14:24:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:24:47 INFO - 'LOGNAME': 'cltbld', 14:24:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:24:47 INFO - 'MOZ_NO_REMOTE': '1', 14:24:47 INFO - 'NO_EM_RESTART': '1', 14:24:47 INFO - 'PAGER': '/bin/cat', 14:24:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:24:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:24:48 INFO - 'PWD': '/builds/slave/test', 14:24:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:24:48 INFO - 'SHELL': '/bin/bash', 14:24:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.VwqSGJXvEj/Listeners', 14:24:48 INFO - 'TMPDIR': '/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/', 14:24:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:24:48 INFO - 'USER': 'cltbld', 14:24:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:24:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:24:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:24:48 INFO - 'XPC_FLAGS': '0x0', 14:24:48 INFO - 'XPC_SERVICE_NAME': '0', 14:24:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:24:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:24:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:24:48 INFO - Running setup.py (path:/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/pip-ZQETxU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:24:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:24:48 INFO - Running setup.py (path:/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/pip-4DamvZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:24:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:24:48 INFO - Running setup.py (path:/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/pip-qkf6GJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:24:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:24:48 INFO - Running setup.py (path:/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/pip-VES1WK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:24:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:24:48 INFO - Running setup.py (path:/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/pip-TrwcDY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:24:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:24:48 INFO - Running setup.py (path:/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/pip-hpRwnp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:24:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:24:48 INFO - Running setup.py (path:/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/pip-nSlQAY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:24:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:24:48 INFO - Running setup.py (path:/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/pip-2pXWY3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:24:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:24:49 INFO - Running setup.py (path:/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/pip-1SppWg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:24:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:24:49 INFO - Running setup.py (path:/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/pip-RncqCM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:24:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:24:49 INFO - Running setup.py (path:/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/pip-pyb6b_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:24:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:24:49 INFO - Running setup.py (path:/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/pip-weHQyu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:24:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:24:49 INFO - Running setup.py (path:/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/pip-JJj0QF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:24:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:24:49 INFO - Running setup.py (path:/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/pip-KIwIgn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:24:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:24:49 INFO - Running setup.py (path:/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/pip-3SLGwr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:24:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:24:49 INFO - Running setup.py (path:/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/pip-GvZIwb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:24:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:24:49 INFO - Running setup.py (path:/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/pip-Kp_onh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:24:50 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:24:50 INFO - Running setup.py install for manifestparser 14:24:50 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 14:24:50 INFO - Running setup.py install for mozcrash 14:24:50 INFO - Running setup.py install for mozdebug 14:24:50 INFO - Running setup.py install for mozdevice 14:24:50 INFO - Installing dm script to /builds/slave/test/build/venv/bin 14:24:50 INFO - Running setup.py install for mozfile 14:24:50 INFO - Running setup.py install for mozhttpd 14:24:50 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 14:24:50 INFO - Running setup.py install for mozinfo 14:24:51 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 14:24:51 INFO - Running setup.py install for mozInstall 14:24:51 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 14:24:51 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 14:24:51 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 14:24:51 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 14:24:51 INFO - Running setup.py install for mozleak 14:24:51 INFO - Running setup.py install for mozlog 14:24:51 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 14:24:51 INFO - Running setup.py install for moznetwork 14:24:51 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 14:24:51 INFO - Running setup.py install for mozprocess 14:24:51 INFO - Running setup.py install for mozprofile 14:24:51 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 14:24:51 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 14:24:51 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 14:24:51 INFO - Running setup.py install for mozrunner 14:24:52 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 14:24:52 INFO - Running setup.py install for mozscreenshot 14:24:52 INFO - Running setup.py install for moztest 14:24:52 INFO - Running setup.py install for mozversion 14:24:52 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 14:24:52 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:24:52 INFO - Cleaning up... 14:24:52 INFO - Return code: 0 14:24:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:24:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:24:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:24:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:24:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:24:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:24:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:24:52 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 0x10ce10b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ce13768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdff2d77bb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cbeed30>, '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 0x10cb14db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cbe3be8>, '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.bnkoMrF2l6/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.VwqSGJXvEj/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/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 14:24:52 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 14:24:52 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 14:24:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bnkoMrF2l6/Render', 14:24:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:24:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:24:52 INFO - 'HOME': '/Users/cltbld', 14:24:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:24:52 INFO - 'LOGNAME': 'cltbld', 14:24:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:24:52 INFO - 'MOZ_NO_REMOTE': '1', 14:24:52 INFO - 'NO_EM_RESTART': '1', 14:24:52 INFO - 'PAGER': '/bin/cat', 14:24:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:24:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:24:52 INFO - 'PWD': '/builds/slave/test', 14:24:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:24:52 INFO - 'SHELL': '/bin/bash', 14:24:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.VwqSGJXvEj/Listeners', 14:24:52 INFO - 'TMPDIR': '/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/', 14:24:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:24:52 INFO - 'USER': 'cltbld', 14:24:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:24:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:24:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:24:52 INFO - 'XPC_FLAGS': '0x0', 14:24:52 INFO - 'XPC_SERVICE_NAME': '0', 14:24:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:24:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:24:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:24:52 INFO - Running setup.py (path:/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/pip-NzGC6p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:24: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)) 14:24:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:24:52 INFO - Running setup.py (path:/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/pip-PlwqDw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:24:53 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)) 14:24:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:24:53 INFO - Running setup.py (path:/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/pip-5XUG9y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:24:53 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)) 14:24:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:24:53 INFO - Running setup.py (path:/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/pip-pwtyfU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:24:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.50 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)) 14:24:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:24:53 INFO - Running setup.py (path:/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/pip-ttA8K4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:24:53 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)) 14:24:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:24:53 INFO - Running setup.py (path:/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/pip-8_AiB2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:24:53 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)) 14:24:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:24:53 INFO - Running setup.py (path:/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/pip-9EdAGp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:24:53 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)) 14:24:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:24:53 INFO - Running setup.py (path:/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/pip-Or9f9p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:24: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)) 14:24:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:24:53 INFO - Running setup.py (path:/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/pip-vCQpMl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:24: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)) 14:24:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:24:53 INFO - Running setup.py (path:/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/pip-3WCmnq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:24: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)) 14:24:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:24:53 INFO - Running setup.py (path:/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/pip-AO9GgD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:24:54 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)) 14:24:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:24:54 INFO - Running setup.py (path:/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/pip-E112xg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:24:54 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)) 14:24:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:24:54 INFO - Running setup.py (path:/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/pip-YtKvoT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:24:54 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)) 14:24:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:24:54 INFO - Running setup.py (path:/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/pip-xgOgc1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:24:54 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)) 14:24:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:24:54 INFO - Running setup.py (path:/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/pip-8Wfkvr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:24:54 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)) 14:24:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:24:54 INFO - Running setup.py (path:/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/pip-dRGgo8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:24:54 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)) 14:24:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:24:54 INFO - Running setup.py (path:/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/pip-c25ACo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:24: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)) 14:24: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)) 14:24: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)) 14:24: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)) 14:24: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.50->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 14:24: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.50->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 14:24:54 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:24: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 14:24: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 14:24: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 14:24: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 14:24: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 14:24: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 14:24:57 INFO - Downloading blessings-1.6.tar.gz 14:24:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 14:24:57 INFO - Installing collected packages: blessings 14:24:57 INFO - Running setup.py install for blessings 14:24:57 INFO - Successfully installed blessings 14:24:57 INFO - Cleaning up... 14:24:57 INFO - Return code: 0 14:24:57 INFO - Done creating virtualenv /builds/slave/test/build/venv. 14:24:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:24:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:24:57 INFO - Reading from file tmpfile_stdout 14:24:57 INFO - Current package versions: 14:24:57 INFO - blessings == 1.6 14:24:57 INFO - blobuploader == 1.2.4 14:24:57 INFO - docopt == 0.6.1 14:24:57 INFO - functools32 == 3.2.3-2 14:24:57 INFO - jsonschema == 2.5.1 14:24:57 INFO - manifestparser == 1.1 14:24:57 INFO - mozInstall == 1.12 14:24:57 INFO - mozcrash == 1.0 14:24:57 INFO - mozdebug == 0.1 14:24:57 INFO - mozdevice == 0.50 14:24:57 INFO - mozfile == 1.2 14:24:57 INFO - mozhttpd == 0.7 14:24:57 INFO - mozinfo == 0.9 14:24:57 INFO - mozleak == 0.1 14:24:57 INFO - mozlog == 3.4 14:24:57 INFO - moznetwork == 0.27 14:24:57 INFO - mozprocess == 0.25 14:24:57 INFO - mozprofile == 0.28 14:24:57 INFO - mozrunner == 6.13 14:24:57 INFO - mozscreenshot == 0.1 14:24:57 INFO - mozsystemmonitor == 0.3 14:24:57 INFO - moztest == 0.8 14:24:57 INFO - mozversion == 1.4 14:24:57 INFO - psutil == 3.1.1 14:24:57 INFO - requests == 1.2.3 14:24:57 INFO - wsgiref == 0.1.2 14:24:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:24: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')]} 14:24:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:24:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:24: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')]} 14:24:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:24:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:24: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 0x10ce10b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ce13768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdff2d77bb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cbeed30>, '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 0x10cb14db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cbe3be8>, '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.bnkoMrF2l6/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.VwqSGJXvEj/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/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 14:24: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 14:24: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 14:24:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bnkoMrF2l6/Render', 14:24:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:24:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:24:57 INFO - 'HOME': '/Users/cltbld', 14:24:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:24:57 INFO - 'LOGNAME': 'cltbld', 14:24:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:24:57 INFO - 'MOZ_NO_REMOTE': '1', 14:24:57 INFO - 'NO_EM_RESTART': '1', 14:24:57 INFO - 'PAGER': '/bin/cat', 14:24:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:24:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:24:57 INFO - 'PWD': '/builds/slave/test', 14:24:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:24:57 INFO - 'SHELL': '/bin/bash', 14:24:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.VwqSGJXvEj/Listeners', 14:24:57 INFO - 'TMPDIR': '/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/', 14:24:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:24:57 INFO - 'USER': 'cltbld', 14:24:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:24:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:24:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:24:57 INFO - 'XPC_FLAGS': '0x0', 14:24:57 INFO - 'XPC_SERVICE_NAME': '0', 14:24:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:24:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:24:58 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)) 14:24:58 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)) 14:24:58 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)) 14:24:58 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)) 14:24:58 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)) 14:24:58 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)) 14:24:58 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)) 14:24:58 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)) 14:24:58 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)) 14:24:58 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)) 14:24:58 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)) 14:24:58 INFO - Cleaning up... 14:24:58 INFO - Return code: 0 14:24:58 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 14:24:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:24:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:24:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:24:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:24:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:24:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:24:58 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10ce10b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ce13768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdff2d77bb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cbeed30>, '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 0x10cb14db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cbe3be8>, '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.bnkoMrF2l6/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.VwqSGJXvEj/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/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 14:24:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 14:24:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 14:24:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bnkoMrF2l6/Render', 14:24:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:24:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:24:58 INFO - 'HOME': '/Users/cltbld', 14:24:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:24:58 INFO - 'LOGNAME': 'cltbld', 14:24:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:24:58 INFO - 'MOZ_NO_REMOTE': '1', 14:24:58 INFO - 'NO_EM_RESTART': '1', 14:24:58 INFO - 'PAGER': '/bin/cat', 14:24:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:24:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:24:58 INFO - 'PWD': '/builds/slave/test', 14:24:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:24:58 INFO - 'SHELL': '/bin/bash', 14:24:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.VwqSGJXvEj/Listeners', 14:24:58 INFO - 'TMPDIR': '/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/', 14:24:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:24:58 INFO - 'USER': 'cltbld', 14:24:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:24:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:24:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:24:58 INFO - 'XPC_FLAGS': '0x0', 14:24:58 INFO - 'XPC_SERVICE_NAME': '0', 14:24:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:24:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:24:58 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 14:24:58 INFO - Cleaning up... 14:24:58 INFO - Return code: 0 14:24:58 INFO - Running post-action listener: _resource_record_post_action 14:24:58 INFO - Running post-action listener: _start_resource_monitoring 14:24:58 INFO - Starting resource monitoring. 14:24:58 INFO - [mozharness: 2017-04-27 21:24:58.472433Z] Finished create-virtualenv step (success) 14:24:58 INFO - [mozharness: 2017-04-27 21:24:58.473350Z] Running install step. 14:24:58 INFO - Running pre-action listener: _resource_record_pre_action 14:24:58 INFO - Running main action method: install 14:24:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:24:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:24:58 INFO - Reading from file tmpfile_stdout 14:24:58 INFO - Detecting whether we're running mozinstall >=1.0... 14:24:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 14:24:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 14:24:58 INFO - Reading from file tmpfile_stdout 14:24:58 INFO - Output received: 14:24:58 INFO - Usage: mozinstall [options] installer 14:24:58 INFO - Options: 14:24:58 INFO - -h, --help show this help message and exit 14:24:58 INFO - -d DEST, --destination=DEST 14:24:58 INFO - Directory to install application into. [default: 14:24:58 INFO - "/builds/slave/test"] 14:24:58 INFO - --app=APP Application being installed. [default: firefox] 14:24:58 INFO - mkdir: /builds/slave/test/build/application 14:24: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'] 14:24: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 14:25:19 INFO - Reading from file tmpfile_stdout 14:25:19 INFO - Output received: 14:25:19 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 14:25:19 INFO - Running post-action listener: _resource_record_post_action 14:25:19 INFO - [mozharness: 2017-04-27 21:25:19.126515Z] Finished install step (success) 14:25:19 INFO - [mozharness: 2017-04-27 21:25:19.126705Z] Running run-tests step. 14:25:19 INFO - Running pre-action listener: _resource_record_pre_action 14:25:19 INFO - Running main action method: run_tests 14:25:19 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 14:25:19 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 14:25:19 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 14:25:19 INFO - 2017-04-27 14:25:19.141 screenresolution[1905:15361] starting screenresolution argv=screenresolution get 14:25:19 INFO - 2017-04-27 14:25:19.144 screenresolution[1905:15361] Display 0: 1600x1200x32@60 14:25:19 INFO - 2017-04-27 14:25:19.150 screenresolution[1906:15364] starting screenresolution argv=screenresolution list 14:25:19 INFO - Available Modes on Display 0 14:25:19 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 14:25:19 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 14:25:19 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 14:25:19 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 14:25:19 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 14:25:19 INFO - Intel Iris: 14:25:19 INFO - Chipset Model: Intel Iris 14:25:19 INFO - Type: GPU 14:25:19 INFO - Bus: Built-In 14:25:19 INFO - VRAM (Dynamic, Max): 1536 MB 14:25:19 INFO - Vendor: Intel (0x8086) 14:25:19 INFO - Device ID: 0x0a2e 14:25:19 INFO - Revision ID: 0x0009 14:25:19 INFO - Displays: 14:25:19 INFO - Display: 14:25:19 INFO - Resolution: 1600 x 1200 @ 60 Hz 14:25:19 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 14:25:19 INFO - Display Serial Number: 1600x1200 60 14:25:19 INFO - Main Display: Yes 14:25:19 INFO - Mirror: Off 14:25:19 INFO - Online: Yes 14:25:19 INFO - Rotation: Supported 14:25:19 INFO - Return code: 0 14:25:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 14:25:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 14:25:19 INFO - Python 2.7.3 14:25:19 INFO - Return code: 0 14:25:19 INFO - grabbing minidump binary from tooltool 14:25:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:25:19 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 0x10cbeed30>, '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 0x10cb14db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cbe3be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 14:25:19 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 14:25:19 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 14:25:19 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 14:25:19 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:25:19 INFO - Return code: 0 14:25:19 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 14:25:19 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 14:25:19 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 14:25:19 INFO - ENV: RUST_BACKTRACE is now 1 14:25:19 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 14:25:19 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 14:25:19 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/Wss_kS7IS9iPcMBhbOHEgA/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0320', '--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 14:25:19 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/Wss_kS7IS9iPcMBhbOHEgA/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0320 --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 14:25:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bnkoMrF2l6/Render', 14:25:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:25:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:25:19 INFO - 'HOME': '/Users/cltbld', 14:25:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:25:19 INFO - 'LOGNAME': 'cltbld', 14:25:19 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:25:19 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 14:25:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:25:19 INFO - 'MOZ_NO_REMOTE': '1', 14:25:19 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:25:19 INFO - 'NO_EM_RESTART': '1', 14:25:19 INFO - 'PAGER': '/bin/cat', 14:25:19 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:25:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:25:19 INFO - 'PWD': '/builds/slave/test', 14:25:19 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:25:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:25:19 INFO - 'RUST_BACKTRACE': '1', 14:25:19 INFO - 'SHELL': '/bin/bash', 14:25:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.VwqSGJXvEj/Listeners', 14:25:19 INFO - 'TMPDIR': '/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/', 14:25:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:25:19 INFO - 'USER': 'cltbld', 14:25:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:25:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:25:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:25:19 INFO - 'XPC_FLAGS': '0x0', 14:25:19 INFO - 'XPC_SERVICE_NAME': '0', 14:25:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:25:19 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/Wss_kS7IS9iPcMBhbOHEgA/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0320', '--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 14:25:19 INFO - mozversion application_buildid: 20170427124424 14:25:19 INFO - mozversion application_changeset: ffdedb9c5aadf033a6a230bbc0338bc0e0760db0 14:25:19 INFO - mozversion application_display_name: Nightly 14:25:19 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:25:19 INFO - mozversion application_name: Firefox 14:25:19 INFO - mozversion application_remotingname: firefox 14:25:19 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 14:25:19 INFO - mozversion application_vendor: Mozilla 14:25:19 INFO - mozversion application_version: 55.0a1 14:25:19 INFO - mozversion platform_buildid: 20170427124424 14:25:19 INFO - mozversion platform_changeset: ffdedb9c5aadf033a6a230bbc0338bc0e0760db0 14:25:19 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 14:25:19 INFO - mozversion platform_version: 55.0a1 14:25:19 INFO - using testdate: 1493328319 14:25:19 INFO - actual date: 1493328319 14:25:19 INFO - starting webserver on 'localhost:52471' 14:25:19 INFO - SUITE-START | Running 2 tests 14:25:19 INFO - TEST-START | dromaeo_css 14:25:19 INFO - operating with platform_type : mac_ 14:25:19 INFO - Initialising browser for dromaeo_css test... 14:25:19 INFO - TEST-INFO | started process 1916 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/tmpx87pJF/profile http://localhost:52471/getInfo.html) 14:25:22 INFO - PID 1916 | __metrics Screen width/height:1600/1200 14:25:22 INFO - PID 1916 | colorDepth:24 14:25:22 INFO - PID 1916 | Browser inner width/height: 1024/689 14:25:22 INFO - PID 1916 | __metrics 14:25:22 INFO - PID 1916 | 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" 14:25:22 INFO - PID 1916 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 334: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 14:25:23 INFO - TEST-INFO | 1916: exit 0 14:25:23 INFO - Browser initialized. 14:25:23 INFO - Running cycle 1/1 for dromaeo_css test... 14:25:23 INFO - TEST-INFO | started process 1918 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/tmpx87pJF/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:25:35 INFO - PID 1918 | RSS: Main: 243077120 14:25:35 INFO - PID 1918 | 14:28:39 INFO - PID 1918 | Cycle 1(1): loaded http://localhost:52471/tests/dromaeo/cssquery-dojo.html (next: http://localhost:52471/tests/dromaeo/cssquery-ext.html) 14:28:41 INFO - PID 1918 | RSS: Main: 412848128 14:28:41 INFO - PID 1918 | 14:30:24 INFO - PID 1918 | ************************* 14:30:24 INFO - PID 1918 | A coding exception was thrown and uncaught in a Task. 14:30:24 INFO - PID 1918 | 14:30:24 ERROR - PID 1918 | Full message: TypeError: NetworkError when attempting to fetch resource. 14:30:24 INFO - PID 1918 | Full stack: 14:30:24 INFO - PID 1918 | ************************* 14:30:24 INFO - PID 1918 | ************************* 14:30:24 INFO - PID 1918 | A coding exception was thrown and uncaught in a Task. 14:30:24 INFO - PID 1918 | 14:30:24 ERROR - PID 1918 | Full message: TypeError: NetworkError when attempting to fetch resource. 14:30:24 INFO - PID 1918 | Full stack: 14:30:24 INFO - PID 1918 | ************************* 14:30:24 INFO - PID 1918 | ************************* 14:30:24 INFO - PID 1918 | A coding exception was thrown and uncaught in a Task. 14:30:24 INFO - PID 1918 | 14:30:24 ERROR - PID 1918 | Full message: TypeError: NetworkError when attempting to fetch resource. 14:30:24 INFO - PID 1918 | Full stack: 14:30:24 INFO - PID 1918 | ************************* 14:30:24 INFO - PID 1918 | ************************* 14:30:24 INFO - PID 1918 | A coding exception was thrown and uncaught in a Task. 14:30:24 INFO - PID 1918 | 14:30:24 ERROR - PID 1918 | Full message: TypeError: NetworkError when attempting to fetch resource. 14:30:24 INFO - PID 1918 | Full stack: 14:30:24 INFO - PID 1918 | ************************* 14:31:43 INFO - PID 1918 | Cycle 1(1): loaded http://localhost:52471/tests/dromaeo/cssquery-ext.html (next: http://localhost:52471/tests/dromaeo/cssquery-jquery.html) 14:31:44 INFO - PID 1918 | RSS: Main: 363556864 14:31:44 INFO - PID 1918 | 14:34:46 INFO - PID 1918 | Cycle 1(1): loaded http://localhost:52471/tests/dromaeo/cssquery-jquery.html (next: http://localhost:52471/tests/dromaeo/cssquery-mootools.html) 14:34:46 INFO - PID 1918 | RSS: Main: 330698752 14:34:46 INFO - PID 1918 | 14:37:49 INFO - PID 1918 | Cycle 1(1): loaded http://localhost:52471/tests/dromaeo/cssquery-mootools.html (next: http://localhost:52471/tests/dromaeo/cssquery-prototype.html) 14:37:49 INFO - PID 1918 | RSS: Main: 333848576 14:37:49 INFO - PID 1918 | 14:40:53 INFO - PID 1918 | Cycle 1(1): loaded http://localhost:52471/tests/dromaeo/cssquery-prototype.html (next: http://localhost:52471/tests/dromaeo/cssquery-yui.html) 14:40:53 INFO - PID 1918 | RSS: Main: 330985472 14:40:53 INFO - PID 1918 | 14:43:56 INFO - PID 1918 | Cycle 1(1): loaded http://localhost:52471/tests/dromaeo/cssquery-yui.html (next: http://localhost:52471/tests/dromaeo/cssquery-dojo.html) 14:43:56 INFO - PID 1918 | RSS: Main: 372215808 14:43:56 INFO - PID 1918 | 14:43:56 INFO - PID 1918 | __start_tp_report 14:43:56 INFO - PID 1918 | _x_x_mozilla_page_load 14:43:56 INFO - PID 1918 | _x_x_mozilla_page_load_details 14:43:56 INFO - PID 1918 | |i|pagename|runs| 14:43:56 INFO - PID 1918 | |0;dojo.html;3056.81659100454;3419.4016047191767;3420.0081976226897;3454.9654503454967;3488.738344624154;5710.1434784782305;5888.381719919411;6089.634621922688;6110.908336374952;6125.111858780479;5995.160677505153;5997.160397544348;6076.513878889689;6094.542909281799;6126.326104128542;5000.924986125211;5072.594192464612;5113.488651134894;5144.742762861861;5185.662931909433;5215.374155101393;5267.789288428458;5270.130428479296;5271.130263506536;5292.444293349201;5043.9747801260755;5052.141136006888;5086.898262034775;5164.612654050924;5251.2385704072885;4348.652107831366;5255.894882102337;5259.710715910624;5270.209468579706;5271.288376069258;5169.948300516984;5192.766325515361;5212.374515058179;5223.921641175385;5241.659292145999;6023.518118550549;6051.485623721989;6055.788047418363;6056.394360563952;6063.545234107415;6233.470155036827;6286.937130628727;6310.9684451577905;6320.683965801692;6364.840878978016;6296.685165741695;6364.522660800459;6441.677916104176;6459.935400645981;6471.741130354781;5001.299818025515;6054.152418661391;6092.482139018189;6121.846953826101;6135.386461353829;6585.440237579859;6587.50593705474;6611.140551728245;6615.503837212228;6628.83427914306;6155.907661385083;6189.752409903554;6276.968615156895;6287.7799277026;6289.465395441439;6419.582727122722;6433.774817881352;6449.935500644933;6449.967750161313;6480.870382592322;6274.215723034621;6311.526635502264;6314.4317011468265;6344.857925573348;6368.808935731936;6187.319394866561;6252.562320637603;6285.245770507477;6308.3060863305;6318.115463835067;5028.974855125701;5033.496650334937;5100.693958362436;5139.486051394831;5156.92264616031;4403.207422663952;4481.663875209372;4633.0733853229485;4651.883702907455;4663.883402914887;6022.759089636365;6072.757089716361;6082.695865206722;6100;6104.664243466563;6186.907196392058;6391;6413.230412350548;6432.871342573122;6445.355464453517;5980.43185897339;5989.790357337472;6081.908771368433;6106.248323414603;6115.301188036035;5579.19101730255;5615;5630.352509461464;5634.4928956393305;5690.430956904359;6681.866362672719;6725.293844146392;6727.865442691216;6741.056252124608;6769.018492318488;6197.628142311476;6298.968505157445;6459.547831651739;6466.579672321284;6469.417752402118;6488.286288508355;6573.1454910861285;6601.405873471411;6652.201735791542;6672.83317917056;6292.1505596743855;6295.811125666238;6339.397757213057;6339.746410143727;6346.777862774781;6474.870502589828;6475.740970361321;6496.837579060561;6505.739770409131;6507.154069970874;6024.578279520567;6221.720022598904;6228.532860035606;6250.968745156245;6268;6195.81412557624;6226.750929962932;6260.530460215411;6261.467775239155;6288.371162883675;6195.535334849814;6212.627242365473;6227.470664993526;6239.376062393906;6244.469220116341;6104.519788040188;6209.534284928558;6247.468965137832;6251.218597675291;6256.593321434092;5912.763489460373;6164.075388691732;6183.752649894134;6234.470070044097;6253.437190652863 14:43:56 INFO - PID 1918 | |1;ext.html;747.9364254038406;783.2989474420394;794.9324307433868;1116.754314050909;1132.9206955513118;25951.610725839128;26626;32605.67394326059;36378;36453.45319820205;38380;38675.613243867556;38785.80607096961;38798.61201387985;38815.41776873349;8233.711820086282;8395.748127556153;8414.78963025923;8429.578521073921;8430.747077587683;5070.974645126787;6072.483838873701;7520.247975202491;8263.628136733862;8409.159084091603;8443.957780211122;8502.44734092285;8510.48937063775;8512.106228845974;8558.443701159405;8382.245597896188;8456.112108228608;8456.704015359495;8472.661093556251;8474.661013559451;8299.875501867476;8301.750947471524;8340.582970851434;8350.290225330855;8361.749147525585;36305.09237269063;36306.63693363059;36308.63691363079;36373;36413;3603.3153700796765;3650.6166852480374;3650.6166852480637;3652.652997965189;3658.2500587379523;29819.403611927857;29834.850825745732;29870.253243668863;29906;29949.550756738667;3105.3323535439763;3181.077487528614;3186.2512309607223;3191.4095892260007;3193.8722451101926;267675;270550.2944970545;271435;272322;272870.999999998;47483.28775068377;47579.76210118927;47599.28808542997;47623.57129286127;47708.284375734394;48824;48890.511094889305;48900.26649600259;48903;48946;13753.106048106842;13866.653333666538;13874.583762487142;13882.375293111632;13897.0966887152;11305.378204198683;11306.038986686059;11307.943460282646;11309.660710178709;11329.546818127348;9953.004699530135;10039.397636141708;10060.195184385231;11475.368854713071;11714.94142529299;5142.537171654569;5198.610104242121;5198.636095473356;5217.426083130853;5226.843194704165;986.9309148359546;990.0792263195153;994.9204063674889;1031.2523420520213;1037.273908264218;22049.559008819735;22326.88836555807;23884.52230955371;24115.155969541334;24127.879360603434;1087.8477013218155;1098.3025778630627;1133.1897693149438;1139.3562637110006;1151;11830.822537661941;12200.51197952072;12267.447964841604;12312.076594255466;12339.259644421363;299192;303855;304274;305560;306028;50680.732981675756;50709.98580028379;50729.746351268004;50840.745796270785;50857;1458.8759955403698;1497.4160077569757;1515.6438237014293;1517.544736579022;1526.7557190849411;23605;23665.64501532444;23681.881590591936;23717.52564948726;23828.285151445485;36503.26993460063;36575;36627;36629.26741465209;36653;233686.83156584107;261373;261880;262399.68800155877;262713;31887;32679.673203268612;32703.672963270063;32773.34453310968;32967.50548741723;36389;36559.81720091489;36572.45141322829;36637.81681091578;43911.78044109759;25853.612195817455;27238.455230895666;29904.663823745872;30202.69797301999;30298.97144227915;29488.410231794816;29532.409351813272;29987.100386988426;30337.24156896095;30421;30421.239469013453;35351.11622209465;35954;36077.27845443129;36173.27653446969;28943;29347;29810.701892980793;30850.53724194094;31112.533311999887;22559;23638.045244344456;23805.404864877823;23919.88040059858;24222 14:43:56 INFO - PID 1918 | |2;jquery.html;424.9061911389354;430.91409647687806;436.28667129243695;440.3197060541463;456.5754844883962;18302.176402061905;20354.491137721565;20882.269120580782;20966.37100886972;20984.89507552462;17651;21546.89226553869;22079.44801379966;22115.889420552874;22143.44641383966;6019.428154325332;6311.431971122598;6316.115743795872;6323.494120470375;6335.493160547145;4766.904661906759;4832.275158726184;4889.926651100236;5198.662086964354;6108.114323423101;4766.142094423002;4793.7363445010515;4809.951900481003;4814.855554333358;4839.830605928793;4752.263399173134;4800.615950723934;5340.519353258225;6081.391860813927;6189.845253868644;5455.263539422167;5465.480779325958;5471.671699697991;5479.726013699299;5481.232627432163;26110.69446527666;26252;26709.73290267092;26716.86641566799;27028.324291892663;2205.9889700551553;2238.350878245307;2241.069955968271;2242.6748121522287;2248.7751224877543;15035.473758418402;17028.233729482203;17573.648527029516;17781.7332740009;17825.554361140945;2068.4932191613;2113.6406810842195;2139.4009677290383;2158.7949144831214;2163.4807646164963;146024.269878651;146883.98370122176;147391;148246;150612.9999999989;11482.655520334403;12106.515739370327;12116.81824772629;12119.272843629411;12180.57367992116;16154.030758154548;16198.595035124215;16210.594735131715;16222.783291253203;16250.51248462548;8614.569271536398;8775.692850750193;8796.12038796128;8874.51190184546;8948.373613847098;8330.541820199825;8347.791305217297;8508.234258916727;8509.914900851036;8561.82876342482;7338.596377199198;7415.1843297237265;7475.850482990419;7548.320651141424;7567.432442566829;2149.98925005374;2152.322018564147;2153.3970488263312;2170.9674354884373;2174.8695078295355;821.9136990616018;952.2953014769159;972.6595691507915;1009.65671671632;1014.3457469931852;15812.683746325009;21019.057331973538;21059;21399.786002140092;21410.464738381354;988.367444835306;989.8564708117427;1021;1024.8360262358135;1026.958921643126;9971.40171589707;10163.644272450429;10441.321314114559;10787.460626968621;10869.021788039114;418163;494536;509140;515115;516770;130868;133027.99999999805;133077.33461332825;133994.3300283512;134307.65692343147;1192.9403529823473;1194.6774370919977;1216.1365430544413;1219.8841110094527;1222.4926655437894;14633.341499632756;20781.58436831285;21868.125274988823;22274.888625556767;22402.215922442636;54190.18714719204;54766;56345.43654563566;56583.717081415976;56646.71676641755;76559;77012;78517.82223266769;79018.6049069751;81172.59413702894;8781.736547903573;8980.754811297176;9070.455772653662;9163.725088247364;9355.345125841126;14163.716725665636;14321.57035288943;14354.49759258421;14747.852521474648;14774.852251477347;11935.343556104497;11943.462544185706;12129.514819407124;12257.38713064361;12269.815952760895;9854.211663066793;11388.963849159958;11390.430478476208;11465.197436179387;11668.008219301115;12076;12299.69250768738;12310.107124825838;12317.876821231674;12402.689932751753;8808.20726134651;9039.412438191497;9114.3559836968;9261.398009129385;9310.44137351734;11831.585894493652;11840.1711880171;12221.877781222074;12272.325022123869;12330 14:43:56 INFO - PID 1918 | |3;mootools.html;1188.780075685998;1462.963425914352;1477.8743806776424;1484.658528538436;1487.3084015932595;11248.437578121091;11741.354225517603;11762.470688819003;11768.823467647991;11793.882061179396;11053.28153670013;11345.602903898365;11741;11745.41272936352;11755.823662645067;2460.655508228845;2515.8364706294124;2516.1319344826006;2521.432677647533;2525.01524405482;2441.8046556275453;2480.6651102101255;2480.937976550583;2486.1298545509017;2487.6268559716004;2390.8804559771943;2490.5392502387026;2492.8753562321904;2498.9750102498924;2499.3501689560753;2461.2247142150163;2470.555300045991;2485.5401750676183;2491.788198003172;2495.2763698527588;2439.9512009759883;2458.483718419134;2483.3046746910713;2489.8381605195605;2497.887595058227;11568.248063875906;11697.3566453845;11699.06407487399;11703.824442633368;11704.590339338083;5400.513953744143;6766.458683305324;6777.62723050232;6778.491613129035;6791.422729068036;3937.0944682722848;4258.510271318807;4323.437953066082;4326.610605045529;4328.50222224445;1231.5566396097397;1247.2703468470954;1291.5866922584776;1301.6420484366874;1302.296759749734;15018.324175412132;15493.302801373853;16557.66884662312;16692.83307166937;16704.916475417667;4844.491328410537;5462.754176062087;5612.5229355504425;5622.91565626516;5625.662460252398;11736.941315293368;11739.178257522062;11739.47172377245;11747.118966077407;11758.823617645741;5399.811006614749;6510.479161667055;6516;6518.348165183538;6527.934720652733;5709.143628455765;6206.844828879314;6227.1282020517165;6231.4391704746795;6233.252009758858;3739.2521495700967;4231.30183519722;4330.545292744279;4350.2387082260475;4375.27807911691;1250.8373911391461;1253.3983687829893;1276.304414094321;1276.527684756646;1279.6225113591513;787.6219414680985;798.8442253760461;801.8035581282624;813.4915677701437;819.3117781063935;6104.328523862371;6604.504662150358;6777.627230502271;6888;6987.685554150075;890.6481939633937;910.5856835139996;914.6204325204966;920.3649481857631;924.6209054287845;3698.5007024051947;4132.925439385721;4345.304751239786;4369.737815731066;4413.713108647928;12506.874931250753;15120.924395377953;15151.772723409158;15180;15221.162836044125;12344.938275308567;14542.781858272134;14879.92560037193;15158.242087895562;15214.847851521565;8348.288600836935;8526.57367131641;8535.359848011549;8536.957315213383;8545.871811922827;6371.808845734636;6589.110470086669;6783.626900520519;6836.863262734618;6860.656967151723;13104.868951310365;13587.980901432235;13588;13644.113132646346;13681.931590341985;13538.323083845966;13684.178949263076;13950.023498355018;14147.64630884236;14259.358328875433;8150.307223886036;8178.46839955401;8281.21328473794;8324.167583241628;8327.167283271867;10475;10577.153827693612;10579.89420105789;10588.047075763217;10605.25763196569;8797.076306987674;9098.135677110664;9197.448153110834;9234.722958311262;9280.071992800666;8536.74389768308;8797.824043518965;8868.556572171494;8968.955155224183;8979.955100224457;7892.723754668559;8078.7172448964;8203.753887383387;8215.876761848458;8230.053543842296;5026.346574945233;5811.895739809423;5882.176495290748;5922.851928701817;6092.116643086639;5946.13781001761;6072.605280656743;6135.386461353829;6163.260408750979;6255.218097737783 14:43:56 INFO - PID 1918 | |4;prototype.html;320.3880588076772;392.76826672263365;397.1164159744568;403.84903026374815;405.0400550694854;5622.91565626516;5849.678267695275;5855.47300742933;5934.1692163097205;5934.673592952386;4167.182447922598;5638.210650508932;5696.458836410545;5806.419358064191;5819.650820950736;4443.84446544371;4479.216137175998;4481.170983368087;4484.932726009112;4489.932651010237;4458.242098843204;4485.147821913843;4491.910161796778;4494.460664720238;4502.639788816887;4052.29084910141;4269.210196113713;4280.507741609708;4445.422095127629;4458.9331160032625;4251.74489530626;4252.298370768819;4253.744775313491;4259.339802330644;4279.358096285551;3660.7803531788177;3661.395869681526;3670.1558641512333;3689.335919534483;3708.2212735325616;4940.2342636891335;5629.155626655994;5643.633163844337;5710.200571919934;5712.457316554921;4445.955540444619;4726.912810053673;5004.674696144739;5020.899582008376;5029.874253143664;6181.938180618181;6184.412480814315;6226;6232;6243.531735119839;4031.455753473273;4095.89760255993;4121.443605113302;4135.7518548886865;4144.772037537934;6196.349383314777;6472.482201423922;6488.870222595521;6534.607923524603;6674.766383176566;3417.2059668674146;3792.6017768133947;3914.6085391460624;4060.5127384714024;4062.8623985284166;3789.8484060637265;3963.8702969654087;4080.449139366207;4133.979330103391;4264.168487145039;4142.813573389205;4960.851174464772;5001.149804533238;5012.674176178537;5028.698278103326;5380.408155102936;5724.513416359573;6253.218347706536;6253.374662533801;6258.405451482102;1220.8341034312211;1241.6709571963436;1307.2287350463273;1436.5115860607443;1442.6609746709514;914.7667344827026;938.1416004356074;951.1962391778935;955.9235261179089;960.2893858544767;5860.413958604106;5911.379305172895;5920.141579470953;5931.7923872665115;5938.792142275;5114.002769459919;5300.31095957523;6038.969805151034;6412.422881940648;6414.294427612959;5617.101263797855;5860.062390017577;5911.438413350811;5991;6003.549733769984;3295.7528185385713;3326.234965957843;3336.816475093893;3340.7494437916766;3348.29685765987;5609.747561359667;6325.778597749057;6562.901556476657;6603.438707709803;6692.732290708414;6676.399124078759;6690.698918548677;6697.631630260285;6697.6986035628515;6732.364523157538;6481.310256243606;6627.801165965126;6647.534672572873;6682.131322927989;6759.188897332351;5239.816606418757;5682.886342273214;5917.6745279010065;6326.240851097714;6542.831163381066;6419.711112999833;6420.335560742426;6420.582662126947;6431.5819471734185;6446.42303964172;5753.367129615655;6363.96818015907;6639.767608133692;6711.811889352519;6733.192016957996;4165.396017577495;4168.270552653335;4170.833166673299;4175.415441838206;4177.8537751178565;5934.842705672352;6246.969250073687;6438.549301548846;6537.411632953057;6553.246376666553;5204.401493828107;5481.698506582176;5965.598084450237;6191;6203.844903877439;5162.6902385856965;5206.73966301691;5601.187827765033;5842;6198.349173336915;5581.2744343236745;5937.554683398676;6083.574149809648;6086.269647642312;6090.69546522681;5218.791248350023;6225.782097626561;6237.126802247598;6237.1891654084675;6264.310925798068;5208.9739551302;5707.571932105026;6055.636661800306;6124.908126378019;6126.94747259673 14:43:56 INFO - PID 1918 | |5;yui.html;694.7186389512249;837.7947402886293;840.1178762299588;844.5144042175747;853.3940901959609;11834.704132396695;13586.048976571645;13591.864081359196;15039.924800375982;17150.399736009243;13823.37794799234;17359.218835152416;17385.391511297075;17541.298348066062;17591.208395622194;979.5543027922296;1002.9448380339079;1005.5927349423495;1007.778288776468;1009;665.2748504130496;1001.5943542865115;1002.939823610582;1003.8895721470633;1005.2058873489934;741.4624397311933;921.5806807902388;1029.9742506437362;1038.2887721910479;1041.8958104189596;1034.596507362133;1034.8551202831609;1035.5081336365242;1036.528379587286;1036.818556752573;757.4962649837851;758.6017340896019;758.6965213914478;761.2729842999922;761.5240474703311;12322.568710095193;12663.620091397273;16291.755623665655;16738.24677889498;16833.91583042077;16264.75602865958;17081.57296067596;17148.142592870307;17321.913390433092;17424.215910284067;13484.258365789878;14110.012299139064;14111.435542578285;14125.505607303798;14191.148531088167;3438.985499277694;3460.567429071366;3467.49721290414;3531.0289670340862;3539.50446937429;128779.35610321982;129275.99999999905;129707;129867;131564.34217828946;11333.94333028346;13127.212367257995;13552.932235338958;13670.31648417595;13683.04218704701;25349.36626584313;25450.745492545208;25706.228813135636;25761.61357579638;25790.35524111875;7343.412526997828;7391.85216295671;7397.18630950595;7411.0736157980255;7417.517861339104;3627.981860090683;3645.5989841117457;3665.560132784083;3712.0719820044988;3721.683656889195;4325.978370108192;4400.053988392511;4403.603675669206;4410.360497727812;4414.27164517851;884.5090974509209;930.8324501589643;954.2795189631784;964.5563041001078;965.4448692002127;645.9741610335534;663.2074670768385;663.5819433756702;671.8824205763972;683.3235097253684;9670.854937175947;11149.331040137618;11917.22538035025;12016.759664806656;12385.690357741129;646.7348387161335;647.2782847125516;649.3928177154376;662.8475450646379;671.4728937783914;4913.091078150482;4931.211006238985;4961.90076198474;4969.676970996946;5105.719185444762;102887.4855625717;104142;104653;105923.41114883283;110290.44854775675;90719;92638.53680731553;93748.06251937394;94637.05362946421;95554.04445955591;81150.59424702839;81814.59092704498;81834.59082704668;81925.59037204777;82265.17734822576;10554.736131596772;11217.66347009591;11320;11426.485808138488;11631.709207269885;39293.41059884047;39564.010899726585;39577.604223957394;39623.207535848545;39674.80162599284;51367;51918;52154.73922630362;52362.73818630882;53165.7341713289;13985.370658320197;14206.502772402917;14245.430182792572;14360.712785744017;14375.784363234769;15276.694466110393;15452.84547154559;15751.68496630084;15891.364345426053;15912.44306449315;14561.27193640335;14639.48761793332;14742.484013059491;14878.77681834795;14923.104613723212;14492.782608260673;14691.485797997446;14752.188629625474;14805.259737013323;14911.105333680014;14143.43426262938;14180.14919104857;14348.06737562055;14515.201663908587;14664;9397.483138427453;10714.410707411167;10997.780044398907;11233.775324493628;11378.658640240807;12132.878671213175;12534.874651253736;13060.346982651019;13122.671933201746;13142.868571314164 14:43:56 INFO - PID 1918 | __end_tp_report 14:43:56 INFO - PID 1918 | __start_cc_report 14:43:56 INFO - PID 1918 | _x_x_mozilla_cycle_collect,1772 14:43:56 INFO - PID 1918 | __end_cc_report 14:43:56 INFO - PID 1918 | __startTimestamp1493329436570__endTimestamp 14:43:56 INFO - PID 1918 | 14:43:56 INFO - PID 1918 | ------- Summary: start ------- 14:43:56 INFO - PID 1918 | Number of tests: 6 14:43:56 INFO - PID 1918 | 14:43:56 INFO - PID 1918 | [#0] dojo.html Cycles:165 Average:5910.91 Median:6187.32 stddev:710.97 (11.5%) stddev-sans-first:676.98 14:43:56 INFO - PID 1918 | Values: 3056.8 3419.4 3420.0 3455.0 3488.7 5710.1 5888.4 6089.6 6110.9 6125.1 5995.2 5997.2 6076.5 6094.5 6126.3 5000.9 5072.6 5113.5 5144.7 5185.7 5215.4 5267.8 5270.1 5271.1 5292.4 5044.0 5052.1 5086.9 5164.6 5251.2 4348.7 5255.9 5259.7 5270.2 5271.3 5169.9 5192.8 5212.4 5223.9 5241.7 6023.5 6051.5 6055.8 6056.4 6063.5 6233.5 6286.9 6311.0 6320.7 6364.8 6296.7 6364.5 6441.7 6459.9 6471.7 5001.3 6054.2 6092.5 6121.8 6135.4 6585.4 6587.5 6611.1 6615.5 6628.8 6155.9 6189.8 6277.0 6287.8 6289.5 6419.6 6433.8 6449.9 6450.0 6480.9 6274.2 6311.5 6314.4 6344.9 6368.8 6187.3 6252.6 6285.2 6308.3 6318.1 5029.0 5033.5 5100.7 5139.5 5156.9 4403.2 4481.7 4633.1 4651.9 4663.9 6022.8 6072.8 6082.7 6100.0 6104.7 6186.9 6391.0 6413.2 6432.9 6445.4 5980.4 5989.8 6081.9 6106.2 6115.3 5579.2 5615.0 5630.4 5634.5 5690.4 6681.9 6725.3 6727.9 6741.1 6769.0 6197.6 6299.0 6459.5 6466.6 6469.4 6488.3 6573.1 6601.4 6652.2 6672.8 6292.2 6295.8 6339.4 6339.7 6346.8 6474.9 6475.7 6496.8 6505.7 6507.2 6024.6 6221.7 6228.5 6251.0 6268.0 6195.8 6226.8 6260.5 6261.5 6288.4 6195.5 6212.6 6227.5 6239.4 6244.5 6104.5 6209.5 6247.5 6251.2 6256.6 5912.8 6164.1 6183.8 6234.5 6253.4 14:43:56 INFO - PID 1918 | 14:43:56 INFO - PID 1918 | [#1] ext.html Cycles:180 Average:42264.77 Median:3192.64 stddev:72771.18 (2279.3%) stddev-sans-first:72908.56 14:43:56 INFO - PID 1918 | Values: 747.9 783.3 794.9 1116.8 1132.9 25951.6 26626.0 32605.7 36378.0 36453.5 38380.0 38675.6 38785.8 38798.6 38815.4 8233.7 8395.7 8414.8 8429.6 8430.7 5071.0 6072.5 7520.2 8263.6 8409.2 8444.0 8502.4 8510.5 8512.1 8558.4 8382.2 8456.1 8456.7 8472.7 8474.7 8299.9 8301.8 8340.6 8350.3 8361.7 36305.1 36306.6 36308.6 36373.0 36413.0 3603.3 3650.6 3650.6 3652.7 3658.3 29819.4 29834.9 29870.3 29906.0 29949.6 3105.3 3181.1 3186.3 3191.4 3193.9 267675.0 270550.3 271435.0 272322.0 272871.0 47483.3 47579.8 47599.3 47623.6 47708.3 48824.0 48890.5 48900.3 48903.0 48946.0 13753.1 13866.7 13874.6 13882.4 13897.1 11305.4 11306.0 11307.9 11309.7 11329.5 9953.0 10039.4 10060.2 11475.4 11714.9 5142.5 5198.6 5198.6 5217.4 5226.8 986.9 990.1 994.9 1031.3 1037.3 22049.6 22326.9 23884.5 24115.2 24127.9 1087.8 1098.3 1133.2 1139.4 1151.0 11830.8 12200.5 12267.4 12312.1 12339.3 299192.0 303855.0 304274.0 305560.0 306028.0 50680.7 50710.0 50729.7 50840.7 50857.0 1458.9 1497.4 1515.6 1517.5 1526.8 23605.0 23665.6 23681.9 23717.5 23828.3 36503.3 36575.0 36627.0 36629.3 36653.0 233686.8 261373.0 261880.0 262399.7 262713.0 31887.0 32679.7 32703.7 32773.3 32967.5 36389.0 36559.8 36572.5 36637.8 43911.8 25853.6 27238.5 29904.7 30202.7 30299.0 29488.4 29532.4 29987.1 30337.2 30421.0 30421.2 35351.1 35954.0 36077.3 36173.3 28943.0 29347.0 29810.7 30850.5 31112.5 22559.0 23638.0 23805.4 23919.9 24222.0 14:43:56 INFO - PID 1918 | 14:43:56 INFO - PID 1918 | [#2] jquery.html Cycles:180 Average:33674.36 Median:22129.67 stddev:84353.47 (381.2%) stddev-sans-first:84553.16 14:43:56 INFO - PID 1918 | Values: 424.9 430.9 436.3 440.3 456.6 18302.2 20354.5 20882.3 20966.4 20984.9 17651.0 21546.9 22079.4 22115.9 22143.4 6019.4 6311.4 6316.1 6323.5 6335.5 4766.9 4832.3 4889.9 5198.7 6108.1 4766.1 4793.7 4810.0 4814.9 4839.8 4752.3 4800.6 5340.5 6081.4 6189.8 5455.3 5465.5 5471.7 5479.7 5481.2 26110.7 26252.0 26709.7 26716.9 27028.3 2206.0 2238.4 2241.1 2242.7 2248.8 15035.5 17028.2 17573.6 17781.7 17825.6 2068.5 2113.6 2139.4 2158.8 2163.5 146024.3 146884.0 147391.0 148246.0 150613.0 11482.7 12106.5 12116.8 12119.3 12180.6 16154.0 16198.6 16210.6 16222.8 16250.5 8614.6 8775.7 8796.1 8874.5 8948.4 8330.5 8347.8 8508.2 8509.9 8561.8 7338.6 7415.2 7475.9 7548.3 7567.4 2150.0 2152.3 2153.4 2171.0 2174.9 821.9 952.3 972.7 1009.7 1014.3 15812.7 21019.1 21059.0 21399.8 21410.5 988.4 989.9 1021.0 1024.8 1027.0 9971.4 10163.6 10441.3 10787.5 10869.0 418163.0 494536.0 509140.0 515115.0 516770.0 130868.0 133028.0 133077.3 133994.3 134307.7 1192.9 1194.7 1216.1 1219.9 1222.5 14633.3 20781.6 21868.1 22274.9 22402.2 54190.2 54766.0 56345.4 56583.7 56646.7 76559.0 77012.0 78517.8 79018.6 81172.6 8781.7 8980.8 9070.5 9163.7 9355.3 14163.7 14321.6 14354.5 14747.9 14774.9 11935.3 11943.5 12129.5 12257.4 12269.8 9854.2 11389.0 11390.4 11465.2 11668.0 12076.0 12299.7 12310.1 12317.9 12402.7 8808.2 9039.4 9114.4 9261.4 9310.4 11831.6 11840.2 12221.9 12272.3 12330.0 14:43:56 INFO - PID 1918 | 14:43:56 INFO - PID 1918 | [#3] mootools.html Cycles:180 Average:7024.89 Median:3718.88 stddev:4444.19 (119.5%) stddev-sans-first:4435.01 14:43:56 INFO - PID 1918 | Values: 1188.8 1463.0 1477.9 1484.7 1487.3 11248.4 11741.4 11762.5 11768.8 11793.9 11053.3 11345.6 11741.0 11745.4 11755.8 2460.7 2515.8 2516.1 2521.4 2525.0 2441.8 2480.7 2480.9 2486.1 2487.6 2390.9 2490.5 2492.9 2499.0 2499.4 2461.2 2470.6 2485.5 2491.8 2495.3 2440.0 2458.5 2483.3 2489.8 2497.9 11568.2 11697.4 11699.1 11703.8 11704.6 5400.5 6766.5 6777.6 6778.5 6791.4 3937.1 4258.5 4323.4 4326.6 4328.5 1231.6 1247.3 1291.6 1301.6 1302.3 15018.3 15493.3 16557.7 16692.8 16704.9 4844.5 5462.8 5612.5 5622.9 5625.7 11736.9 11739.2 11739.5 11747.1 11758.8 5399.8 6510.5 6516.0 6518.3 6527.9 5709.1 6206.8 6227.1 6231.4 6233.3 3739.3 4231.3 4330.5 4350.2 4375.3 1250.8 1253.4 1276.3 1276.5 1279.6 787.6 798.8 801.8 813.5 819.3 6104.3 6604.5 6777.6 6888.0 6987.7 890.6 910.6 914.6 920.4 924.6 3698.5 4132.9 4345.3 4369.7 4413.7 12506.9 15120.9 15151.8 15180.0 15221.2 12344.9 14542.8 14879.9 15158.2 15214.8 8348.3 8526.6 8535.4 8537.0 8545.9 6371.8 6589.1 6783.6 6836.9 6860.7 13104.9 13588.0 13588.0 13644.1 13681.9 13538.3 13684.2 13950.0 14147.6 14259.4 8150.3 8178.5 8281.2 8324.2 8327.2 10475.0 10577.2 10579.9 10588.0 10605.3 8797.1 9098.1 9197.4 9234.7 9280.1 8536.7 8797.8 8868.6 8969.0 8980.0 7892.7 8078.7 8203.8 8215.9 8230.1 5026.3 5811.9 5882.2 5922.9 6092.1 5946.1 6072.6 6135.4 6163.3 6255.2 14:43:56 INFO - PID 1918 | 14:43:56 INFO - PID 1918 | [#4] prototype.html Cycles:180 Average:5006.48 Median:5689.67 stddev:1582.23 (27.8%) stddev-sans-first:1547.08 14:43:56 INFO - PID 1918 | Values: 320.4 392.8 397.1 403.8 405.0 5622.9 5849.7 5855.5 5934.2 5934.7 4167.2 5638.2 5696.5 5806.4 5819.7 4443.8 4479.2 4481.2 4484.9 4489.9 4458.2 4485.1 4491.9 4494.5 4502.6 4052.3 4269.2 4280.5 4445.4 4458.9 4251.7 4252.3 4253.7 4259.3 4279.4 3660.8 3661.4 3670.2 3689.3 3708.2 4940.2 5629.2 5643.6 5710.2 5712.5 4446.0 4726.9 5004.7 5020.9 5029.9 6181.9 6184.4 6226.0 6232.0 6243.5 4031.5 4095.9 4121.4 4135.8 4144.8 6196.3 6472.5 6488.9 6534.6 6674.8 3417.2 3792.6 3914.6 4060.5 4062.9 3789.8 3963.9 4080.4 4134.0 4264.2 4142.8 4960.9 5001.1 5012.7 5028.7 5380.4 5724.5 6253.2 6253.4 6258.4 1220.8 1241.7 1307.2 1436.5 1442.7 914.8 938.1 951.2 955.9 960.3 5860.4 5911.4 5920.1 5931.8 5938.8 5114.0 5300.3 6039.0 6412.4 6414.3 5617.1 5860.1 5911.4 5991.0 6003.5 3295.8 3326.2 3336.8 3340.7 3348.3 5609.7 6325.8 6562.9 6603.4 6692.7 6676.4 6690.7 6697.6 6697.7 6732.4 6481.3 6627.8 6647.5 6682.1 6759.2 5239.8 5682.9 5917.7 6326.2 6542.8 6419.7 6420.3 6420.6 6431.6 6446.4 5753.4 6364.0 6639.8 6711.8 6733.2 4165.4 4168.3 4170.8 4175.4 4177.9 5934.8 6247.0 6438.5 6537.4 6553.2 5204.4 5481.7 5965.6 6191.0 6203.8 5162.7 5206.7 5601.2 5842.0 6198.3 5581.3 5937.6 6083.6 6086.3 6090.7 5218.8 6225.8 6237.1 6237.2 6264.3 5209.0 5707.6 6055.6 6124.9 6126.9 14:43:56 INFO - PID 1918 | 14:43:56 INFO - PID 1918 | [#5] yui.html Cycles:180 Average:21381.39 Median:17114.86 stddev:31294.56 (182.9%) stddev-sans-first:31343.80 14:43:56 INFO - PID 1918 | Values: 694.7 837.8 840.1 844.5 853.4 11834.7 13586.0 13591.9 15039.9 17150.4 13823.4 17359.2 17385.4 17541.3 17591.2 979.6 1002.9 1005.6 1007.8 1009.0 665.3 1001.6 1002.9 1003.9 1005.2 741.5 921.6 1030.0 1038.3 1041.9 1034.6 1034.9 1035.5 1036.5 1036.8 757.5 758.6 758.7 761.3 761.5 12322.6 12663.6 16291.8 16738.2 16833.9 16264.8 17081.6 17148.1 17321.9 17424.2 13484.3 14110.0 14111.4 14125.5 14191.1 3439.0 3460.6 3467.5 3531.0 3539.5 128779.4 129276.0 129707.0 129867.0 131564.3 11333.9 13127.2 13552.9 13670.3 13683.0 25349.4 25450.7 25706.2 25761.6 25790.4 7343.4 7391.9 7397.2 7411.1 7417.5 3628.0 3645.6 3665.6 3712.1 3721.7 4326.0 4400.1 4403.6 4410.4 4414.3 884.5 930.8 954.3 964.6 965.4 646.0 663.2 663.6 671.9 683.3 9670.9 11149.3 11917.2 12016.8 12385.7 646.7 647.3 649.4 662.8 671.5 4913.1 4931.2 4961.9 4969.7 5105.7 102887.5 104142.0 104653.0 105923.4 110290.4 90719.0 92638.5 93748.1 94637.1 95554.0 81150.6 81814.6 81834.6 81925.6 82265.2 10554.7 11217.7 11320.0 11426.5 11631.7 39293.4 39564.0 39577.6 39623.2 39674.8 51367.0 51918.0 52154.7 52362.7 53165.7 13985.4 14206.5 14245.4 14360.7 14375.8 15276.7 15452.8 15751.7 15891.4 15912.4 14561.3 14639.5 14742.5 14878.8 14923.1 14492.8 14691.5 14752.2 14805.3 14911.1 14143.4 14180.1 14348.1 14515.2 14664.0 9397.5 10714.4 10997.8 11233.8 11378.7 12132.9 12534.9 13060.3 13122.7 13142.9 14:43:56 INFO - PID 1918 | -------- Summary: end -------- 14:43:56 INFO - PID 1918 | 14:43:57 INFO - TEST-INFO | 1918: exit 0 14:43:57 INFO - TEST-OK | dromaeo_css | took 1117480ms 14:43:57 INFO - TEST-START | kraken 14:43:57 INFO - operating with platform_type : mac_ 14:43:57 INFO - Initialising browser for kraken test... 14:43:57 INFO - TEST-INFO | started process 1923 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/tmp7bniPW/profile http://localhost:52471/getInfo.html) 14:43:59 INFO - PID 1923 | __metrics Screen width/height:1600/1200 14:43:59 INFO - PID 1923 | colorDepth:24 14:43:59 INFO - PID 1923 | Browser inner width/height: 1024/689 14:43:59 INFO - PID 1923 | __metrics 14:43:59 INFO - PID 1923 | 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" 14:43:59 INFO - PID 1923 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 334: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 14:44:00 INFO - TEST-INFO | 1923: exit 0 14:44:00 INFO - Browser initialized. 14:44:00 INFO - Running cycle 1/1 for kraken test... 14:44:00 INFO - TEST-INFO | started process 1924 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/tmp7bniPW/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:44:13 INFO - PID 1924 | RSS: Main: 242864128 14:44:13 INFO - PID 1924 | 14:44:15 INFO - PID 1924 | Cycle 1(1): loaded http://localhost:52471/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:52471/tests/kraken/driver.html?testName=audio-beat-detection) 14:44:16 INFO - PID 1924 | RSS: Main: 310169600 14:44:16 INFO - PID 1924 | 14:44:19 INFO - PID 1924 | Cycle 1(1): loaded http://localhost:52471/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:52471/tests/kraken/driver.html?testName=audio-dft) 14:44:20 INFO - PID 1924 | RSS: Main: 291962880 14:44:20 INFO - PID 1924 | 14:44:23 INFO - PID 1924 | Cycle 1(1): loaded http://localhost:52471/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:52471/tests/kraken/driver.html?testName=audio-fft) 14:44:24 INFO - PID 1924 | RSS: Main: 386138112 14:44:24 INFO - PID 1924 | 14:44:26 INFO - PID 1924 | Cycle 1(1): loaded http://localhost:52471/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:52471/tests/kraken/driver.html?testName=audio-oscillator) 14:44:26 INFO - PID 1924 | RSS: Main: 289411072 14:44:26 INFO - PID 1924 | 14:44:28 INFO - PID 1924 | Cycle 1(1): loaded http://localhost:52471/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:52471/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:44:29 INFO - PID 1924 | RSS: Main: 291471360 14:44:29 INFO - PID 1924 | 14:44:32 INFO - PID 1924 | Cycle 1(1): loaded http://localhost:52471/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:52471/tests/kraken/driver.html?testName=imaging-darkroom) 14:44:32 INFO - PID 1924 | RSS: Main: 354324480 14:44:32 INFO - PID 1924 | 14:44:35 INFO - PID 1924 | Cycle 1(1): loaded http://localhost:52471/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:52471/tests/kraken/driver.html?testName=imaging-desaturate) 14:44:36 INFO - PID 1924 | RSS: Main: 376909824 14:44:36 INFO - PID 1924 | 14:44:39 INFO - PID 1924 | Cycle 1(1): loaded http://localhost:52471/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:52471/tests/kraken/driver.html?testName=json-parse-financial) 14:44:39 INFO - PID 1924 | RSS: Main: 391356416 14:44:39 INFO - PID 1924 | 14:44:41 INFO - PID 1924 | Cycle 1(1): loaded http://localhost:52471/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:52471/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:44:42 INFO - PID 1924 | RSS: Main: 332374016 14:44:42 INFO - PID 1924 | 14:44:43 INFO - PID 1924 | Cycle 1(1): loaded http://localhost:52471/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:52471/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:44:44 INFO - PID 1924 | RSS: Main: 333148160 14:44:44 INFO - PID 1924 | 14:44:46 INFO - PID 1924 | Cycle 1(1): loaded http://localhost:52471/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:52471/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:44:47 INFO - PID 1924 | RSS: Main: 317730816 14:44:47 INFO - PID 1924 | 14:44:50 INFO - PID 1924 | Cycle 1(1): loaded http://localhost:52471/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:52471/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:44:51 INFO - PID 1924 | RSS: Main: 332075008 14:44:51 INFO - PID 1924 | 14:44:54 INFO - PID 1924 | Cycle 1(1): loaded http://localhost:52471/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:52471/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:44:54 INFO - PID 1924 | RSS: Main: 343257088 14:44:54 INFO - PID 1924 | 14:44:56 INFO - PID 1924 | Cycle 1(1): loaded http://localhost:52471/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:52471/tests/kraken/driver.html?testName=ai-astar) 14:44:56 INFO - PID 1924 | RSS: Main: 385904640 14:44:56 INFO - PID 1924 | 14:44:56 INFO - PID 1924 | __start_tp_report 14:44:56 INFO - PID 1924 | _x_x_mozilla_page_load 14:44:56 INFO - PID 1924 | _x_x_mozilla_page_load_details 14:44:56 INFO - PID 1924 | |i|pagename|runs| 14:44:56 INFO - PID 1924 | |0;ai-astar;111;110;109;109;110;110;111;110;112;111 14:44:56 INFO - PID 1924 | |1;audio-beat-detection;138;108;127;165;130;139;139;139;145;124 14:44:56 INFO - PID 1924 | |2;audio-dft;185;187;185;198;182;186;184;186;181;184 14:44:56 INFO - PID 1924 | |3;audio-fft;81;58;56;90;57;61;57;58;81;58 14:44:56 INFO - PID 1924 | |4;audio-oscillator;85;71;86;69;69;68;90;69;70;112 14:44:56 INFO - PID 1924 | |5;imaging-gaussian-blur;91;90;91;91;92;90;92;90;91;91 14:44:56 INFO - PID 1924 | |6;imaging-darkroom;96;96;96;95;96;96;97;96;97;97 14:44:56 INFO - PID 1924 | |7;imaging-desaturate;84;86;84;84;83;86;84;87;83;85 14:44:56 INFO - PID 1924 | |8;json-parse-financial;49;47;49;46;47;49;47;48;48;48 14:44:56 INFO - PID 1924 | |9;json-stringify-tinderbox;55;53;62;57;66;58;56;55;72;80 14:44:56 INFO - PID 1924 | |10;stanford-crypto-aes;83;84;81;82;84;81;80;86;101;103 14:44:56 INFO - PID 1924 | |11;stanford-crypto-ccm;139;136;137;135;139;144;148;141;193;144 14:44:56 INFO - PID 1924 | |12;stanford-crypto-pbkdf2;189;185;183;182;188;181;186;186;185;182 14:44:56 INFO - PID 1924 | |13;stanford-crypto-sha256-iterative;68;68;67;67;67;67;69;69;67;68 14:44:56 INFO - PID 1924 | __end_tp_report 14:44:56 INFO - PID 1924 | __start_cc_report 14:44:56 INFO - PID 1924 | _x_x_mozilla_cycle_collect,2226 14:44:56 INFO - PID 1924 | __end_cc_report 14:44:56 INFO - PID 1924 | __startTimestamp1493329496697__endTimestamp 14:44:56 INFO - PID 1924 | 14:44:56 INFO - PID 1924 | ------- Summary: start ------- 14:44:56 INFO - PID 1924 | Number of tests: 14 14:44:56 INFO - PID 1924 | 14:44:56 INFO - PID 1924 | [#0] ai-astar Cycles:10 Average:110.30 Median:110.50 stddev:0.95 (0.9%) stddev-sans-first:0.97 14:44:56 INFO - PID 1924 | Values: 111.0 110.0 109.0 109.0 110.0 110.0 111.0 110.0 112.0 111.0 14:44:56 INFO - PID 1924 | 14:44:56 INFO - PID 1924 | [#1] audio-beat-detection Cycles:10 Average:135.40 Median:139.00 stddev:14.89 (10.7%) stddev-sans-first:15.76 14:44:56 INFO - PID 1924 | Values: 138.0 108.0 127.0 165.0 130.0 139.0 139.0 139.0 145.0 124.0 14:44:56 INFO - PID 1924 | 14:44:56 INFO - PID 1924 | [#2] audio-dft Cycles:10 Average:185.80 Median:185.50 stddev:4.66 (2.5%) stddev-sans-first:4.94 14:44:56 INFO - PID 1924 | Values: 185.0 187.0 185.0 198.0 182.0 186.0 184.0 186.0 181.0 184.0 14:44:56 INFO - PID 1924 | 14:44:56 INFO - PID 1924 | [#3] audio-fft Cycles:10 Average:65.70 Median:59.50 stddev:12.93 (21.7%) stddev-sans-first:12.47 14:44:56 INFO - PID 1924 | Values: 81.0 58.0 56.0 90.0 57.0 61.0 57.0 58.0 81.0 58.0 14:44:56 INFO - PID 1924 | 14:44:56 INFO - PID 1924 | [#4] audio-oscillator Cycles:10 Average:78.90 Median:70.50 stddev:14.38 (20.4%) stddev-sans-first:15.08 14:44:56 INFO - PID 1924 | Values: 85.0 71.0 86.0 69.0 69.0 68.0 90.0 69.0 70.0 112.0 14:44:56 INFO - PID 1924 | 14:44:56 INFO - PID 1924 | [#5] imaging-gaussian-blur Cycles:10 Average:90.90 Median:91.00 stddev:0.74 (0.8%) stddev-sans-first:0.78 14:44:56 INFO - PID 1924 | Values: 91.0 90.0 91.0 91.0 92.0 90.0 92.0 90.0 91.0 91.0 14:44:56 INFO - PID 1924 | 14:44:56 INFO - PID 1924 | [#6] imaging-darkroom Cycles:10 Average:96.20 Median:96.00 stddev:0.63 (0.7%) stddev-sans-first:0.67 14:44:56 INFO - PID 1924 | Values: 96.0 96.0 96.0 95.0 96.0 96.0 97.0 96.0 97.0 97.0 14:44:56 INFO - PID 1924 | 14:44:56 INFO - PID 1924 | [#7] imaging-desaturate Cycles:10 Average:84.60 Median:84.50 stddev:1.35 (1.6%) stddev-sans-first:1.41 14:44:56 INFO - PID 1924 | Values: 84.0 86.0 84.0 84.0 83.0 86.0 84.0 87.0 83.0 85.0 14:44:56 INFO - PID 1924 | 14:44:56 INFO - PID 1924 | [#8] json-parse-financial Cycles:10 Average:47.80 Median:48.00 stddev:1.03 (2.2%) stddev-sans-first:1.00 14:44:56 INFO - PID 1924 | Values: 49.0 47.0 49.0 46.0 47.0 49.0 47.0 48.0 48.0 48.0 14:44:56 INFO - PID 1924 | 14:44:56 INFO - PID 1924 | [#9] json-stringify-tinderbox Cycles:10 Average:61.40 Median:60.00 stddev:8.77 (14.6%) stddev-sans-first:8.99 14:44:56 INFO - PID 1924 | Values: 55.0 53.0 62.0 57.0 66.0 58.0 56.0 55.0 72.0 80.0 14:44:56 INFO - PID 1924 | 14:44:56 INFO - PID 1924 | [#10] stanford-crypto-aes Cycles:10 Average:86.50 Median:82.50 stddev:8.37 (10.1%) stddev-sans-first:8.78 14:44:56 INFO - PID 1924 | Values: 83.0 84.0 81.0 82.0 84.0 81.0 80.0 86.0 101.0 103.0 14:44:56 INFO - PID 1924 | 14:44:56 INFO - PID 1924 | [#11] stanford-crypto-ccm Cycles:10 Average:145.60 Median:142.50 stddev:17.14 (12.0%) stddev-sans-first:18.01 14:44:56 INFO - PID 1924 | Values: 139.0 136.0 137.0 135.0 139.0 144.0 148.0 141.0 193.0 144.0 14:44:56 INFO - PID 1924 | 14:44:56 INFO - PID 1924 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:184.70 Median:185.50 stddev:2.67 (1.4%) stddev-sans-first:2.33 14:44:56 INFO - PID 1924 | Values: 189.0 185.0 183.0 182.0 188.0 181.0 186.0 186.0 185.0 182.0 14:44:56 INFO - PID 1924 | 14:44:56 INFO - PID 1924 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.70 Median:68.00 stddev:0.82 (1.2%) stddev-sans-first:0.87 14:44:56 INFO - PID 1924 | Values: 68.0 68.0 67.0 67.0 67.0 67.0 69.0 69.0 67.0 68.0 14:44:56 INFO - PID 1924 | -------- Summary: end -------- 14:44:56 INFO - PID 1924 | 14:44:57 INFO - TEST-INFO | 1924: exit 0 14:44:57 INFO - TEST-OK | kraken | took 60560ms 14:44:57 INFO - SUITE-END | took 1178s 14:44:57 INFO - Completed test suite (00:19:38) 14:44:57 INFO - javascript benchmark 14:44:57 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7607.465475787845, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3056.81659100454, 3419.4016047191767, 3420.0081976226897, 3454.9654503454967, 3488.738344624154, 5710.1434784782305, 5888.381719919411, 6089.634621922688, 6110.908336374952, 6125.111858780479, 5995.160677505153, 5997.160397544348, 6076.513878889689, 6094.542909281799, 6126.326104128542, 5000.924986125211, 5072.594192464612, 5113.488651134894, 5144.742762861861, 5185.662931909433, 5215.374155101393, 5267.789288428458, 5270.130428479296, 5271.130263506536, 5292.444293349201, 5043.9747801260755, 5052.141136006888, 5086.898262034775, 5164.612654050924, 5251.2385704072885, 4348.652107831366, 5255.894882102337, 5259.710715910624, 5270.209468579706, 5271.288376069258, 5169.948300516984, 5192.766325515361, 5212.374515058179, 5223.921641175385, 5241.659292145999, 6023.518118550549, 6051.485623721989, 6055.788047418363, 6056.394360563952, 6063.545234107415, 6233.470155036827, 6286.937130628727, 6310.9684451577905, 6320.683965801692, 6364.840878978016, 6296.685165741695, 6364.522660800459, 6441.677916104176, 6459.935400645981, 6471.741130354781, 5001.299818025515, 6054.152418661391, 6092.482139018189, 6121.846953826101, 6135.386461353829, 6585.440237579859, 6587.50593705474, 6611.140551728245, 6615.503837212228, 6628.83427914306, 6155.907661385083, 6189.752409903554, 6276.968615156895, 6287.7799277026, 6289.465395441439, 6419.582727122722, 6433.774817881352, 6449.935500644933, 6449.967750161313, 6480.870382592322, 6274.215723034621, 6311.526635502264, 6314.4317011468265, 6344.857925573348, 6368.808935731936, 6187.319394866561, 6252.562320637603, 6285.245770507477, 6308.3060863305, 6318.115463835067, 5028.974855125701, 5033.496650334937, 5100.693958362436, 5139.486051394831, 5156.92264616031, 4403.207422663952, 4481.663875209372, 4633.0733853229485, 4651.883702907455, 4663.883402914887, 6022.759089636365, 6072.757089716361, 6082.695865206722, 6100.0, 6104.664243466563, 6186.907196392058, 6391.0, 6413.230412350548, 6432.871342573122, 6445.355464453517, 5980.43185897339, 5989.790357337472, 6081.908771368433, 6106.248323414603, 6115.301188036035, 5579.19101730255, 5615.0, 5630.352509461464, 5634.4928956393305, 5690.430956904359, 6681.866362672719, 6725.293844146392, 6727.865442691216, 6741.056252124608, 6769.018492318488, 6197.628142311476, 6298.968505157445, 6459.547831651739, 6466.579672321284, 6469.417752402118, 6488.286288508355, 6573.1454910861285, 6601.405873471411, 6652.201735791542, 6672.83317917056, 6292.1505596743855, 6295.811125666238, 6339.397757213057, 6339.746410143727, 6346.777862774781, 6474.870502589828, 6475.740970361321, 6496.837579060561, 6505.739770409131, 6507.154069970874, 6024.578279520567, 6221.720022598904, 6228.532860035606, 6250.968745156245, 6268.0, 6195.81412557624, 6226.750929962932, 6260.530460215411, 6261.467775239155, 6288.371162883675, 6195.535334849814, 6212.627242365473, 6227.470664993526, 6239.376062393906, 6244.469220116341, 6104.519788040188, 6209.534284928558, 6247.468965137832, 6251.218597675291, 6256.593321434092, 5912.763489460373, 6164.075388691732, 6183.752649894134, 6234.470070044097, 6253.437190652863], "value": 5861.625080586096, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [747.9364254038406, 783.2989474420394, 794.9324307433868, 1116.754314050909, 1132.9206955513118, 25951.610725839128, 26626.0, 32605.67394326059, 36378.0, 36453.45319820205, 38380.0, 38675.613243867556, 38785.80607096961, 38798.61201387985, 38815.41776873349, 8233.711820086282, 8395.748127556153, 8414.78963025923, 8429.578521073921, 8430.747077587683, 5070.974645126787, 6072.483838873701, 7520.247975202491, 8263.628136733862, 8409.159084091603, 8443.957780211122, 8502.44734092285, 8510.48937063775, 8512.106228845974, 8558.443701159405, 8382.245597896188, 8456.112108228608, 8456.704015359495, 8472.661093556251, 8474.661013559451, 8299.875501867476, 8301.750947471524, 8340.582970851434, 8350.290225330855, 8361.749147525585, 36305.09237269063, 36306.63693363059, 36308.63691363079, 36373.0, 36413.0, 3603.3153700796765, 3650.6166852480374, 3650.6166852480637, 3652.652997965189, 3658.2500587379523, 29819.403611927857, 29834.850825745732, 29870.253243668863, 29906.0, 29949.550756738667, 3105.3323535439763, 3181.077487528614, 3186.2512309607223, 3191.4095892260007, 3193.8722451101926, 267675.0, 270550.2944970545, 271435.0, 272322.0, 272870.999999998, 47483.28775068377, 47579.76210118927, 47599.28808542997, 47623.57129286127, 47708.284375734394, 48824.0, 48890.511094889305, 48900.26649600259, 48903.0, 48946.0, 13753.106048106842, 13866.653333666538, 13874.583762487142, 13882.375293111632, 13897.0966887152, 11305.378204198683, 11306.038986686059, 11307.943460282646, 11309.660710178709, 11329.546818127348, 9953.004699530135, 10039.397636141708, 10060.195184385231, 11475.368854713071, 11714.94142529299, 5142.537171654569, 5198.610104242121, 5198.636095473356, 5217.426083130853, 5226.843194704165, 986.9309148359546, 990.0792263195153, 994.9204063674889, 1031.2523420520213, 1037.273908264218, 22049.559008819735, 22326.88836555807, 23884.52230955371, 24115.155969541334, 24127.879360603434, 1087.8477013218155, 1098.3025778630627, 1133.1897693149438, 1139.3562637110006, 1151.0, 11830.822537661941, 12200.51197952072, 12267.447964841604, 12312.076594255466, 12339.259644421363, 299192.0, 303855.0, 304274.0, 305560.0, 306028.0, 50680.732981675756, 50709.98580028379, 50729.746351268004, 50840.745796270785, 50857.0, 1458.8759955403698, 1497.4160077569757, 1515.6438237014293, 1517.544736579022, 1526.7557190849411, 23605.0, 23665.64501532444, 23681.881590591936, 23717.52564948726, 23828.285151445485, 36503.26993460063, 36575.0, 36627.0, 36629.26741465209, 36653.0, 233686.83156584107, 261373.0, 261880.0, 262399.68800155877, 262713.0, 31887.0, 32679.673203268612, 32703.672963270063, 32773.34453310968, 32967.50548741723, 36389.0, 36559.81720091489, 36572.45141322829, 36637.81681091578, 43911.78044109759, 25853.612195817455, 27238.455230895666, 29904.663823745872, 30202.69797301999, 30298.97144227915, 29488.410231794816, 29532.409351813272, 29987.100386988426, 30337.24156896095, 30421.0, 30421.239469013453, 35351.11622209465, 35954.0, 36077.27845443129, 36173.27653446969, 28943.0, 29347.0, 29810.701892980793, 30850.53724194094, 31112.533311999887, 22559.0, 23638.045244344456, 23805.404864877823, 23919.88040059858, 24222.0], "value": 16761.72803343963, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [424.9061911389354, 430.91409647687806, 436.28667129243695, 440.3197060541463, 456.5754844883962, 18302.176402061905, 20354.491137721565, 20882.269120580782, 20966.37100886972, 20984.89507552462, 17651.0, 21546.89226553869, 22079.44801379966, 22115.889420552874, 22143.44641383966, 6019.428154325332, 6311.431971122598, 6316.115743795872, 6323.494120470375, 6335.493160547145, 4766.904661906759, 4832.275158726184, 4889.926651100236, 5198.662086964354, 6108.114323423101, 4766.142094423002, 4793.7363445010515, 4809.951900481003, 4814.855554333358, 4839.830605928793, 4752.263399173134, 4800.615950723934, 5340.519353258225, 6081.391860813927, 6189.845253868644, 5455.263539422167, 5465.480779325958, 5471.671699697991, 5479.726013699299, 5481.232627432163, 26110.69446527666, 26252.0, 26709.73290267092, 26716.86641566799, 27028.324291892663, 2205.9889700551553, 2238.350878245307, 2241.069955968271, 2242.6748121522287, 2248.7751224877543, 15035.473758418402, 17028.233729482203, 17573.648527029516, 17781.7332740009, 17825.554361140945, 2068.4932191613, 2113.6406810842195, 2139.4009677290383, 2158.7949144831214, 2163.4807646164963, 146024.269878651, 146883.98370122176, 147391.0, 148246.0, 150612.9999999989, 11482.655520334403, 12106.515739370327, 12116.81824772629, 12119.272843629411, 12180.57367992116, 16154.030758154548, 16198.595035124215, 16210.594735131715, 16222.783291253203, 16250.51248462548, 8614.569271536398, 8775.692850750193, 8796.12038796128, 8874.51190184546, 8948.373613847098, 8330.541820199825, 8347.791305217297, 8508.234258916727, 8509.914900851036, 8561.82876342482, 7338.596377199198, 7415.1843297237265, 7475.850482990419, 7548.320651141424, 7567.432442566829, 2149.98925005374, 2152.322018564147, 2153.3970488263312, 2170.9674354884373, 2174.8695078295355, 821.9136990616018, 952.2953014769159, 972.6595691507915, 1009.65671671632, 1014.3457469931852, 15812.683746325009, 21019.057331973538, 21059.0, 21399.786002140092, 21410.464738381354, 988.367444835306, 989.8564708117427, 1021.0, 1024.8360262358135, 1026.958921643126, 9971.40171589707, 10163.644272450429, 10441.321314114559, 10787.460626968621, 10869.021788039114, 418163.0, 494536.0, 509140.0, 515115.0, 516770.0, 130868.0, 133027.99999999805, 133077.33461332825, 133994.3300283512, 134307.65692343147, 1192.9403529823473, 1194.6774370919977, 1216.1365430544413, 1219.8841110094527, 1222.4926655437894, 14633.341499632756, 20781.58436831285, 21868.125274988823, 22274.888625556767, 22402.215922442636, 54190.18714719204, 54766.0, 56345.43654563566, 56583.717081415976, 56646.71676641755, 76559.0, 77012.0, 78517.82223266769, 79018.6049069751, 81172.59413702894, 8781.736547903573, 8980.754811297176, 9070.455772653662, 9163.725088247364, 9355.345125841126, 14163.716725665636, 14321.57035288943, 14354.49759258421, 14747.852521474648, 14774.852251477347, 11935.343556104497, 11943.462544185706, 12129.514819407124, 12257.38713064361, 12269.815952760895, 9854.211663066793, 11388.963849159958, 11390.430478476208, 11465.197436179387, 11668.008219301115, 12076.0, 12299.69250768738, 12310.107124825838, 12317.876821231674, 12402.689932751753, 8808.20726134651, 9039.412438191497, 9114.3559836968, 9261.398009129385, 9310.44137351734, 11831.585894493652, 11840.1711880171, 12221.877781222074, 12272.325022123869, 12330.0], "value": 10223.412283128719, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1188.780075685998, 1462.963425914352, 1477.8743806776424, 1484.658528538436, 1487.3084015932595, 11248.437578121091, 11741.354225517603, 11762.470688819003, 11768.823467647991, 11793.882061179396, 11053.28153670013, 11345.602903898365, 11741.0, 11745.41272936352, 11755.823662645067, 2460.655508228845, 2515.8364706294124, 2516.1319344826006, 2521.432677647533, 2525.01524405482, 2441.8046556275453, 2480.6651102101255, 2480.937976550583, 2486.1298545509017, 2487.6268559716004, 2390.8804559771943, 2490.5392502387026, 2492.8753562321904, 2498.9750102498924, 2499.3501689560753, 2461.2247142150163, 2470.555300045991, 2485.5401750676183, 2491.788198003172, 2495.2763698527588, 2439.9512009759883, 2458.483718419134, 2483.3046746910713, 2489.8381605195605, 2497.887595058227, 11568.248063875906, 11697.3566453845, 11699.06407487399, 11703.824442633368, 11704.590339338083, 5400.513953744143, 6766.458683305324, 6777.62723050232, 6778.491613129035, 6791.422729068036, 3937.0944682722848, 4258.510271318807, 4323.437953066082, 4326.610605045529, 4328.50222224445, 1231.5566396097397, 1247.2703468470954, 1291.5866922584776, 1301.6420484366874, 1302.296759749734, 15018.324175412132, 15493.302801373853, 16557.66884662312, 16692.83307166937, 16704.916475417667, 4844.491328410537, 5462.754176062087, 5612.5229355504425, 5622.91565626516, 5625.662460252398, 11736.941315293368, 11739.178257522062, 11739.47172377245, 11747.118966077407, 11758.823617645741, 5399.811006614749, 6510.479161667055, 6516.0, 6518.348165183538, 6527.934720652733, 5709.143628455765, 6206.844828879314, 6227.1282020517165, 6231.4391704746795, 6233.252009758858, 3739.2521495700967, 4231.30183519722, 4330.545292744279, 4350.2387082260475, 4375.27807911691, 1250.8373911391461, 1253.3983687829893, 1276.304414094321, 1276.527684756646, 1279.6225113591513, 787.6219414680985, 798.8442253760461, 801.8035581282624, 813.4915677701437, 819.3117781063935, 6104.328523862371, 6604.504662150358, 6777.627230502271, 6888.0, 6987.685554150075, 890.6481939633937, 910.5856835139996, 914.6204325204966, 920.3649481857631, 924.6209054287845, 3698.5007024051947, 4132.925439385721, 4345.304751239786, 4369.737815731066, 4413.713108647928, 12506.874931250753, 15120.924395377953, 15151.772723409158, 15180.0, 15221.162836044125, 12344.938275308567, 14542.781858272134, 14879.92560037193, 15158.242087895562, 15214.847851521565, 8348.288600836935, 8526.57367131641, 8535.359848011549, 8536.957315213383, 8545.871811922827, 6371.808845734636, 6589.110470086669, 6783.626900520519, 6836.863262734618, 6860.656967151723, 13104.868951310365, 13587.980901432235, 13588.0, 13644.113132646346, 13681.931590341985, 13538.323083845966, 13684.178949263076, 13950.023498355018, 14147.64630884236, 14259.358328875433, 8150.307223886036, 8178.46839955401, 8281.21328473794, 8324.167583241628, 8327.167283271867, 10475.0, 10577.153827693612, 10579.89420105789, 10588.047075763217, 10605.25763196569, 8797.076306987674, 9098.135677110664, 9197.448153110834, 9234.722958311262, 9280.071992800666, 8536.74389768308, 8797.824043518965, 8868.556572171494, 8968.955155224183, 8979.955100224457, 7892.723754668559, 8078.7172448964, 8203.753887383387, 8215.876761848458, 8230.053543842296, 5026.346574945233, 5811.895739809423, 5882.176495290748, 5922.851928701817, 6092.116643086639, 5946.13781001761, 6072.605280656743, 6135.386461353829, 6163.260408750979, 6255.218097737783], "value": 5329.806485016041, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [320.3880588076772, 392.76826672263365, 397.1164159744568, 403.84903026374815, 405.0400550694854, 5622.91565626516, 5849.678267695275, 5855.47300742933, 5934.1692163097205, 5934.673592952386, 4167.182447922598, 5638.210650508932, 5696.458836410545, 5806.419358064191, 5819.650820950736, 4443.84446544371, 4479.216137175998, 4481.170983368087, 4484.932726009112, 4489.932651010237, 4458.242098843204, 4485.147821913843, 4491.910161796778, 4494.460664720238, 4502.639788816887, 4052.29084910141, 4269.210196113713, 4280.507741609708, 4445.422095127629, 4458.9331160032625, 4251.74489530626, 4252.298370768819, 4253.744775313491, 4259.339802330644, 4279.358096285551, 3660.7803531788177, 3661.395869681526, 3670.1558641512333, 3689.335919534483, 3708.2212735325616, 4940.2342636891335, 5629.155626655994, 5643.633163844337, 5710.200571919934, 5712.457316554921, 4445.955540444619, 4726.912810053673, 5004.674696144739, 5020.899582008376, 5029.874253143664, 6181.938180618181, 6184.412480814315, 6226.0, 6232.0, 6243.531735119839, 4031.455753473273, 4095.89760255993, 4121.443605113302, 4135.7518548886865, 4144.772037537934, 6196.349383314777, 6472.482201423922, 6488.870222595521, 6534.607923524603, 6674.766383176566, 3417.2059668674146, 3792.6017768133947, 3914.6085391460624, 4060.5127384714024, 4062.8623985284166, 3789.8484060637265, 3963.8702969654087, 4080.449139366207, 4133.979330103391, 4264.168487145039, 4142.813573389205, 4960.851174464772, 5001.149804533238, 5012.674176178537, 5028.698278103326, 5380.408155102936, 5724.513416359573, 6253.218347706536, 6253.374662533801, 6258.405451482102, 1220.8341034312211, 1241.6709571963436, 1307.2287350463273, 1436.5115860607443, 1442.6609746709514, 914.7667344827026, 938.1416004356074, 951.1962391778935, 955.9235261179089, 960.2893858544767, 5860.413958604106, 5911.379305172895, 5920.141579470953, 5931.7923872665115, 5938.792142275, 5114.002769459919, 5300.31095957523, 6038.969805151034, 6412.422881940648, 6414.294427612959, 5617.101263797855, 5860.062390017577, 5911.438413350811, 5991.0, 6003.549733769984, 3295.7528185385713, 3326.234965957843, 3336.816475093893, 3340.7494437916766, 3348.29685765987, 5609.747561359667, 6325.778597749057, 6562.901556476657, 6603.438707709803, 6692.732290708414, 6676.399124078759, 6690.698918548677, 6697.631630260285, 6697.6986035628515, 6732.364523157538, 6481.310256243606, 6627.801165965126, 6647.534672572873, 6682.131322927989, 6759.188897332351, 5239.816606418757, 5682.886342273214, 5917.6745279010065, 6326.240851097714, 6542.831163381066, 6419.711112999833, 6420.335560742426, 6420.582662126947, 6431.5819471734185, 6446.42303964172, 5753.367129615655, 6363.96818015907, 6639.767608133692, 6711.811889352519, 6733.192016957996, 4165.396017577495, 4168.270552653335, 4170.833166673299, 4175.415441838206, 4177.8537751178565, 5934.842705672352, 6246.969250073687, 6438.549301548846, 6537.411632953057, 6553.246376666553, 5204.401493828107, 5481.698506582176, 5965.598084450237, 6191.0, 6203.844903877439, 5162.6902385856965, 5206.73966301691, 5601.187827765033, 5842.0, 6198.349173336915, 5581.2744343236745, 5937.554683398676, 6083.574149809648, 6086.269647642312, 6090.69546522681, 5218.791248350023, 6225.782097626561, 6237.126802247598, 6237.1891654084675, 6264.310925798068, 5208.9739551302, 5707.571932105026, 6055.636661800306, 6124.908126378019, 6126.94747259673], "value": 4508.595032773127, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [694.7186389512249, 837.7947402886293, 840.1178762299588, 844.5144042175747, 853.3940901959609, 11834.704132396695, 13586.048976571645, 13591.864081359196, 15039.924800375982, 17150.399736009243, 13823.37794799234, 17359.218835152416, 17385.391511297075, 17541.298348066062, 17591.208395622194, 979.5543027922296, 1002.9448380339079, 1005.5927349423495, 1007.778288776468, 1009.0, 665.2748504130496, 1001.5943542865115, 1002.939823610582, 1003.8895721470633, 1005.2058873489934, 741.4624397311933, 921.5806807902388, 1029.9742506437362, 1038.2887721910479, 1041.8958104189596, 1034.596507362133, 1034.8551202831609, 1035.5081336365242, 1036.528379587286, 1036.818556752573, 757.4962649837851, 758.6017340896019, 758.6965213914478, 761.2729842999922, 761.5240474703311, 12322.568710095193, 12663.620091397273, 16291.755623665655, 16738.24677889498, 16833.91583042077, 16264.75602865958, 17081.57296067596, 17148.142592870307, 17321.913390433092, 17424.215910284067, 13484.258365789878, 14110.012299139064, 14111.435542578285, 14125.505607303798, 14191.148531088167, 3438.985499277694, 3460.567429071366, 3467.49721290414, 3531.0289670340862, 3539.50446937429, 128779.35610321982, 129275.99999999905, 129707.0, 129867.0, 131564.34217828946, 11333.94333028346, 13127.212367257995, 13552.932235338958, 13670.31648417595, 13683.04218704701, 25349.36626584313, 25450.745492545208, 25706.228813135636, 25761.61357579638, 25790.35524111875, 7343.412526997828, 7391.85216295671, 7397.18630950595, 7411.0736157980255, 7417.517861339104, 3627.981860090683, 3645.5989841117457, 3665.560132784083, 3712.0719820044988, 3721.683656889195, 4325.978370108192, 4400.053988392511, 4403.603675669206, 4410.360497727812, 4414.27164517851, 884.5090974509209, 930.8324501589643, 954.2795189631784, 964.5563041001078, 965.4448692002127, 645.9741610335534, 663.2074670768385, 663.5819433756702, 671.8824205763972, 683.3235097253684, 9670.854937175947, 11149.331040137618, 11917.22538035025, 12016.759664806656, 12385.690357741129, 646.7348387161335, 647.2782847125516, 649.3928177154376, 662.8475450646379, 671.4728937783914, 4913.091078150482, 4931.211006238985, 4961.90076198474, 4969.676970996946, 5105.719185444762, 102887.4855625717, 104142.0, 104653.0, 105923.41114883283, 110290.44854775675, 90719.0, 92638.53680731553, 93748.06251937394, 94637.05362946421, 95554.04445955591, 81150.59424702839, 81814.59092704498, 81834.59082704668, 81925.59037204777, 82265.17734822576, 10554.736131596772, 11217.66347009591, 11320.0, 11426.485808138488, 11631.709207269885, 39293.41059884047, 39564.010899726585, 39577.604223957394, 39623.207535848545, 39674.80162599284, 51367.0, 51918.0, 52154.73922630362, 52362.73818630882, 53165.7341713289, 13985.370658320197, 14206.502772402917, 14245.430182792572, 14360.712785744017, 14375.784363234769, 15276.694466110393, 15452.84547154559, 15751.68496630084, 15891.364345426053, 15912.44306449315, 14561.27193640335, 14639.48761793332, 14742.484013059491, 14878.77681834795, 14923.104613723212, 14492.782608260673, 14691.485797997446, 14752.188629625474, 14805.259737013323, 14911.105333680014, 14143.43426262938, 14180.14919104857, 14348.06737562055, 14515.201663908587, 14664.0, 9397.483138427453, 10714.410707411167, 10997.780044398907, 11233.775324493628, 11378.658640240807, 12132.878671213175, 12534.874651253736, 13060.346982651019, 13122.671933201746, 13142.868571314164], "value": 8030.13287029022, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1441.5, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 110.0, 109.0, 109.0, 110.0, 110.0, 111.0, 110.0, 112.0, 111.0], "value": 110.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [138.0, 108.0, 127.0, 165.0, 130.0, 139.0, 139.0, 139.0, 145.0, 124.0], "value": 135.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [185.0, 187.0, 185.0, 198.0, 182.0, 186.0, 184.0, 186.0, 181.0, 184.0], "value": 185.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 58.0, 56.0, 90.0, 57.0, 61.0, 57.0, 58.0, 81.0, 58.0], "value": 65.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 71.0, 86.0, 69.0, 69.0, 68.0, 90.0, 69.0, 70.0, 112.0], "value": 78.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 90.0, 91.0, 91.0, 92.0, 90.0, 92.0, 90.0, 91.0, 91.0], "value": 90.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 96.0, 95.0, 96.0, 96.0, 97.0, 96.0, 97.0, 97.0], "value": 96.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 86.0, 84.0, 84.0, 83.0, 86.0, 84.0, 87.0, 83.0, 85.0], "value": 84.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [49.0, 47.0, 49.0, 46.0, 47.0, 49.0, 47.0, 48.0, 48.0, 48.0], "value": 47.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 53.0, 62.0, 57.0, 66.0, 58.0, 56.0, 55.0, 72.0, 80.0], "value": 61.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 84.0, 81.0, 82.0, 84.0, 81.0, 80.0, 86.0, 101.0, 103.0], "value": 86.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 136.0, 137.0, 135.0, 139.0, 144.0, 148.0, 141.0, 193.0, 144.0], "value": 145.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [189.0, 185.0, 183.0, 182.0, 188.0, 181.0, 186.0, 186.0, 185.0, 182.0], "value": 184.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 68.0, 67.0, 67.0, 67.0, 67.0, 69.0, 69.0, 67.0, 68.0], "value": 67.7, "unit": "score"}]}]} 14:44:57 INFO - Return code: 0 14:44:58 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 14:44:58 ERROR - # TBPL SUCCESS # 14:44:58 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 14:44:58 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 14:44:58 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 14:44:58 INFO - 2017-04-27 14:44:58.056 screenresolution[1928:17689] starting screenresolution argv=screenresolution get 14:44:58 INFO - 2017-04-27 14:44:58.058 screenresolution[1928:17689] Display 0: 1600x1200x32@60 14:44:58 INFO - 2017-04-27 14:44:58.065 screenresolution[1929:17692] starting screenresolution argv=screenresolution list 14:44:58 INFO - Available Modes on Display 0 14:44:58 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 14:44:58 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 14:44:58 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 14:44:58 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 14:44:58 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 14:44:58 INFO - Intel Iris: 14:44:58 INFO - Chipset Model: Intel Iris 14:44:58 INFO - Type: GPU 14:44:58 INFO - Bus: Built-In 14:44:58 INFO - VRAM (Dynamic, Max): 1536 MB 14:44:58 INFO - Vendor: Intel (0x8086) 14:44:58 INFO - Device ID: 0x0a2e 14:44:58 INFO - Revision ID: 0x0009 14:44:58 INFO - Displays: 14:44:58 INFO - Display: 14:44:58 INFO - Resolution: 1600 x 1200 @ 60 Hz 14:44:58 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 14:44:58 INFO - Display Serial Number: 1600x1200 60 14:44:58 INFO - Main Display: Yes 14:44:58 INFO - Mirror: Off 14:44:58 INFO - Online: Yes 14:44:58 INFO - Rotation: Supported 14:44:58 INFO - Return code: 0 14:44:58 INFO - Running post-action listener: _resource_record_post_action 14:44:58 INFO - [mozharness: 2017-04-27 21:44:58.307513Z] Finished run-tests step (success) 14:44:58 INFO - Running post-run listener: _resource_record_post_run 14:44:58 INFO - Total resource usage - Wall time: 1199s; CPU: 53.0%; Read bytes: 708608; Write bytes: 510629888; Read time: 10; Write time: 1579 14:44:58 INFO - TinderboxPrint: CPU usage
53.4% 14:44:58 INFO - TinderboxPrint: I/O read bytes / time
708,608 / 10 14:44:58 INFO - TinderboxPrint: I/O write bytes / time
510,629,888 / 1,579 14:44:58 INFO - TinderboxPrint: CPU idle
2,235.5 (46.6%) 14:44:58 INFO - TinderboxPrint: CPU system
958.4 (20.0%) 14:44:58 INFO - TinderboxPrint: CPU user
1,603.8 (33.4%) 14:44:58 INFO - TinderboxPrint: Swap in / out
209,719,296 / 0 14:44:58 INFO - install - Wall time: 21s; CPU: 54.0%; Read bytes: 201386496; Write bytes: 194068480; Read time: 16200; Write time: 401 14:44:58 INFO - run-tests - Wall time: 1179s; CPU: 53.0%; Read bytes: 708608; Write bytes: 299907072; Read time: 10; Write time: 1125 14:44:58 INFO - Running post-run listener: _upload_blobber_files 14:44:58 INFO - Blob upload gear active. 14:44:58 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 14:44:58 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 14:44:58 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'] 14:44:58 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 14:44:59 INFO - (blobuploader) - INFO - Open directory for files ... 14:44:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 14:44:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:44:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:45:00 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 14:45:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:45:00 INFO - (blobuploader) - INFO - Done attempting. 14:45:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 14:45:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:45:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:45:01 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 14:45:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:45:01 INFO - (blobuploader) - INFO - Done attempting. 14:45:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 14:45:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:45:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:45:02 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 14:45:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:45:02 INFO - (blobuploader) - INFO - Done attempting. 14:45:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 14:45:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:45:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:45:04 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 14:45:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:45:04 INFO - (blobuploader) - INFO - Done attempting. 14:45:04 INFO - (blobuploader) - INFO - Iteration through files over. 14:45:04 INFO - Return code: 0 14:45:04 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 14:45:04 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 14:45:04 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/393cd84913842dea7364d59d5346ab2d46e23403f212fa85e05af9175bdd85d9a032e0ea3f5e34339e500345a603f7f6be054fd9698f395bb2fc4e227aa6960e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/160ec0d8c422657cfd773da340496749d7bc925afcfe8db3f5f0d6bdd9c207cf2343e39f5f91cceab3bc91224c932cb07096375abc37dfbd96f022a7eae9173d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/66223557478c10fc2ecdb3a9b7d2d05220caf291b4efb2031012be39a79eed01675325412c2eb39c3ead44a20880cb4cf9613231de40062ab0a5eab35c1d2df8", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ba12682b50c7d3087b33e766d9333473e537bad97ab84191099bd22af2215f69ef362dc76af7450f04fcc65a343ea8fe63abc677c14f6af75ff9a3eae4b5ce35"} 14:45:04 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 14:45:04 INFO - Writing to file /builds/slave/test/properties/blobber_files 14:45:04 INFO - Contents: 14:45:04 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/393cd84913842dea7364d59d5346ab2d46e23403f212fa85e05af9175bdd85d9a032e0ea3f5e34339e500345a603f7f6be054fd9698f395bb2fc4e227aa6960e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/160ec0d8c422657cfd773da340496749d7bc925afcfe8db3f5f0d6bdd9c207cf2343e39f5f91cceab3bc91224c932cb07096375abc37dfbd96f022a7eae9173d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/66223557478c10fc2ecdb3a9b7d2d05220caf291b4efb2031012be39a79eed01675325412c2eb39c3ead44a20880cb4cf9613231de40062ab0a5eab35c1d2df8", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ba12682b50c7d3087b33e766d9333473e537bad97ab84191099bd22af2215f69ef362dc76af7450f04fcc65a343ea8fe63abc677c14f6af75ff9a3eae4b5ce35"} 14:45:04 INFO - Running post-run listener: copy_logs_to_upload_dir 14:45:04 INFO - Copying logs to upload dir... 14:45:04 INFO - mkdir: /builds/slave/test/build/upload/logs 14:45:04 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1282.073296 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 22 secs) (at 2017-04-27 14:45:04.604926) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-27 14:45:04.608636) ========= 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.bnkoMrF2l6/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.VwqSGJXvEj/Listeners TMPDIR=/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/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/393cd84913842dea7364d59d5346ab2d46e23403f212fa85e05af9175bdd85d9a032e0ea3f5e34339e500345a603f7f6be054fd9698f395bb2fc4e227aa6960e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/160ec0d8c422657cfd773da340496749d7bc925afcfe8db3f5f0d6bdd9c207cf2343e39f5f91cceab3bc91224c932cb07096375abc37dfbd96f022a7eae9173d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/66223557478c10fc2ecdb3a9b7d2d05220caf291b4efb2031012be39a79eed01675325412c2eb39c3ead44a20880cb4cf9613231de40062ab0a5eab35c1d2df8", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ba12682b50c7d3087b33e766d9333473e537bad97ab84191099bd22af2215f69ef362dc76af7450f04fcc65a343ea8fe63abc677c14f6af75ff9a3eae4b5ce35"} build_url:https://queue.taskcluster.net/v1/task/Wss_kS7IS9iPcMBhbOHEgA/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011333 build_url: 'https://queue.taskcluster.net/v1/task/Wss_kS7IS9iPcMBhbOHEgA/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/393cd84913842dea7364d59d5346ab2d46e23403f212fa85e05af9175bdd85d9a032e0ea3f5e34339e500345a603f7f6be054fd9698f395bb2fc4e227aa6960e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/160ec0d8c422657cfd773da340496749d7bc925afcfe8db3f5f0d6bdd9c207cf2343e39f5f91cceab3bc91224c932cb07096375abc37dfbd96f022a7eae9173d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/66223557478c10fc2ecdb3a9b7d2d05220caf291b4efb2031012be39a79eed01675325412c2eb39c3ead44a20880cb4cf9613231de40062ab0a5eab35c1d2df8", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ba12682b50c7d3087b33e766d9333473e537bad97ab84191099bd22af2215f69ef362dc76af7450f04fcc65a343ea8fe63abc677c14f6af75ff9a3eae4b5ce35"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-27 14:45:04.643298) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-27 14:45:04.643610) ========= 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.bnkoMrF2l6/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.VwqSGJXvEj/Listeners TMPDIR=/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/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.004666 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-27 14:45:04.692010) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-27 14:45:04.692332) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-27 14:45:04.692649) ========= ========= Total master_lag: 0.18 =========