builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0024 starttime: 1493310000.41 results: success (0) buildid: 20170427073327 builduid: 9ccf132ee1b3468c8e2f9f8b81ff4a96 revision: c0d35b1c5ab5fa9bb2f5661aa0454a1ce31b50e0 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-04-27 09:20:00.415179) ========= master: http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-04-27 09:20:00.415587) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-27 09:20:00.415857) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-27 09:20:00.476187) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-27 09:20:00.479485) ========= 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.xZr80f4b21/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.A7rmB0FSP2/Listeners TMPDIR=/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/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 09:20:00-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 15.4M=0.001s 2017-04-27 09:20:00 (15.4 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.144516 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-27 09:20:00.648879) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-27 09:20:00.649190) ========= 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.xZr80f4b21/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.A7rmB0FSP2/Listeners TMPDIR=/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/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.028795 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-27 09:20:00.706584) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 3 secs) (at 2017-04-27 09:20:00.706909) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev c0d35b1c5ab5fa9bb2f5661aa0454a1ce31b50e0 --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 c0d35b1c5ab5fa9bb2f5661aa0454a1ce31b50e0 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.xZr80f4b21/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.A7rmB0FSP2/Listeners TMPDIR=/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/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 09:20:00,806 truncating revision to first 12 chars 2017-04-27 09:20:00,806 Setting DEBUG logging. 2017-04-27 09:20:00,807 attempt 1/10 2017-04-27 09:20:00,807 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/c0d35b1c5ab5?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-04-27 09:20:01,761 unpacking tar archive at: mozilla-central-c0d35b1c5ab5/testing/mozharness/ program finished with exit code 0 elapsedTime=1.224179 ========= master_lag: 1.78 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 3 secs) (at 2017-04-27 09:20:03.709602) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-27 09:20:03.710013) ========= script_repo_revision: c0d35b1c5ab5fa9bb2f5661aa0454a1ce31b50e0 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-27 09:20:03.714476) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-27 09:20:03.714793) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-27 09:20:03.789461) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 27 secs) (at 2017-04-27 09:20:03.789772) ========= /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.xZr80f4b21/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.A7rmB0FSP2/Listeners TMPDIR=/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 09:20:04 INFO - MultiFileLogger online at 20170427 09:20:04 in /builds/slave/test 09:20:04 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 09:20:04 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:20:04 INFO - {'append_to_log': False, 09:20:04 INFO - 'base_work_dir': '/builds/slave/test', 09:20:04 INFO - 'blob_upload_branch': 'Firefox', 09:20:04 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:20:04 INFO - 'branch': 'Firefox', 09:20:04 INFO - 'buildbot_json_path': 'buildprops.json', 09:20:04 INFO - 'config_files': ('talos/mac_config.py',), 09:20:04 INFO - 'default_actions': ('clobber', 09:20:04 INFO - 'read-buildbot-config', 09:20:04 INFO - 'download-and-extract', 09:20:04 INFO - 'populate-webroot', 09:20:04 INFO - 'create-virtualenv', 09:20:04 INFO - 'install', 09:20:04 INFO - 'run-tests'), 09:20:04 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:20:04 INFO - 'download_minidump_stackwalk': True, 09:20:04 INFO - 'download_symbols': 'ondemand', 09:20:04 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:20:04 INFO - 'tooltool.py': '/tools/tooltool.py', 09:20:04 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:20:04 INFO - '/tools/misc-python/virtualenv.py')}, 09:20:04 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:20:04 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:20:04 INFO - 'gecko_profile': False, 09:20:04 INFO - 'gecko_profile_interval': 0, 09:20:04 INFO - 'installer_path': 'installer.exe', 09:20:04 INFO - 'log_level': 'info', 09:20:04 INFO - 'log_name': 'talos', 09:20:04 INFO - 'log_to_console': True, 09:20:04 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 09:20:04 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 09:20:04 INFO - 'opt_config_files': (), 09:20:04 INFO - 'pip_index': False, 09:20:04 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 09:20:04 INFO - 'cmd': ('bash', 09:20:04 INFO - '-c', 09:20:04 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 09:20:04 INFO - 'enabled': True, 09:20:04 INFO - 'halt_on_failure': False, 09:20:04 INFO - 'name': 'check_screen_resolution'},), 09:20:04 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 09:20:04 INFO - 'cmd': ('bash', 09:20:04 INFO - '-c', 09:20:04 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 09:20:04 INFO - 'enabled': True, 09:20:04 INFO - 'halt_on_failure': False, 09:20:04 INFO - 'name': 'check_screen_resolution'},), 09:20:04 INFO - 'run_cmd_checks_enabled': True, 09:20:04 INFO - 'suite': 'dromaeojs', 09:20:04 INFO - 'system_bits': '32', 09:20:04 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:20:04 INFO - 'title': 't-yosemite-r7-0024', 09:20:04 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:20:04 INFO - 'use_talos_json': True, 09:20:04 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:20:04 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:20:04 INFO - 'work_dir': 'build'} 09:20:04 INFO - [mozharness: 2017-04-27 16:20:04.016323Z] Running clobber step. 09:20:04 INFO - Running pre-action listener: _resource_record_pre_action 09:20:04 INFO - Running main action method: clobber 09:20:04 INFO - rmtree: /builds/slave/test/build 09:20:04 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:20:06 INFO - Running post-action listener: _resource_record_post_action 09:20:06 INFO - [mozharness: 2017-04-27 16:20:06.456616Z] Finished clobber step (success) 09:20:06 INFO - [mozharness: 2017-04-27 16:20:06.456787Z] Running read-buildbot-config step. 09:20:06 INFO - Running pre-action listener: _resource_record_pre_action 09:20:06 INFO - Running main action method: read_buildbot_config 09:20:06 INFO - Using buildbot properties: 09:20:06 INFO - { 09:20:06 INFO - "project": "", 09:20:06 INFO - "product": "firefox", 09:20:06 INFO - "script_repo_revision": "production", 09:20:06 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 09:20:06 INFO - "repository": "", 09:20:06 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 09:20:06 INFO - "buildid": "20170427073327", 09:20:06 INFO - "pgo_build": "False", 09:20:06 INFO - "basedir": "/builds/slave/test", 09:20:06 INFO - "buildnumber": 34, 09:20:06 INFO - "slavename": "t-yosemite-r7-0024", 09:20:06 INFO - "master": "http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/", 09:20:06 INFO - "platform": "yosemite_r7", 09:20:06 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 09:20:06 INFO - "branch": "mozilla-central", 09:20:06 INFO - "repo_path": "mozilla-central", 09:20:06 INFO - "revision": "c0d35b1c5ab5fa9bb2f5661aa0454a1ce31b50e0", 09:20:06 INFO - "stage_platform": "macosx64", 09:20:06 INFO - "builduid": "9ccf132ee1b3468c8e2f9f8b81ff4a96", 09:20:06 INFO - "slavebuilddir": "test" 09:20:06 INFO - } 09:20:06 INFO - Found installer url https://queue.taskcluster.net/v1/task/awXcEhMjQgybIQJk36DeUg/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg. 09:20:06 INFO - Running post-action listener: _resource_record_post_action 09:20:06 INFO - [mozharness: 2017-04-27 16:20:06.460219Z] Finished read-buildbot-config step (success) 09:20:06 INFO - [mozharness: 2017-04-27 16:20:06.460335Z] Running download-and-extract step. 09:20:06 INFO - Running pre-action listener: _resource_record_pre_action 09:20:06 INFO - Running main action method: download_and_extract 09:20:06 INFO - mkdir: /builds/slave/test/build/tests 09:20:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:20:06 INFO - trying https://queue.taskcluster.net/v1/task/awXcEhMjQgybIQJk36DeUg/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json 09:20:06 INFO - Downloading https://queue.taskcluster.net/v1/task/awXcEhMjQgybIQJk36DeUg/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 09:20:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/awXcEhMjQgybIQJk36DeUg/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 09:20:07 INFO - Downloaded 1325 bytes. 09:20:07 INFO - Reading from file /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 09:20:07 INFO - Using the following test package requirements: 09:20:07 INFO - {u'awsy': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 09:20:07 INFO - u'firefox-55.0a1.en-US.mac.awsy.tests.zip'], 09:20:07 INFO - u'common': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 09:20:07 INFO - u'cppunittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 09:20:07 INFO - u'firefox-55.0a1.en-US.mac.cppunittest.tests.zip'], 09:20:07 INFO - u'gtest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 09:20:07 INFO - u'firefox-55.0a1.en-US.mac.gtest.tests.zip'], 09:20:07 INFO - u'jittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 09:20:07 INFO - u'jsshell-mac.zip'], 09:20:07 INFO - u'mochitest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 09:20:07 INFO - u'firefox-55.0a1.en-US.mac.mochitest.tests.zip'], 09:20:07 INFO - u'mozbase': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 09:20:07 INFO - u'reftest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 09:20:07 INFO - u'firefox-55.0a1.en-US.mac.reftest.tests.zip'], 09:20:07 INFO - u'talos': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 09:20:07 INFO - u'firefox-55.0a1.en-US.mac.talos.tests.zip'], 09:20:07 INFO - u'web-platform': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 09:20:07 INFO - u'firefox-55.0a1.en-US.mac.web-platform.tests.zip'], 09:20:07 INFO - u'xpcshell': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 09:20:07 INFO - u'firefox-55.0a1.en-US.mac.xpcshell.tests.zip']} 09:20:07 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip'] for test suite category: common 09:20:07 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/awXcEhMjQgybIQJk36DeUg/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 09:20:07 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/awXcEhMjQgybIQJk36DeUg/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 09:20:07 INFO - Fetch https://queue.taskcluster.net/v1/task/awXcEhMjQgybIQJk36DeUg/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 09:20:09 INFO - Content-Length response header: 52529286 09:20:09 INFO - Bytes received: 52529286 09:20:25 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 09:20:25 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/awXcEhMjQgybIQJk36DeUg/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 09:20:25 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/awXcEhMjQgybIQJk36DeUg/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 09:20:25 INFO - Fetch https://queue.taskcluster.net/v1/task/awXcEhMjQgybIQJk36DeUg/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 09:20:27 INFO - Content-Length response header: 52529286 09:20:27 INFO - Bytes received: 52529286 09:20:43 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/awXcEhMjQgybIQJk36DeUg/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip 09:20:43 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/awXcEhMjQgybIQJk36DeUg/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip'}, attempt #1 09:20:43 INFO - Fetch https://queue.taskcluster.net/v1/task/awXcEhMjQgybIQJk36DeUg/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip into memory 09:20:44 INFO - Content-Length response header: 14408809 09:20:44 INFO - Bytes received: 14408809 09:20: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')]} 09:20:44 INFO - trying https://queue.taskcluster.net/v1/task/awXcEhMjQgybIQJk36DeUg/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 09:20:44 INFO - Downloading https://queue.taskcluster.net/v1/task/awXcEhMjQgybIQJk36DeUg/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg 09:20:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/awXcEhMjQgybIQJk36DeUg/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 09:20:46 INFO - Downloaded 71194061 bytes. 09:20:46 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/awXcEhMjQgybIQJk36DeUg/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 09:20:46 INFO - mkdir: /builds/slave/test/properties 09:20:46 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:20:46 INFO - Writing to file /builds/slave/test/properties/build_url 09:20:46 INFO - Contents: 09:20:46 INFO - build_url:https://queue.taskcluster.net/v1/task/awXcEhMjQgybIQJk36DeUg/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 09:20:47 INFO - Running post-action listener: _resource_record_post_action 09:20:47 INFO - Running post-action listener: set_extra_try_arguments 09:20:47 INFO - [mozharness: 2017-04-27 16:20:47.519237Z] Finished download-and-extract step (success) 09:20:47 INFO - [mozharness: 2017-04-27 16:20:47.519392Z] Running populate-webroot step. 09:20:47 INFO - Running pre-action listener: _resource_record_pre_action 09:20:47 INFO - Running main action method: populate_webroot 09:20:47 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:20:47 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:20:47 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:20:47 INFO - '--tppagecycles', 09:20:47 INFO - '7'], 09:20:47 INFO - 'tests': ['tsvgm']}}, 09:20:47 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 09:20:47 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:20:47 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:20:47 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:20:47 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:20:47 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:20:47 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 09:20:47 INFO - 'talos_options': ['--disable-e10s'], 09:20:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:20:47 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 09:20:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:20:47 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 09:20:47 INFO - 'talos_options': ['--disable-e10s'], 09:20:47 INFO - 'tests': ['damp', 'tps']}, 09:20:47 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 09:20:47 INFO - 'tests': ['damp', 'tps']}, 09:20:47 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:20:47 INFO - 'tests': ['dromaeo_dom']}, 09:20:47 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:20:47 INFO - 'g4': {'talos_options': ['--disable-e10s'], 09:20:47 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 09:20:47 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 09:20:47 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:20:47 INFO - 'tests': ['a11yr', 09:20:47 INFO - 'ts_paint', 09:20:47 INFO - 'tpaint', 09:20:47 INFO - 'sessionrestore', 09:20:47 INFO - 'sessionrestore_no_auto_restore', 09:20:47 INFO - 'tabpaint']}, 09:20:47 INFO - 'other-e10s': {'tests': ['a11yr', 09:20:47 INFO - 'ts_paint', 09:20:47 INFO - 'tpaint', 09:20:47 INFO - 'sessionrestore', 09:20:47 INFO - 'sessionrestore_no_auto_restore', 09:20:47 INFO - 'tabpaint']}, 09:20:47 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:20:47 INFO - 'ts_paint', 09:20:47 INFO - 'tpaint', 09:20:47 INFO - 'sessionrestore', 09:20:47 INFO - 'sessionrestore_no_auto_restore', 09:20:47 INFO - 'tabpaint']}, 09:20:47 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:20:47 INFO - 'ts_paint', 09:20:47 INFO - 'tpaint', 09:20:47 INFO - 'sessionrestore', 09:20:47 INFO - 'sessionrestore_no_auto_restore', 09:20:47 INFO - 'tabpaint']}, 09:20:47 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:20:47 INFO - 'tests': ['a11yr', 09:20:47 INFO - 'ts_paint', 09:20:47 INFO - 'tpaint', 09:20:47 INFO - 'sessionrestore', 09:20:47 INFO - 'sessionrestore_no_auto_restore', 09:20:47 INFO - 'tabpaint']}, 09:20:47 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:20:47 INFO - 'tests': ['a11yr', 09:20:47 INFO - 'ts_paint', 09:20:47 INFO - 'tpaint', 09:20:47 INFO - 'sessionrestore', 09:20:47 INFO - 'sessionrestore_no_auto_restore', 09:20:47 INFO - 'tabpaint']}, 09:20:47 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 09:20:47 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 09:20:47 INFO - 'bloom_basic_ref']}, 09:20:47 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:20:47 INFO - 'tests': ['tsvgx', 09:20:47 INFO - 'tsvgr_opacity', 09:20:47 INFO - 'tart', 09:20:47 INFO - 'tscrollx', 09:20:47 INFO - 'cart', 09:20:47 INFO - 'tsvg_static']}, 09:20:47 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:20:47 INFO - 'tsvgr_opacity', 09:20:47 INFO - 'tart', 09:20:47 INFO - 'tscrollx', 09:20:47 INFO - 'cart', 09:20:47 INFO - 'tsvg_static']}, 09:20:47 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 09:20:47 INFO - 'talos_options': ['--disable-e10s'], 09:20:47 INFO - 'tests': ['tp5o']}, 09:20:47 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 09:20:47 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 09:20:47 INFO - 'talos_options': ['--disable-e10s', 09:20:47 INFO - '--xperf_path', 09:20:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:20:47 INFO - 'tests': ['tp5n']}, 09:20:47 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 09:20:47 INFO - 'talos_options': ['--xperf_path', 09:20:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:20:47 INFO - 'tests': ['tp5n']}}, 09:20:47 INFO - 'talos.zip': {'path': '', 09:20:47 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:20:47 INFO - Running post-action listener: _resource_record_post_action 09:20:47 INFO - [mozharness: 2017-04-27 16:20:47.538985Z] Finished populate-webroot step (success) 09:20:47 INFO - [mozharness: 2017-04-27 16:20:47.539099Z] Running create-virtualenv step. 09:20:47 INFO - Running pre-action listener: _resource_record_pre_action 09:20:47 INFO - Running main action method: create_virtualenv 09:20:47 INFO - Creating virtualenv /builds/slave/test/build/venv 09:20:47 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 09:20:47 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:20:47 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:20:47 INFO - Using real prefix '/tools/python27' 09:20:47 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:20:48 INFO - Installing distribute.............................................................................................................................................................................................done. 09:20:51 INFO - Installing pip.................done. 09:20:51 INFO - Return code: 0 09:20:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 09:20:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 09:20:51 INFO - Reading from file tmpfile_stdout 09:20:51 INFO - Output received: 09:20:51 INFO - pip 1.5.5 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 09:20:51 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:20:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:20:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:20:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:20:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:20:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:20:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:20:51 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 0x108191b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108194768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fea7a55a5c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107f6fd30>, '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 0x107e95db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107f64be8>, '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.xZr80f4b21/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.A7rmB0FSP2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:20:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 09:20:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 09:20:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xZr80f4b21/Render', 09:20:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:20:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:20:51 INFO - 'HOME': '/Users/cltbld', 09:20:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:20:51 INFO - 'LOGNAME': 'cltbld', 09:20:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:20:51 INFO - 'MOZ_NO_REMOTE': '1', 09:20:51 INFO - 'NO_EM_RESTART': '1', 09:20:51 INFO - 'PAGER': '/bin/cat', 09:20:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:20:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:20:51 INFO - 'PWD': '/builds/slave/test', 09:20:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:20:51 INFO - 'SHELL': '/bin/bash', 09:20:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.A7rmB0FSP2/Listeners', 09:20:51 INFO - 'TMPDIR': '/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/', 09:20:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:20:51 INFO - 'USER': 'cltbld', 09:20:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:20:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:20:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:20:51 INFO - 'XPC_FLAGS': '0x0', 09:20:51 INFO - 'XPC_SERVICE_NAME': '0', 09:20:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:20:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:20:51 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 09:20:51 INFO - Cleaning up... 09:20:52 INFO - Return code: 0 09:20:52 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 09:20: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')]} 09:20:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:20:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:20: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')]} 09:20:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:20:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:20:52 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 0x108191b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108194768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fea7a55a5c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107f6fd30>, '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 0x107e95db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107f64be8>, '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.xZr80f4b21/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.A7rmB0FSP2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:20:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 09:20:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 09:20:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xZr80f4b21/Render', 09:20:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:20:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:20:52 INFO - 'HOME': '/Users/cltbld', 09:20:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:20:52 INFO - 'LOGNAME': 'cltbld', 09:20:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:20:52 INFO - 'MOZ_NO_REMOTE': '1', 09:20:52 INFO - 'NO_EM_RESTART': '1', 09:20:52 INFO - 'PAGER': '/bin/cat', 09:20:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:20:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:20:52 INFO - 'PWD': '/builds/slave/test', 09:20:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:20:52 INFO - 'SHELL': '/bin/bash', 09:20:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.A7rmB0FSP2/Listeners', 09:20:52 INFO - 'TMPDIR': '/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/', 09:20:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:20:52 INFO - 'USER': 'cltbld', 09:20:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:20:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:20:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:20:52 INFO - 'XPC_FLAGS': '0x0', 09:20:52 INFO - 'XPC_SERVICE_NAME': '0', 09:20:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:20:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:20:52 INFO - Downloading/unpacking psutil>=3.1.1 09:20:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:20:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:20:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:20:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:20:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:20:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:20:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:20:56 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:20:56 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:20:56 INFO - Installing collected packages: psutil 09:20:56 INFO - Running setup.py install for psutil 09:20:56 INFO - building 'psutil._psutil_osx' extension 09:20:56 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 09:20:56 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 09:20:56 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 09:20:57 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 09:20:57 INFO - building 'psutil._psutil_posix' extension 09:20:57 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 09:20:57 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 09:20:57 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 09:20:57 INFO - ^ 09:20:57 INFO - 1 warning generated. 09:20:57 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 09:20:57 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:20:57 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:20:57 INFO - Successfully installed psutil 09:20:57 INFO - Cleaning up... 09:20:57 INFO - Return code: 0 09:20:57 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 09:20: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')]} 09:20:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:20:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:20: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')]} 09:20:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:20:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:20:57 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x108191b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108194768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fea7a55a5c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107f6fd30>, '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 0x107e95db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107f64be8>, '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.xZr80f4b21/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.A7rmB0FSP2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:20:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 09:20:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 09:20:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xZr80f4b21/Render', 09:20:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:20:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:20:57 INFO - 'HOME': '/Users/cltbld', 09:20:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:20:57 INFO - 'LOGNAME': 'cltbld', 09:20:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:20:57 INFO - 'MOZ_NO_REMOTE': '1', 09:20:57 INFO - 'NO_EM_RESTART': '1', 09:20:57 INFO - 'PAGER': '/bin/cat', 09:20:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:20:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:20:57 INFO - 'PWD': '/builds/slave/test', 09:20:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:20:57 INFO - 'SHELL': '/bin/bash', 09:20:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.A7rmB0FSP2/Listeners', 09:20:57 INFO - 'TMPDIR': '/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/', 09:20:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:20:57 INFO - 'USER': 'cltbld', 09:20:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:20:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:20:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:20:57 INFO - 'XPC_FLAGS': '0x0', 09:20:57 INFO - 'XPC_SERVICE_NAME': '0', 09:20:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:20:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:20:57 INFO - Downloading/unpacking mozsystemmonitor==0.3 09:20:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:20:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:20:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:20:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:20:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:20:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:21:00 INFO - Downloading mozsystemmonitor-0.3.tar.gz 09:21:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:21:00 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 09:21:00 INFO - Installing collected packages: mozsystemmonitor 09:21:00 INFO - Running setup.py install for mozsystemmonitor 09:21:00 INFO - Successfully installed mozsystemmonitor 09:21:00 INFO - Cleaning up... 09:21:00 INFO - Return code: 0 09:21:00 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 09:21:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:21:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:21:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:21:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:21:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:21:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:21:00 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 0x108191b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108194768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fea7a55a5c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107f6fd30>, '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 0x107e95db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107f64be8>, '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.xZr80f4b21/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.A7rmB0FSP2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:21:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 09:21:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 09:21:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xZr80f4b21/Render', 09:21:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:21:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:21:00 INFO - 'HOME': '/Users/cltbld', 09:21:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:21:00 INFO - 'LOGNAME': 'cltbld', 09:21:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:21:00 INFO - 'MOZ_NO_REMOTE': '1', 09:21:00 INFO - 'NO_EM_RESTART': '1', 09:21:00 INFO - 'PAGER': '/bin/cat', 09:21:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:21:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:21:00 INFO - 'PWD': '/builds/slave/test', 09:21:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:21:00 INFO - 'SHELL': '/bin/bash', 09:21:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.A7rmB0FSP2/Listeners', 09:21:00 INFO - 'TMPDIR': '/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/', 09:21:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:21:00 INFO - 'USER': 'cltbld', 09:21:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:21:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:21:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:21:00 INFO - 'XPC_FLAGS': '0x0', 09:21:00 INFO - 'XPC_SERVICE_NAME': '0', 09:21:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:21:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:21:00 INFO - Downloading/unpacking jsonschema==2.5.1 09:21:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:21:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:21:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:21:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:21:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:21:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:21:03 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:21:03 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 09:21:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:21:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:21:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:21:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:21:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:21:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:21:03 INFO - Downloading functools32-3.2.3-2.tar.gz 09:21:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:21:04 INFO - warning: no files found matching '*.txt' 09:21:04 INFO - no previously-included directories found matching 'build' 09:21:04 INFO - no previously-included directories found matching 'dist' 09:21:04 INFO - no previously-included directories found matching '.git*' 09:21:04 INFO - Installing collected packages: jsonschema, functools32 09:21:04 INFO - Running setup.py install for functools32 09:21:04 INFO - warning: no files found matching '*.txt' 09:21:04 INFO - no previously-included directories found matching 'build' 09:21:04 INFO - no previously-included directories found matching 'dist' 09:21:04 INFO - no previously-included directories found matching '.git*' 09:21:04 INFO - Successfully installed jsonschema functools32 09:21:04 INFO - Cleaning up... 09:21:04 INFO - Return code: 0 09:21:04 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 09:21:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:21:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:21:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:21:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:21:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:21:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:21:04 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 0x108191b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108194768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fea7a55a5c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107f6fd30>, '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 0x107e95db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107f64be8>, '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.xZr80f4b21/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.A7rmB0FSP2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:21:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 09:21:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 09:21:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xZr80f4b21/Render', 09:21:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:21:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:21:04 INFO - 'HOME': '/Users/cltbld', 09:21:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:21:04 INFO - 'LOGNAME': 'cltbld', 09:21:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:21:04 INFO - 'MOZ_NO_REMOTE': '1', 09:21:04 INFO - 'NO_EM_RESTART': '1', 09:21:04 INFO - 'PAGER': '/bin/cat', 09:21:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:21:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:21:04 INFO - 'PWD': '/builds/slave/test', 09:21:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:21:04 INFO - 'SHELL': '/bin/bash', 09:21:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.A7rmB0FSP2/Listeners', 09:21:04 INFO - 'TMPDIR': '/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/', 09:21:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:21:04 INFO - 'USER': 'cltbld', 09:21:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:21:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:21:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:21:04 INFO - 'XPC_FLAGS': '0x0', 09:21:04 INFO - 'XPC_SERVICE_NAME': '0', 09:21:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:21:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:21:04 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 09:21:04 INFO - Cleaning up... 09:21:04 INFO - Return code: 0 09:21:04 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:21:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:21:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:21:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:21:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:21:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:21:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:21:04 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 0x108191b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108194768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fea7a55a5c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107f6fd30>, '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 0x107e95db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107f64be8>, '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.xZr80f4b21/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.A7rmB0FSP2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:21:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 09:21:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 09:21:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xZr80f4b21/Render', 09:21:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:21:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:21:04 INFO - 'HOME': '/Users/cltbld', 09:21:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:21:04 INFO - 'LOGNAME': 'cltbld', 09:21:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:21:04 INFO - 'MOZ_NO_REMOTE': '1', 09:21:04 INFO - 'NO_EM_RESTART': '1', 09:21:04 INFO - 'PAGER': '/bin/cat', 09:21:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:21:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:21:04 INFO - 'PWD': '/builds/slave/test', 09:21:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:21:04 INFO - 'SHELL': '/bin/bash', 09:21:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.A7rmB0FSP2/Listeners', 09:21:04 INFO - 'TMPDIR': '/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/', 09:21:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:21:04 INFO - 'USER': 'cltbld', 09:21:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:21:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:21:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:21:04 INFO - 'XPC_FLAGS': '0x0', 09:21:04 INFO - 'XPC_SERVICE_NAME': '0', 09:21:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:21:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:21:04 INFO - Downloading/unpacking blobuploader==1.2.4 09:21:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:21:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:21:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:21:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:21:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:21:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:21:07 INFO - Downloading blobuploader-1.2.4.tar.gz 09:21:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:21:07 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:21:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:21:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:21:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:21:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:21:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:21:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:21:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:21:08 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:21:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:21:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:21:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:21:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:21:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:21:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:21:08 INFO - Downloading docopt-0.6.1.tar.gz 09:21:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:21:08 INFO - Installing collected packages: blobuploader, requests, docopt 09:21:08 INFO - Running setup.py install for blobuploader 09:21:08 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:21:08 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:21:09 INFO - Running setup.py install for requests 09:21:09 INFO - Running setup.py install for docopt 09:21:09 INFO - Successfully installed blobuploader requests docopt 09:21:09 INFO - Cleaning up... 09:21:09 INFO - Return code: 0 09:21:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:21:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:21:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:21:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:21:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:21:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:21:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:21:09 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 0x108191b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108194768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fea7a55a5c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107f6fd30>, '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 0x107e95db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107f64be8>, '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.xZr80f4b21/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.A7rmB0FSP2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:21:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 09:21:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:21:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xZr80f4b21/Render', 09:21:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:21:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:21:09 INFO - 'HOME': '/Users/cltbld', 09:21:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:21:09 INFO - 'LOGNAME': 'cltbld', 09:21:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:21:09 INFO - 'MOZ_NO_REMOTE': '1', 09:21:09 INFO - 'NO_EM_RESTART': '1', 09:21:09 INFO - 'PAGER': '/bin/cat', 09:21:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:21:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:21:09 INFO - 'PWD': '/builds/slave/test', 09:21:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:21:09 INFO - 'SHELL': '/bin/bash', 09:21:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.A7rmB0FSP2/Listeners', 09:21:09 INFO - 'TMPDIR': '/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/', 09:21:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:21:09 INFO - 'USER': 'cltbld', 09:21:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:21:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:21:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:21:09 INFO - 'XPC_FLAGS': '0x0', 09:21:09 INFO - 'XPC_SERVICE_NAME': '0', 09:21:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:21:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:21:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:21:10 INFO - Running setup.py (path:/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/pip-jxDSAK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:21:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:21:10 INFO - Running setup.py (path:/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/pip-E46YtM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:21:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:21:10 INFO - Running setup.py (path:/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/pip-wOxUAZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:21:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:21:10 INFO - Running setup.py (path:/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/pip-iTHOC_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:21:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:21:10 INFO - Running setup.py (path:/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/pip-3ovtYP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:21:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:21:10 INFO - Running setup.py (path:/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/pip-nbebLy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:21:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:21:10 INFO - Running setup.py (path:/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/pip-7i4GGz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:21:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:21:10 INFO - Running setup.py (path:/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/pip-RehJx8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:21:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:21:10 INFO - Running setup.py (path:/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/pip-RtugEj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:21:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:21:10 INFO - Running setup.py (path:/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/pip-uf9NoB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:21:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:21:11 INFO - Running setup.py (path:/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/pip-XaZ8gU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:21:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:21:11 INFO - Running setup.py (path:/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/pip-CrX_uE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:21:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:21:11 INFO - Running setup.py (path:/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/pip-fXT6wi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:21:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:21:11 INFO - Running setup.py (path:/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/pip-TXYEXH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:21:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:21:11 INFO - Running setup.py (path:/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/pip-iw4HTy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:21:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:21:11 INFO - Running setup.py (path:/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/pip-_fateT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:21:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:21:11 INFO - Running setup.py (path:/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/pip-yh9m2f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:21:11 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:21:11 INFO - Running setup.py install for manifestparser 09:21:11 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:21:11 INFO - Running setup.py install for mozcrash 09:21:12 INFO - Running setup.py install for mozdebug 09:21:12 INFO - Running setup.py install for mozdevice 09:21:12 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:21:12 INFO - Running setup.py install for mozfile 09:21:12 INFO - Running setup.py install for mozhttpd 09:21:12 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:21:12 INFO - Running setup.py install for mozinfo 09:21:12 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:21:12 INFO - Running setup.py install for mozInstall 09:21:12 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:21:12 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:21:12 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:21:12 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:21:12 INFO - Running setup.py install for mozleak 09:21:13 INFO - Running setup.py install for mozlog 09:21:13 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:21:13 INFO - Running setup.py install for moznetwork 09:21:13 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:21:13 INFO - Running setup.py install for mozprocess 09:21:13 INFO - Running setup.py install for mozprofile 09:21:13 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:21:13 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:21:13 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:21:13 INFO - Running setup.py install for mozrunner 09:21:13 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:21:13 INFO - Running setup.py install for mozscreenshot 09:21:14 INFO - Running setup.py install for moztest 09:21:14 INFO - Running setup.py install for mozversion 09:21:14 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:21:14 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:21:14 INFO - Cleaning up... 09:21:14 INFO - Return code: 0 09:21:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:21:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:21:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:21:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:21:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:21:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:21:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:21:14 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 0x108191b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108194768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fea7a55a5c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107f6fd30>, '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 0x107e95db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107f64be8>, '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.xZr80f4b21/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.A7rmB0FSP2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:21:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 09:21:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:21:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xZr80f4b21/Render', 09:21:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:21:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:21:14 INFO - 'HOME': '/Users/cltbld', 09:21:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:21:14 INFO - 'LOGNAME': 'cltbld', 09:21:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:21:14 INFO - 'MOZ_NO_REMOTE': '1', 09:21:14 INFO - 'NO_EM_RESTART': '1', 09:21:14 INFO - 'PAGER': '/bin/cat', 09:21:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:21:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:21:14 INFO - 'PWD': '/builds/slave/test', 09:21:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:21:14 INFO - 'SHELL': '/bin/bash', 09:21:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.A7rmB0FSP2/Listeners', 09:21:14 INFO - 'TMPDIR': '/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/', 09:21:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:21:14 INFO - 'USER': 'cltbld', 09:21:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:21:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:21:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:21:14 INFO - 'XPC_FLAGS': '0x0', 09:21:14 INFO - 'XPC_SERVICE_NAME': '0', 09:21:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:21:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:21:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:21:14 INFO - Running setup.py (path:/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/pip-HL4KUM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:21:14 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 09:21:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:21:14 INFO - Running setup.py (path:/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/pip-x1XvtN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:21:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:21:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:21:14 INFO - Running setup.py (path:/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/pip-0t9hUp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:21:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 09:21:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:21:14 INFO - Running setup.py (path:/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/pip-NQPhfZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:21:15 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)) 09:21:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:21:15 INFO - Running setup.py (path:/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/pip-CygPvi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:21:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 09:21:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:21:15 INFO - Running setup.py (path:/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/pip-whSeqj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:21:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 09:21:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:21:15 INFO - Running setup.py (path:/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/pip-jDFHnJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:21:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 09:21:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:21:15 INFO - Running setup.py (path:/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/pip-lJDkdf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:21:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 09:21:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:21:15 INFO - Running setup.py (path:/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/pip-EPo7uX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:21:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 09:21:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:21:15 INFO - Running setup.py (path:/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/pip-aLqPAN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:21:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:21:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:21:15 INFO - Running setup.py (path:/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/pip-LQ5_Y8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:21:15 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 09:21:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:21:15 INFO - Running setup.py (path:/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/pip-iHY1GP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:21:15 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)) 09:21:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:21:15 INFO - Running setup.py (path:/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/pip-Soegu5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:21:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 09:21:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:21:16 INFO - Running setup.py (path:/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/pip-XHX0cS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:21:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 09:21:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:21:16 INFO - Running setup.py (path:/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/pip-9utAod-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:21:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 09:21:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:21:16 INFO - Running setup.py (path:/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/pip-pxFdsl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:21:16 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 09:21:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:21:16 INFO - Running setup.py (path:/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/pip-mNeQ4N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:21:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 09:21:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:21:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:21:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 09:21:16 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)) 09:21:16 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)) 09:21:16 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:21:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:21:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:21:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:21:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:21:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:21:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:21:19 INFO - Downloading blessings-1.6.tar.gz 09:21:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:21:19 INFO - Installing collected packages: blessings 09:21:19 INFO - Running setup.py install for blessings 09:21:19 INFO - Successfully installed blessings 09:21:19 INFO - Cleaning up... 09:21:19 INFO - Return code: 0 09:21:19 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:21:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:21:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:21:19 INFO - Reading from file tmpfile_stdout 09:21:19 INFO - Current package versions: 09:21:19 INFO - blessings == 1.6 09:21:19 INFO - blobuploader == 1.2.4 09:21:19 INFO - docopt == 0.6.1 09:21:19 INFO - functools32 == 3.2.3-2 09:21:19 INFO - jsonschema == 2.5.1 09:21:19 INFO - manifestparser == 1.1 09:21:19 INFO - mozInstall == 1.12 09:21:19 INFO - mozcrash == 1.0 09:21:19 INFO - mozdebug == 0.1 09:21:19 INFO - mozdevice == 0.50 09:21:19 INFO - mozfile == 1.2 09:21:19 INFO - mozhttpd == 0.7 09:21:19 INFO - mozinfo == 0.9 09:21:19 INFO - mozleak == 0.1 09:21:19 INFO - mozlog == 3.4 09:21:19 INFO - moznetwork == 0.27 09:21:19 INFO - mozprocess == 0.25 09:21:19 INFO - mozprofile == 0.28 09:21:19 INFO - mozrunner == 6.13 09:21:19 INFO - mozscreenshot == 0.1 09:21:19 INFO - mozsystemmonitor == 0.3 09:21:19 INFO - moztest == 0.8 09:21:19 INFO - mozversion == 1.4 09:21:19 INFO - psutil == 3.1.1 09:21:19 INFO - requests == 1.2.3 09:21:19 INFO - wsgiref == 0.1.2 09:21:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:21: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')]} 09:21:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:21:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:21: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')]} 09:21:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:21:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:21:19 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 0x108191b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108194768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fea7a55a5c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107f6fd30>, '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 0x107e95db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107f64be8>, '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.xZr80f4b21/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.A7rmB0FSP2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:21:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 09:21:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:21:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xZr80f4b21/Render', 09:21:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:21:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:21:19 INFO - 'HOME': '/Users/cltbld', 09:21:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:21:19 INFO - 'LOGNAME': 'cltbld', 09:21:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:21:19 INFO - 'MOZ_NO_REMOTE': '1', 09:21:19 INFO - 'NO_EM_RESTART': '1', 09:21:19 INFO - 'PAGER': '/bin/cat', 09:21:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:21:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:21:19 INFO - 'PWD': '/builds/slave/test', 09:21:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:21:19 INFO - 'SHELL': '/bin/bash', 09:21:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.A7rmB0FSP2/Listeners', 09:21:19 INFO - 'TMPDIR': '/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/', 09:21:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:21:19 INFO - 'USER': 'cltbld', 09:21:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:21:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:21:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:21:19 INFO - 'XPC_FLAGS': '0x0', 09:21:19 INFO - 'XPC_SERVICE_NAME': '0', 09:21:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:21:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:21:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 09:21:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 09:21:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 09:21:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 09:21:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 09:21:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 09:21:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 09:21:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 09:21:20 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 09:21:20 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 09:21:20 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 09:21:20 INFO - Cleaning up... 09:21:20 INFO - Return code: 0 09:21:20 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:21:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:21:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:21:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:21:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:21:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:21:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:21:20 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 0x108191b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108194768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fea7a55a5c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107f6fd30>, '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 0x107e95db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107f64be8>, '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.xZr80f4b21/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.A7rmB0FSP2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:21:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 09:21:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 09:21:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xZr80f4b21/Render', 09:21:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:21:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:21:20 INFO - 'HOME': '/Users/cltbld', 09:21:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:21:20 INFO - 'LOGNAME': 'cltbld', 09:21:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:21:20 INFO - 'MOZ_NO_REMOTE': '1', 09:21:20 INFO - 'NO_EM_RESTART': '1', 09:21:20 INFO - 'PAGER': '/bin/cat', 09:21:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:21:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:21:20 INFO - 'PWD': '/builds/slave/test', 09:21:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:21:20 INFO - 'SHELL': '/bin/bash', 09:21:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.A7rmB0FSP2/Listeners', 09:21:20 INFO - 'TMPDIR': '/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/', 09:21:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:21:20 INFO - 'USER': 'cltbld', 09:21:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:21:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:21:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:21:20 INFO - 'XPC_FLAGS': '0x0', 09:21:20 INFO - 'XPC_SERVICE_NAME': '0', 09:21:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:21:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:21:20 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 09:21:20 INFO - Cleaning up... 09:21:20 INFO - Return code: 0 09:21:20 INFO - Running post-action listener: _resource_record_post_action 09:21:20 INFO - Running post-action listener: _start_resource_monitoring 09:21:20 INFO - Starting resource monitoring. 09:21:20 INFO - [mozharness: 2017-04-27 16:21:20.327704Z] Finished create-virtualenv step (success) 09:21:20 INFO - [mozharness: 2017-04-27 16:21:20.328656Z] Running install step. 09:21:20 INFO - Running pre-action listener: _resource_record_pre_action 09:21:20 INFO - Running main action method: install 09:21:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:21:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:21:20 INFO - Reading from file tmpfile_stdout 09:21:20 INFO - Detecting whether we're running mozinstall >=1.0... 09:21:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:21:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:21:20 INFO - Reading from file tmpfile_stdout 09:21:20 INFO - Output received: 09:21:20 INFO - Usage: mozinstall [options] installer 09:21:20 INFO - Options: 09:21:20 INFO - -h, --help show this help message and exit 09:21:20 INFO - -d DEST, --destination=DEST 09:21:20 INFO - Directory to install application into. [default: 09:21:20 INFO - "/builds/slave/test"] 09:21:20 INFO - --app=APP Application being installed. [default: firefox] 09:21:20 INFO - mkdir: /builds/slave/test/build/application 09:21:20 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'] 09:21:20 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 09:21:40 INFO - Reading from file tmpfile_stdout 09:21:40 INFO - Output received: 09:21:40 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 09:21:40 INFO - Running post-action listener: _resource_record_post_action 09:21:40 INFO - [mozharness: 2017-04-27 16:21:40.578610Z] Finished install step (success) 09:21:40 INFO - [mozharness: 2017-04-27 16:21:40.578748Z] Running run-tests step. 09:21:40 INFO - Running pre-action listener: _resource_record_pre_action 09:21:40 INFO - Running main action method: run_tests 09:21:40 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 09:21:40 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 09:21:40 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 09:21:40 INFO - 2017-04-27 09:21:40.593 screenresolution[1622:7477] starting screenresolution argv=screenresolution get 09:21:40 INFO - 2017-04-27 09:21:40.596 screenresolution[1622:7477] Display 0: 1600x1200x32@60 09:21:40 INFO - 2017-04-27 09:21:40.602 screenresolution[1623:7480] starting screenresolution argv=screenresolution list 09:21:40 INFO - Available Modes on Display 0 09:21:40 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 09:21:40 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 09:21:40 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 09:21:40 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 09:21:40 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 09:21:40 INFO - Intel Iris: 09:21:40 INFO - Chipset Model: Intel Iris 09:21:40 INFO - Type: GPU 09:21:40 INFO - Bus: Built-In 09:21:40 INFO - VRAM (Dynamic, Max): 1536 MB 09:21:40 INFO - Vendor: Intel (0x8086) 09:21:40 INFO - Device ID: 0x0a2e 09:21:40 INFO - Revision ID: 0x0009 09:21:40 INFO - Displays: 09:21:40 INFO - Display: 09:21:40 INFO - Resolution: 1600 x 1200 @ 60 Hz 09:21:40 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 09:21:40 INFO - Display Serial Number: 1600x1200 60 09:21:40 INFO - Main Display: Yes 09:21:40 INFO - Mirror: Off 09:21:40 INFO - Online: Yes 09:21:40 INFO - Rotation: Supported 09:21:40 INFO - Return code: 0 09:21:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:21:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:21:40 INFO - Python 2.7.3 09:21:40 INFO - Return code: 0 09:21:40 INFO - grabbing minidump binary from tooltool 09:21:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:21:40 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 0x107f6fd30>, '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 0x107e95db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107f64be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:21:40 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 09:21:40 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 09:21:40 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 09:21:40 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:21:40 INFO - Return code: 0 09:21:40 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 09:21:40 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:21:40 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:21:40 INFO - ENV: RUST_BACKTRACE is now 1 09:21:40 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 09:21:40 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:21:40 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/awXcEhMjQgybIQJk36DeUg/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0024', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 09:21:40 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/awXcEhMjQgybIQJk36DeUg/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0024 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 09:21:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xZr80f4b21/Render', 09:21:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:21:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:21:40 INFO - 'HOME': '/Users/cltbld', 09:21:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:21:40 INFO - 'LOGNAME': 'cltbld', 09:21:40 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:21:40 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 09:21:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:21:40 INFO - 'MOZ_NO_REMOTE': '1', 09:21:40 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:21:40 INFO - 'NO_EM_RESTART': '1', 09:21:40 INFO - 'PAGER': '/bin/cat', 09:21:40 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:21:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:21:40 INFO - 'PWD': '/builds/slave/test', 09:21:40 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:21:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:21:40 INFO - 'RUST_BACKTRACE': '1', 09:21:40 INFO - 'SHELL': '/bin/bash', 09:21:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.A7rmB0FSP2/Listeners', 09:21:40 INFO - 'TMPDIR': '/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/', 09:21:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:21:40 INFO - 'USER': 'cltbld', 09:21:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:21:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:21:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:21:40 INFO - 'XPC_FLAGS': '0x0', 09:21:40 INFO - 'XPC_SERVICE_NAME': '0', 09:21:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:21:40 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/awXcEhMjQgybIQJk36DeUg/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0024', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 09:21:41 INFO - mozversion application_buildid: 20170427073327 09:21:41 INFO - mozversion application_changeset: c0d35b1c5ab5fa9bb2f5661aa0454a1ce31b50e0 09:21:41 INFO - mozversion application_display_name: Nightly 09:21:41 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:21:41 INFO - mozversion application_name: Firefox 09:21:41 INFO - mozversion application_remotingname: firefox 09:21:41 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 09:21:41 INFO - mozversion application_vendor: Mozilla 09:21:41 INFO - mozversion application_version: 55.0a1 09:21:41 INFO - mozversion platform_buildid: 20170427073327 09:21:41 INFO - mozversion platform_changeset: c0d35b1c5ab5fa9bb2f5661aa0454a1ce31b50e0 09:21:41 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 09:21:41 INFO - mozversion platform_version: 55.0a1 09:21:41 INFO - using testdate: 1493310101 09:21:41 INFO - actual date: 1493310101 09:21:41 INFO - starting webserver on 'localhost:49235' 09:21:41 INFO - SUITE-START | Running 2 tests 09:21:41 INFO - TEST-START | dromaeo_css 09:21:41 INFO - operating with platform_type : mac_ 09:21:41 INFO - Initialising browser for dromaeo_css test... 09:21:41 INFO - TEST-INFO | started process 1633 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/tmpu7j6mo/profile http://localhost:49235/getInfo.html) 09:21:43 INFO - PID 1633 | __metrics Screen width/height:1600/1200 09:21:43 INFO - PID 1633 | colorDepth:24 09:21:43 INFO - PID 1633 | Browser inner width/height: 1024/689 09:21:43 INFO - PID 1633 | __metrics 09:21:43 INFO - PID 1633 | 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" 09:21:43 INFO - PID 1633 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 334: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:21:44 INFO - TEST-INFO | 1633: exit 0 09:21:44 INFO - Browser initialized. 09:21:44 INFO - Running cycle 1/1 for dromaeo_css test... 09:21:44 INFO - TEST-INFO | started process 1635 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/tmpu7j6mo/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:21:57 INFO - PID 1635 | RSS: Main: 243040256 09:21:57 INFO - PID 1635 | 09:25:01 INFO - PID 1635 | Cycle 1(1): loaded http://localhost:49235/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49235/tests/dromaeo/cssquery-ext.html) 09:25:03 INFO - PID 1635 | RSS: Main: 430297088 09:25:03 INFO - PID 1635 | 09:26:46 INFO - PID 1635 | ************************* 09:26:46 INFO - PID 1635 | A coding exception was thrown and uncaught in a Task. 09:26:46 INFO - PID 1635 | 09:26:46 ERROR - PID 1635 | Full message: TypeError: NetworkError when attempting to fetch resource. 09:26:46 INFO - PID 1635 | Full stack: 09:26:46 INFO - PID 1635 | ************************* 09:26:46 INFO - PID 1635 | ************************* 09:26:46 INFO - PID 1635 | A coding exception was thrown and uncaught in a Task. 09:26:46 INFO - PID 1635 | 09:26:46 ERROR - PID 1635 | Full message: TypeError: NetworkError when attempting to fetch resource. 09:26:46 INFO - PID 1635 | Full stack: 09:26:46 INFO - PID 1635 | ************************* 09:26:46 INFO - PID 1635 | ************************* 09:26:46 INFO - PID 1635 | A coding exception was thrown and uncaught in a Task. 09:26:46 INFO - PID 1635 | 09:26:46 ERROR - PID 1635 | Full message: TypeError: NetworkError when attempting to fetch resource. 09:26:46 INFO - PID 1635 | Full stack: 09:26:46 INFO - PID 1635 | ************************* 09:26:46 INFO - PID 1635 | ************************* 09:26:46 INFO - PID 1635 | A coding exception was thrown and uncaught in a Task. 09:26:46 INFO - PID 1635 | 09:26:46 ERROR - PID 1635 | Full message: TypeError: NetworkError when attempting to fetch resource. 09:26:46 INFO - PID 1635 | Full stack: 09:26:46 INFO - PID 1635 | ************************* 09:28:06 INFO - PID 1635 | Cycle 1(1): loaded http://localhost:49235/tests/dromaeo/cssquery-ext.html (next: http://localhost:49235/tests/dromaeo/cssquery-jquery.html) 09:28:07 INFO - PID 1635 | RSS: Main: 371351552 09:28:07 INFO - PID 1635 | 09:31:09 INFO - PID 1635 | Cycle 1(1): loaded http://localhost:49235/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49235/tests/dromaeo/cssquery-mootools.html) 09:31:10 INFO - PID 1635 | RSS: Main: 353034240 09:31:10 INFO - PID 1635 | 09:34:12 INFO - PID 1635 | Cycle 1(1): loaded http://localhost:49235/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49235/tests/dromaeo/cssquery-prototype.html) 09:34:13 INFO - PID 1635 | RSS: Main: 359174144 09:34:13 INFO - PID 1635 | 09:37:17 INFO - PID 1635 | Cycle 1(1): loaded http://localhost:49235/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49235/tests/dromaeo/cssquery-yui.html) 09:37:17 INFO - PID 1635 | RSS: Main: 331546624 09:37:17 INFO - PID 1635 | 09:40:20 INFO - PID 1635 | Cycle 1(1): loaded http://localhost:49235/tests/dromaeo/cssquery-yui.html (next: http://localhost:49235/tests/dromaeo/cssquery-dojo.html) 09:40:20 INFO - PID 1635 | RSS: Main: 373710848 09:40:20 INFO - PID 1635 | 09:40:20 INFO - PID 1635 | __start_tp_report 09:40:20 INFO - PID 1635 | _x_x_mozilla_page_load 09:40:20 INFO - PID 1635 | _x_x_mozilla_page_load_details 09:40:20 INFO - PID 1635 | |i|pagename|runs| 09:40:20 INFO - PID 1635 | |0;dojo.html;3476.026712520495;3514.2268700885797;3524.559430071241;3542.2915416916608;3548.130707976546;5902.380250073745;5982.611130276529;6142.60073095249;6168.198134242548;6171.598846075008;6101.368489499309;6140.473573783597;6188.133661287412;6213.720382582784;6219.751209951608;4735.065114035682;5152.278680984647;5312.893742125155;5352.946470535294;5448.91826622601;5417.51242388185;5443.156310771837;5459.754311055992;5468.398476167618;5477.534409575191;5231.398389185254;5307.230451584537;5328.333958255218;5344.465553444663;5405.189221616769;5353.009693206769;5355.98236335095;5378.435264297271;5412.485813847678;5435.374931882845;5276.868078298035;5335.066363386431;5350.30446042016;5360.356757189163;5390.326209223847;5880.441358070976;5936.97031514844;6126.142340072393;6131.908021379683;6134.355892631299;6307.24313082433;6443.48452123829;6480.254770701383;6508.739650413978;6525.3800888915475;6325.841853953642;6584.242812076624;6591.868162636721;6609.669516524203;6619.106420633201;6199.628022318675;6223.253209614875;6254.781082662131;6285.057241413824;6285.779997700059;5435.211894275308;6348.904766428507;6394.648294343856;6413.7113829876835;6646.567973081735;6378;6402.743890244431;6419.807405777834;6428.067930150102;6429.678516074177;6503.804885853432;6554.672266386661;6570.474362051024;6582.670866456658;6591.242007169141;6225.470834978987;6465.612063276219;6470.6441145737435;6496.610203387811;6508.9023664645065;6315.778947736807;6315.873682526324;6354.459870910932;6470.611763294218;6521.869562608721;5184.662996905189;5185.196294574272;5213.817516386984;5228.163493840967;5242.659227150223;4535.455745310584;4557.886052848706;4607.746573938465;4639.791209395586;4707.929381059287;5991.970040149771;6073.271207455045;6175.2589689237575;6180.598261113103;6199.3490683477585;5546.639468434539;6316.557840951181;6539;6588.670566471657;6598.86802263952;6182.9798083315745;6202.379762023852;6206.0690896365;6210.161628180228;6215.378462153749;5716.942830571724;5744.942550574441;5752.108423194411;5758.769649213985;5760.337561180518;5405.945940540544;6537.934620653923;6540.313267106885;6546.509011824228;6774.220964589037;6383.96808015957;6389.329120442287;6393.584417013065;6414.711337989708;6543;5672.886542269214;6692.464602831859;6733.42765864907;6759.290274521301;6769.1876974763345;6458.321876202931;6467.676616169267;6471.417572418505;6485.643289618927;6498.090267362668;6281.340459251713;6343.429091381798;6593.80218593443;6609.008648702733;6617.702203400955;6296.212973378328;6314.715837787402;6329.30377658448;6337.081123237197;6349.587276826992;5669.659820410789;6281.968590157203;6316.431521163117;6348.555601107878;6353.205849268841;6285.560010799383;6290.465310448663;6307.148534947907;6316.084167795552;6320.589161704658;6233.625982441068;6276.278228003655;6290.559660823881;6307.873842523032;6318.936810631835;5612.915806262991;5915.231019967377;6287.654179020014;6299.6535190564955;6314.336994615683 09:40:20 INFO - PID 1635 | |1;ext.html;800.3237264511488;809.3848675006997;1122.354646078505;1144.0218613085806;1150.5857891159187;26106;33554.65781368745;33589.992300231;36436;36483.90548283556;38329.42505862414;38612.61387386125;38661;38686.419703704465;38717.225655486945;8157.388195885303;8329.50022998619;8331.791705207388;8347.582620868932;8352.999999999969;5897.292324920994;5967.283925928895;5995.940040599582;5998.55010874184;8235.011798584179;6048.334683184846;7415;8329.958350208271;8335.916640833604;8369.33045356373;8316.251537361637;8368.163183681674;8373.916260837435;8377.664893404257;8393.160683931557;8247.628856701464;8333.29167020804;8337.416380853343;8340.749777506684;8354.039285482126;25229.495410091695;25432.10987615443;25460.745392546207;25466.326035766164;25468.617970730455;3577.713782897362;3589.820508974567;3592.892213233581;3596.8021758803516;3596.9280614387567;30132.24669383283;30286.697133028607;30297;30329.090127296215;30337;3073.124159614499;3115.7818952673324;3127.9374412511625;3139.1053549738217;3143.528470729386;214817;284037;285125.9999999979;286143;287365;47826;48102.27846582304;48130.79673008203;48135;48179.75910120427;40918.977025574;40934.79532602318;41036.589634103875;49363.506364936606;50126.749366253665;13661.658458538417;13770;13770.380332885044;13779.931100344435;13858.4456621734;11215.775684486265;11243.325400475998;11253.043491303331;11260.155488338407;11273.54905803775;12377.443015064344;12390.876091239152;12416.441260143134;12423.391087871467;12515.812262816065;5481.12302031681;5496.148097044965;5498.560115190775;5506.091494903376;5524.751386187631;1039.4127318065268;1043.3739756146404;1059.9523021464054;1076.5532304093713;1082.2045796339685;22574.774252257266;23795.881020594785;23813.285601431984;23895.641565376533;24082;1112.7663190730038;1122.3097794856105;1158.5076342554548;1159.686884541169;1164.441068287227;10473.476326183812;11497.540098396137;12078.33569153705;12103.455344509342;12166.714986953473;308503.914960852;309595;309716;310050;310476.44761776045;51568;51642.483575163766;51728;51795.74102129465;51814.22278665823;1513.2963172125014;1515.3484001879299;1560.2822701557411;1564.2960667699354;1568.913709745975;20932.895335523226;21796.237131700313;23141.88429057844;23226.883865580563;23325.41686457852;37788.62211377851;37989;38012.859614211615;38021.04947376338;38050.85847424582;283987;284489;284575;284777;285436.5728171346;29244.70755292505;29542.81828726827;32657;33934.32131357408;34029.31941361209;41070.38394424026;42597;42679;42714.359284611375;42724.78637606792;27868.442631147667;28810.7118928808;29614.851925740233;29630.81476740906;29947.251318716335;27601.895924162807;28971;29516.557251641672;29826.85086574553;29859;32889;35836.462453063745;35951.460728088576;35979.82010089933;36030;22323.10707571679;26898.462030758885;27943.16170514888;29285.35235616112;30380.24049398783;21129.471763205427;21664.35006949794;21686.8915655427;23342.299731008097;23655.408614784767 09:40:20 INFO - PID 1635 | |2;jquery.html;388.2041814280724;426.4285856951686;437.5209145985146;444.26695951679733;448.2939370491477;16821.495355139352;21241.57516849662;21291.935403229854;21580.352589422324;21816.345509634735;22747.772522274772;22773.20293789718;23473.178438754647;23723.169689060887;23726;5889.381614930435;6084.361142080084;6123.418275263843;6195.256569211679;6276.466500347453;3648.562172539299;3698.1124530112847;6112.510999120082;6214.409631085062;6225.097360882669;3678.50340204073;3690.4833323334756;3724.776513409204;3742.307673080475;5418.593605479585;4829.9275510867365;6172.351903050205;6194.969025154868;6199.721012554446;6204.6587437690905;5347.893042139135;5431.891362172734;5501.202325662796;5506.614536982413;5519.254900588409;27026.459470810474;27931.86034069837;28025.299367515974;28207.294817629725;28295.858520707472;2180.4221881201493;2234.4860682043222;2243.394283543434;2245.2702871566808;2250.437390652337;17302.04838733869;17481.853266412167;17817.821821781745;17905.015224162667;18107.00411477368;2120.522882351474;2128.9148434062618;2178.923737669174;2180.5965896309076;2183.5851188274337;128374.07438888424;149830;159868;165724;172419.13790431092;11481.770364592661;11847.822282665767;11873.821892671616;12462;12548.81176782349;15259.313330900137;16303.266353014144;16521.504354869372;16682.582935426468;16703.33186672544;7301.707931682779;7936.920630793618;8622.698205562776;9042.367034307666;9170.174684278447;8563.700270490628;8568.10034946334;8585.441946273471;8723.738287851374;8734.737957861274;7662.961685191538;7818.6090695465;7955.920440795634;7999.9600001999615;8013.2387423194705;2069.3481553310658;2111.2391557038777;2134.1570079818694;2135.370065830584;2136.81837043853;935.4434111703525;947.4126041854095;959.7072892767633;981.8183636027358;983.7147227304001;19164.329248476235;19295.807041929682;20438.795612043985;20615.793842061386;21040;863.3481721300378;930.2000279759402;966.5167416291854;969.5443141723379;998.6205242007991;8814.86777698335;10706.304090234109;10752.462376881125;10849.837252441219;10861.67414977552;500061.99876002275;502650;510628;529534;529975;137246;137834;142302.2884885569;142486;144174.2791286037;1165.7668466306773;1171.771768777031;1185.0874826383808;1195.862475815275;1196.2463647901766;15577.454789082327;16591.585210369838;17912.92522448657;18590.44228673142;18702.877827330405;47529.52470475251;49329.50670493249;57521.849563009346;57899.710501447225;58900.41099588949;59469.70265148646;79650.6017469909;80742;80892.59553702195;80952.3809523818;7039.014537964586;8629.741107766777;8745.300375970035;8894.155055269739;8971.551422428984;12454.31501267439;13317;14281.000329976801;14502.202378869264;14562.927185364006;11905.583304584297;12153.939230303791;12216.572419965258;12290.877091229331;12302.815457767962;11370.488328025423;11409.3724845131;11590.88409115898;11750.412479375826;11822.82265765997;12058.397080146133;12394.02543389562;12580.308083055153;12605.43275552584;12743.80884286755;8949.239314658327;9116.726498205064;9160.816783664422;9178.173964343241;9187.862182067141;10071.194304455772;11250.437478125898;11892.583759568719;12009.219400738924;12242.693932651755 09:40:20 INFO - PID 1635 | |3;mootools.html;1257.6541451100948;1436.8419473857873;1446.7395868743636;1456.228199054501;1457.1111621910638;11215.887841121586;11707.765844683101;11714.121440891924;11720.945114939665;11736.178467507267;10992;11600.187986840925;11675.766484670301;11698.415079246046;11704.707382315446;2510.4728007118483;2551.336652470362;2558.1430220876027;2560.398306397995;2562.6027965665353;1994.8204661580455;2397.7961873240706;2503.849769013856;2510.874456277188;2514.5473814713346;2121.098533123424;2329.5457385809773;2499.825012249143;2504.060977133575;2505.9749402506013;2428.3929017745563;2431.4286142756437;2432.100122954518;2437.536867995093;2437.9756202437925;2060.721802556651;2386.689730335045;2443.6090225563826;2491.978288901542;2498.700155981294;9757.12185903272;9852;11369.204155709103;11592.47833847479;11596.594119205787;6493.70778314977;6750.189977202767;6772.864542709118;6773.593584384904;6780.220274668427;3827.158025234444;4158.9376159357635;4218.198542276958;4229.429027081335;4235.428217190702;932.2821427500786;1228.5134986666144;1267.4296566545;1281.634734100786;1283.6277479530925;16389;16461.6707665846;16480.42318518846;16503.587410314718;16538.421155259508;4948.837023299522;5237.685738855681;5315.681059136464;5353.946460535422;5632.042552765957;11721.941390292994;11742.94313511771;11745;11758.88241117595;11761.059115270758;6126.050462178369;6546.24718157418;6551.672416379257;6553.541252112402;6554.672266386661;5902.793402230901;5932.525397968238;6017.06735456005;6149.66176860268;6265.780697675559;3554.7867127972404;4134.37984302357;4217.156568686275;4249.702520823513;4269.829206831692;1228.5454381878583;1230.1450491908038;1239.1016513028162;1252.768237875996;1256.1395444120624;768.769369189241;784.2118670735874;797.6849144587856;805.6334367862609;806.2703253555542;6609.537332386687;6861.210960739479;6987.580745155307;7006.75476358325;7040.6479676016;911.1799380557419;931.1852129386787;940.3464592108419;943.6697155995485;951.7002144324516;3790.1093243087853;3868.9806550967064;3976.324024915771;4094.488188976378;4331.826726930951;14949.832274320162;15064.472743453927;15240.237988100773;15247.23763811805;15421.460248891235;14432.278386080654;15089.396424142911;15192.392304307705;15214.391424342903;15247.313870875838;8301.750947471586;8538.316934645214;8542;8568.742937712002;8568.785780355542;6483.578567393104;6731.966340168464;6976.790696279119;7000.47496437759;7143.535670181422;12865.549705760253;13645.863541364857;13654.317284135555;13905;13914.512992045635;12040.578579749666;12114.75770484603;14077.788833167715;14110.153390796175;14163.291835407983;9063.818723625622;9176.95411522938;9192;9334.019927907744;9334.766630834283;10324.896751032695;10611.522481488506;10638.627648032281;10647.041766241075;10648.254622176682;7588.354989825927;8779.0781967895;8940.195382415353;9107.134822191882;9161.358704890594;8807.251383632207;8834.823303533765;8865.202131808168;8982.966958799821;9151.99328073898;5830.300363956352;8139.941807564978;8178.7955301117945;8264.752057438287;8304.211099945496;5554.222408862844;6078.300995385587;6080.635161890301;6191.566590338633;6236.937630623635;6002.909956350571;6059.121427393092;6222.502199823913;6249.875002500015;6371.55399122057 09:40:20 INFO - PID 1635 | |4;prototype.html;386.5303656057889;402.29397407549754;410.40081481037686;411.66449343784814;416.997915010425;5969.7015149242525;5971.820845374646;5992.910106348409;6013.128096426016;6020.30766461857;5200.32395788547;5398.433164517728;5620.747066382012;5855.736491857866;5882.970585147079;3605.4591811228393;3930.3711406175016;4082.6320733974226;4298.828046878121;4300.182965236603;3579.266250418658;3750.1562148516637;4309.719868208556;4329.7402155870595;4333.046729719456;4076.429299898017;4255.4467919170465;4257.659387249028;4277.401163837049;4293.338130359181;3601.9099522511883;3602.783832970017;4219.641330486912;4221.725587836811;4244.915101697964;3516.595591506984;3689.612590677967;3691.2617476504806;3693.150575367654;3716.6655001049767;5472.50747432729;5691.630044047124;5724.914126288109;5779.913301300484;5814.941850581525;3849.3263678856088;5005.349304590416;5028.7988480460735;5038.362532177057;5038.546530812245;4863.927041094386;5232.633715639907;6135.417135372132;6229.906551401733;6282.277538083134;3450.5852600433955;3995.760254384746;4135.276326642826;4135.669146468275;4178.8537401190815;5898.439648233454;5909.113632955091;6306.400891915261;6464.482841372679;6573.967130164367;3512.9297414051575;3686.281175170816;3871.2838124946975;4188.434561334181;4216.093539888939;3572.5534308211472;4075.959240407558;4106.753594784323;4260.318349064197;4279.251131052053;4873.756312184377;4908.656394052382;4972.229304457815;5026.673266237756;5037.395512538519;5279.340082489689;6300.243970723543;6303.338149494329;6313.368663133741;6313.873722525615;1274.8278982337451;1335.2255691698792;1441.9206943617992;1455.3087283540444;1460.7224627320775;879.2043200903192;888.8578177042469;930.1953809954341;948.4451595816387;958.4584709639032;5501.697406642673;5926.2295901532525;5968.582199246098;6001.699915004232;6007.519398448114;6014.7594096236535;6536.967315163393;6554.3614096475885;6569.901451478232;6576.013597960345;5425.294711687534;5614.522765564891;5897.085951677497;5924.229850119543;6020.849478762978;3119.31556959244;3128.108489080601;3261.3041218566686;3360.277540328841;3407.420738474416;6439.227292724903;6706.195256569243;6758.729650814011;6773.45812335012;6810.931890681129;5548.750306236229;6724.193096828412;6793.592384456949;6802.421794147553;6831.180258368928;5335.359756829205;5733.792489891505;5889.882202355929;6655.201375834931;6687.465002799764;5654.568535529762;5792.565557583114;5894.2926848778425;6510.218773746991;6585.868282634417;6093.329733729198;6121.816345509642;6193.318734939063;6365.267994180544;6448.742050318122;4558.931616025696;5670.546356291569;6499.155109835691;6515.413612774683;6576.177977752781;4087.2234275487563;4119.105211602697;4156.189543039079;4160.521540022936;4161.375793630979;5635.703788128835;6451.709568187917;6485.448736857231;6513.817871013263;6570.244421891543;5251.921221181609;5705.914411283751;5932.881342373042;6293.402126797947;6333.240011198685;5389.380221274603;6222.688865556795;6255.9374406257175;6258.7809426671665;6335.746570137143;6160.383961603804;6208.348123446973;6221.5333849960525;6233.189685340877;6234.937650623436;5808.477237048686;5822.039363505143;5955.67243801595;6101.816945491642;6291.150694656346;6165.475934545614;6165.84585385369;6170.259568851767;6200.007998720183;6247.219097612799 09:40:20 INFO - PID 1635 | |5;yui.html;700.5481464455423;839.9118092600277;843.1905370843989;844.4637655089018;857.1856736100704;13245.867541324584;17754.82245177548;17755.46733597994;18839.24643014278;18890.81109188906;17106.401275955344;17118.400855970045;17473.126343682798;17503.474895753116;17549;962.4658314635392;976.5166242709869;981.3817295104075;981.4258658684643;985.2364417576364;669.6317025635905;682.2222666160557;960.8798900137483;1005.7284533176038;1006.4615430744553;1047.6176195688595;1049.0244073012095;1049.2655141401012;1049.380865289479;1049.4595283429003;1046.2728403759313;1046.4140081554353;1046.863907691999;1047.4448542272607;1056.8678915135608;502.6255439697412;519.1356391607968;742.4728442805615;773.1688434932414;775.5540564175622;16581.005139691537;17015.744763828552;17037.7444338335;17076.402325918534;17117.31530738769;16894;16925.3229870805;17222.655546889117;17383.565410864703;17399.130043497775;13816.93091534546;13878.722425551432;14028.368723407471;14120.364583593762;14147.221902795342;3452.7065199458075;3505.333986542574;3506.105942984548;3515.2617950230483;3515.5781306243416;129476;129482;131440;131539;133710.33144834312;11099.667009989713;13446.260455674836;13578.321083945762;13630.045896787327;13897.513587024609;17574.824251757575;19702.70445943312;20107.19571217135;20112.39662810118;25154.874225628755;7580.393568514505;7760.223977602308;7761.68953241864;7764;7781;3776.8300426480873;3806.923861522754;3862.9956211385243;3905.9804700976315;3912.158885839558;4227.175700738388;4307.483102027777;4308.612224899774;4311.956880431156;4317.892052698645;912.4662072687552;953.4184147669915;959.4627008875052;962.8940816510178;963.3834346018554;628.977985770505;642.6658137768334;652.2629428745487;652.6182183422655;669.0699927101333;9169.633214671338;10131.594736210616;10988.560457581767;11123.555057797597;11986.700332491757;624.3974564545235;639.389383139101;647.543481845298;671.8219671786981;674.7638326585655;5102.515261050195;5637.859053523613;5651.491365777018;5679.716014199274;5794.333651630117;82049.58975205086;106277;107617;108968.65470179378;110324.89675103307;95019;95827.52086239523;96760.4859271115;96814.51592741991;97841;84695;86256.56871715726;87026.68653075186;88384.5580772092;88732;11211;11316.962946669679;11393.14551408631;11411.771764564828;11507.021903138328;42514.78742606267;43164.13671726485;43421.56578434175;43512.12975740404;43557.475488357755;56262.15606765984;63984.68007659932;64934;69104;69730.65134674295;16664.50006499807;17067.317307307567;17085.914570427067;17110.058946758047;17254.827451725323;17698.5575360617;18399.54001149982;18707.25170993145;18849.6230075395;18901.621967560848;16376.263068161723;16442.588935276715;16662.91668541698;16714.913530620957;17080;14430.927845361126;16377.181140942666;16543.586410339838;16790.412335568195;16867.240974156437;15969.520914372588;16161.75757363664;16496.83503164953;16530.256138473556;16697.332106715596;11134.944325278322;11518.53925842957;11717.238379505305;11774.764504710029;12239.877601223874;11416.393638527526;12849.35753212317;13789.448422063406;13792.517601675097;13889.236092015037 09:40:20 INFO - PID 1635 | __end_tp_report 09:40:20 INFO - PID 1635 | __start_cc_report 09:40:20 INFO - PID 1635 | _x_x_mozilla_cycle_collect,2079 09:40:20 INFO - PID 1635 | __end_cc_report 09:40:20 INFO - PID 1635 | __startTimestamp1493311220421__endTimestamp 09:40:20 INFO - PID 1635 | 09:40:20 INFO - PID 1635 | ------- Summary: start ------- 09:40:20 INFO - PID 1635 | Number of tests: 6 09:40:20 INFO - PID 1635 | 09:40:20 INFO - PID 1635 | [#0] dojo.html Cycles:165 Average:5984.79 Median:6276.28 stddev:677.68 (10.8%) stddev-sans-first:650.55 09:40:20 INFO - PID 1635 | Values: 3476.0 3514.2 3524.6 3542.3 3548.1 5902.4 5982.6 6142.6 6168.2 6171.6 6101.4 6140.5 6188.1 6213.7 6219.8 4735.1 5152.3 5312.9 5352.9 5448.9 5417.5 5443.2 5459.8 5468.4 5477.5 5231.4 5307.2 5328.3 5344.5 5405.2 5353.0 5356.0 5378.4 5412.5 5435.4 5276.9 5335.1 5350.3 5360.4 5390.3 5880.4 5937.0 6126.1 6131.9 6134.4 6307.2 6443.5 6480.3 6508.7 6525.4 6325.8 6584.2 6591.9 6609.7 6619.1 6199.6 6223.3 6254.8 6285.1 6285.8 5435.2 6348.9 6394.6 6413.7 6646.6 6378.0 6402.7 6419.8 6428.1 6429.7 6503.8 6554.7 6570.5 6582.7 6591.2 6225.5 6465.6 6470.6 6496.6 6508.9 6315.8 6315.9 6354.5 6470.6 6521.9 5184.7 5185.2 5213.8 5228.2 5242.7 4535.5 4557.9 4607.7 4639.8 4707.9 5992.0 6073.3 6175.3 6180.6 6199.3 5546.6 6316.6 6539.0 6588.7 6598.9 6183.0 6202.4 6206.1 6210.2 6215.4 5716.9 5744.9 5752.1 5758.8 5760.3 5405.9 6537.9 6540.3 6546.5 6774.2 6384.0 6389.3 6393.6 6414.7 6543.0 5672.9 6692.5 6733.4 6759.3 6769.2 6458.3 6467.7 6471.4 6485.6 6498.1 6281.3 6343.4 6593.8 6609.0 6617.7 6296.2 6314.7 6329.3 6337.1 6349.6 5669.7 6282.0 6316.4 6348.6 6353.2 6285.6 6290.5 6307.1 6316.1 6320.6 6233.6 6276.3 6290.6 6307.9 6318.9 5612.9 5915.2 6287.7 6299.7 6314.3 09:40:20 INFO - PID 1635 | 09:40:20 INFO - PID 1635 | [#1] ext.html Cycles:180 Average:42901.16 Median:16726.68 stddev:76010.60 (454.4%) stddev-sans-first:76158.10 09:40:20 INFO - PID 1635 | Values: 800.3 809.4 1122.4 1144.0 1150.6 26106.0 33554.7 33590.0 36436.0 36483.9 38329.4 38612.6 38661.0 38686.4 38717.2 8157.4 8329.5 8331.8 8347.6 8353.0 5897.3 5967.3 5995.9 5998.6 8235.0 6048.3 7415.0 8330.0 8335.9 8369.3 8316.3 8368.2 8373.9 8377.7 8393.2 8247.6 8333.3 8337.4 8340.7 8354.0 25229.5 25432.1 25460.7 25466.3 25468.6 3577.7 3589.8 3592.9 3596.8 3596.9 30132.2 30286.7 30297.0 30329.1 30337.0 3073.1 3115.8 3127.9 3139.1 3143.5 214817.0 284037.0 285126.0 286143.0 287365.0 47826.0 48102.3 48130.8 48135.0 48179.8 40919.0 40934.8 41036.6 49363.5 50126.7 13661.7 13770.0 13770.4 13779.9 13858.4 11215.8 11243.3 11253.0 11260.2 11273.5 12377.4 12390.9 12416.4 12423.4 12515.8 5481.1 5496.1 5498.6 5506.1 5524.8 1039.4 1043.4 1060.0 1076.6 1082.2 22574.8 23795.9 23813.3 23895.6 24082.0 1112.8 1122.3 1158.5 1159.7 1164.4 10473.5 11497.5 12078.3 12103.5 12166.7 308503.9 309595.0 309716.0 310050.0 310476.4 51568.0 51642.5 51728.0 51795.7 51814.2 1513.3 1515.3 1560.3 1564.3 1568.9 20932.9 21796.2 23141.9 23226.9 23325.4 37788.6 37989.0 38012.9 38021.0 38050.9 283987.0 284489.0 284575.0 284777.0 285436.6 29244.7 29542.8 32657.0 33934.3 34029.3 41070.4 42597.0 42679.0 42714.4 42724.8 27868.4 28810.7 29614.9 29630.8 29947.3 27601.9 28971.0 29516.6 29826.9 29859.0 32889.0 35836.5 35951.5 35979.8 36030.0 22323.1 26898.5 27943.2 29285.4 30380.2 21129.5 21664.4 21686.9 23342.3 23655.4 09:40:20 INFO - PID 1635 | 09:40:20 INFO - PID 1635 | [#2] jquery.html Cycles:180 Average:34661.12 Median:23123.19 stddev:88329.67 (382.0%) stddev-sans-first:88539.97 09:40:20 INFO - PID 1635 | Values: 388.2 426.4 437.5 444.3 448.3 16821.5 21241.6 21291.9 21580.4 21816.3 22747.8 22773.2 23473.2 23723.2 23726.0 5889.4 6084.4 6123.4 6195.3 6276.5 3648.6 3698.1 6112.5 6214.4 6225.1 3678.5 3690.5 3724.8 3742.3 5418.6 4829.9 6172.4 6195.0 6199.7 6204.7 5347.9 5431.9 5501.2 5506.6 5519.3 27026.5 27931.9 28025.3 28207.3 28295.9 2180.4 2234.5 2243.4 2245.3 2250.4 17302.0 17481.9 17817.8 17905.0 18107.0 2120.5 2128.9 2178.9 2180.6 2183.6 128374.1 149830.0 159868.0 165724.0 172419.1 11481.8 11847.8 11873.8 12462.0 12548.8 15259.3 16303.3 16521.5 16682.6 16703.3 7301.7 7936.9 8622.7 9042.4 9170.2 8563.7 8568.1 8585.4 8723.7 8734.7 7663.0 7818.6 7955.9 8000.0 8013.2 2069.3 2111.2 2134.2 2135.4 2136.8 935.4 947.4 959.7 981.8 983.7 19164.3 19295.8 20438.8 20615.8 21040.0 863.3 930.2 966.5 969.5 998.6 8814.9 10706.3 10752.5 10849.8 10861.7 500062.0 502650.0 510628.0 529534.0 529975.0 137246.0 137834.0 142302.3 142486.0 144174.3 1165.8 1171.8 1185.1 1195.9 1196.2 15577.5 16591.6 17912.9 18590.4 18702.9 47529.5 49329.5 57521.8 57899.7 58900.4 59469.7 79650.6 80742.0 80892.6 80952.4 7039.0 8629.7 8745.3 8894.2 8971.6 12454.3 13317.0 14281.0 14502.2 14562.9 11905.6 12153.9 12216.6 12290.9 12302.8 11370.5 11409.4 11590.9 11750.4 11822.8 12058.4 12394.0 12580.3 12605.4 12743.8 8949.2 9116.7 9160.8 9178.2 9187.9 10071.2 11250.4 11892.6 12009.2 12242.7 09:40:20 INFO - PID 1635 | 09:40:20 INFO - PID 1635 | [#3] mootools.html Cycles:180 Average:7040.72 Median:3922.65 stddev:4497.32 (114.6%) stddev-sans-first:4488.94 09:40:20 INFO - PID 1635 | Values: 1257.7 1436.8 1446.7 1456.2 1457.1 11215.9 11707.8 11714.1 11720.9 11736.2 10992.0 11600.2 11675.8 11698.4 11704.7 2510.5 2551.3 2558.1 2560.4 2562.6 1994.8 2397.8 2503.8 2510.9 2514.5 2121.1 2329.5 2499.8 2504.1 2506.0 2428.4 2431.4 2432.1 2437.5 2438.0 2060.7 2386.7 2443.6 2492.0 2498.7 9757.1 9852.0 11369.2 11592.5 11596.6 6493.7 6750.2 6772.9 6773.6 6780.2 3827.2 4158.9 4218.2 4229.4 4235.4 932.3 1228.5 1267.4 1281.6 1283.6 16389.0 16461.7 16480.4 16503.6 16538.4 4948.8 5237.7 5315.7 5353.9 5632.0 11721.9 11742.9 11745.0 11758.9 11761.1 6126.1 6546.2 6551.7 6553.5 6554.7 5902.8 5932.5 6017.1 6149.7 6265.8 3554.8 4134.4 4217.2 4249.7 4269.8 1228.5 1230.1 1239.1 1252.8 1256.1 768.8 784.2 797.7 805.6 806.3 6609.5 6861.2 6987.6 7006.8 7040.6 911.2 931.2 940.3 943.7 951.7 3790.1 3869.0 3976.3 4094.5 4331.8 14949.8 15064.5 15240.2 15247.2 15421.5 14432.3 15089.4 15192.4 15214.4 15247.3 8301.8 8538.3 8542.0 8568.7 8568.8 6483.6 6732.0 6976.8 7000.5 7143.5 12865.5 13645.9 13654.3 13905.0 13914.5 12040.6 12114.8 14077.8 14110.2 14163.3 9063.8 9177.0 9192.0 9334.0 9334.8 10324.9 10611.5 10638.6 10647.0 10648.3 7588.4 8779.1 8940.2 9107.1 9161.4 8807.3 8834.8 8865.2 8983.0 9152.0 5830.3 8139.9 8178.8 8264.8 8304.2 5554.2 6078.3 6080.6 6191.6 6236.9 6002.9 6059.1 6222.5 6249.9 6371.6 09:40:20 INFO - PID 1635 | 09:40:20 INFO - PID 1635 | [#4] prototype.html Cycles:180 Average:4987.97 Median:5729.35 stddev:1607.92 (28.1%) stddev-sans-first:1574.90 09:40:20 INFO - PID 1635 | Values: 386.5 402.3 410.4 411.7 417.0 5969.7 5971.8 5992.9 6013.1 6020.3 5200.3 5398.4 5620.7 5855.7 5883.0 3605.5 3930.4 4082.6 4298.8 4300.2 3579.3 3750.2 4309.7 4329.7 4333.0 4076.4 4255.4 4257.7 4277.4 4293.3 3601.9 3602.8 4219.6 4221.7 4244.9 3516.6 3689.6 3691.3 3693.2 3716.7 5472.5 5691.6 5724.9 5779.9 5814.9 3849.3 5005.3 5028.8 5038.4 5038.5 4863.9 5232.6 6135.4 6229.9 6282.3 3450.6 3995.8 4135.3 4135.7 4178.9 5898.4 5909.1 6306.4 6464.5 6574.0 3512.9 3686.3 3871.3 4188.4 4216.1 3572.6 4076.0 4106.8 4260.3 4279.3 4873.8 4908.7 4972.2 5026.7 5037.4 5279.3 6300.2 6303.3 6313.4 6313.9 1274.8 1335.2 1441.9 1455.3 1460.7 879.2 888.9 930.2 948.4 958.5 5501.7 5926.2 5968.6 6001.7 6007.5 6014.8 6537.0 6554.4 6569.9 6576.0 5425.3 5614.5 5897.1 5924.2 6020.8 3119.3 3128.1 3261.3 3360.3 3407.4 6439.2 6706.2 6758.7 6773.5 6810.9 5548.8 6724.2 6793.6 6802.4 6831.2 5335.4 5733.8 5889.9 6655.2 6687.5 5654.6 5792.6 5894.3 6510.2 6585.9 6093.3 6121.8 6193.3 6365.3 6448.7 4558.9 5670.5 6499.2 6515.4 6576.2 4087.2 4119.1 4156.2 4160.5 4161.4 5635.7 6451.7 6485.4 6513.8 6570.2 5251.9 5705.9 5932.9 6293.4 6333.2 5389.4 6222.7 6255.9 6258.8 6335.7 6160.4 6208.3 6221.5 6233.2 6234.9 5808.5 5822.0 5955.7 6101.8 6291.2 6165.5 6165.8 6170.3 6200.0 6247.2 09:40:20 INFO - PID 1635 | 09:40:20 INFO - PID 1635 | [#5] yui.html Cycles:180 Average:22399.75 Median:18553.40 stddev:32130.92 (173.2%) stddev-sans-first:32179.74 09:40:20 INFO - PID 1635 | Values: 700.5 839.9 843.2 844.5 857.2 13245.9 17754.8 17755.5 18839.2 18890.8 17106.4 17118.4 17473.1 17503.5 17549.0 962.5 976.5 981.4 981.4 985.2 669.6 682.2 960.9 1005.7 1006.5 1047.6 1049.0 1049.3 1049.4 1049.5 1046.3 1046.4 1046.9 1047.4 1056.9 502.6 519.1 742.5 773.2 775.6 16581.0 17015.7 17037.7 17076.4 17117.3 16894.0 16925.3 17222.7 17383.6 17399.1 13816.9 13878.7 14028.4 14120.4 14147.2 3452.7 3505.3 3506.1 3515.3 3515.6 129476.0 129482.0 131440.0 131539.0 133710.3 11099.7 13446.3 13578.3 13630.0 13897.5 17574.8 19702.7 20107.2 20112.4 25154.9 7580.4 7760.2 7761.7 7764.0 7781.0 3776.8 3806.9 3863.0 3906.0 3912.2 4227.2 4307.5 4308.6 4312.0 4317.9 912.5 953.4 959.5 962.9 963.4 629.0 642.7 652.3 652.6 669.1 9169.6 10131.6 10988.6 11123.6 11986.7 624.4 639.4 647.5 671.8 674.8 5102.5 5637.9 5651.5 5679.7 5794.3 82049.6 106277.0 107617.0 108968.7 110324.9 95019.0 95827.5 96760.5 96814.5 97841.0 84695.0 86256.6 87026.7 88384.6 88732.0 11211.0 11317.0 11393.1 11411.8 11507.0 42514.8 43164.1 43421.6 43512.1 43557.5 56262.2 63984.7 64934.0 69104.0 69730.7 16664.5 17067.3 17085.9 17110.1 17254.8 17698.6 18399.5 18707.3 18849.6 18901.6 16376.3 16442.6 16662.9 16714.9 17080.0 14430.9 16377.2 16543.6 16790.4 16867.2 15969.5 16161.8 16496.8 16530.3 16697.3 11134.9 11518.5 11717.2 11774.8 12239.9 11416.4 12849.4 13789.4 13792.5 13889.2 09:40:20 INFO - PID 1635 | -------- Summary: end -------- 09:40:20 INFO - PID 1635 | 09:40:21 INFO - TEST-INFO | 1635: exit 0 09:40:21 INFO - TEST-OK | dromaeo_css | took 1119958ms 09:40:21 INFO - TEST-START | kraken 09:40:21 INFO - operating with platform_type : mac_ 09:40:21 INFO - Initialising browser for kraken test... 09:40:21 INFO - TEST-INFO | started process 1642 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/tmp3vLzU8/profile http://localhost:49235/getInfo.html) 09:40:23 INFO - PID 1642 | __metrics Screen width/height:1600/1200 09:40:23 INFO - PID 1642 | colorDepth:24 09:40:23 INFO - PID 1642 | Browser inner width/height: 1024/689 09:40:23 INFO - PID 1642 | __metrics 09:40:23 INFO - PID 1642 | 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" 09:40:23 INFO - PID 1642 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 334: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:40:24 INFO - TEST-INFO | 1642: exit 0 09:40:24 INFO - Browser initialized. 09:40:24 INFO - Running cycle 1/1 for kraken test... 09:40:24 INFO - TEST-INFO | started process 1643 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/tmp3vLzU8/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:40:36 INFO - PID 1643 | RSS: Main: 242696192 09:40:36 INFO - PID 1643 | 09:40:39 INFO - PID 1643 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49235/tests/kraken/driver.html?testName=audio-beat-detection) 09:40:40 INFO - PID 1643 | RSS: Main: 311967744 09:40:40 INFO - PID 1643 | 09:40:43 INFO - PID 1643 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49235/tests/kraken/driver.html?testName=audio-dft) 09:40:43 INFO - PID 1643 | RSS: Main: 292384768 09:40:43 INFO - PID 1643 | 09:40:47 INFO - PID 1643 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49235/tests/kraken/driver.html?testName=audio-fft) 09:40:47 INFO - PID 1643 | RSS: Main: 386289664 09:40:47 INFO - PID 1643 | 09:40:49 INFO - PID 1643 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49235/tests/kraken/driver.html?testName=audio-oscillator) 09:40:50 INFO - PID 1643 | RSS: Main: 288432128 09:40:50 INFO - PID 1643 | 09:40:52 INFO - PID 1643 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49235/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:40:53 INFO - PID 1643 | RSS: Main: 290877440 09:40:53 INFO - PID 1643 | 09:40:56 INFO - PID 1643 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49235/tests/kraken/driver.html?testName=imaging-darkroom) 09:40:56 INFO - PID 1643 | RSS: Main: 354279424 09:40:56 INFO - PID 1643 | 09:40:59 INFO - PID 1643 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49235/tests/kraken/driver.html?testName=imaging-desaturate) 09:41:00 INFO - PID 1643 | RSS: Main: 371609600 09:41:00 INFO - PID 1643 | 09:41:03 INFO - PID 1643 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49235/tests/kraken/driver.html?testName=json-parse-financial) 09:41:03 INFO - PID 1643 | RSS: Main: 359260160 09:41:03 INFO - PID 1643 | 09:41:05 INFO - PID 1643 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49235/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:41:05 INFO - PID 1643 | RSS: Main: 333553664 09:41:05 INFO - PID 1643 | 09:41:07 INFO - PID 1643 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49235/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:41:08 INFO - PID 1643 | RSS: Main: 335220736 09:41:08 INFO - PID 1643 | 09:41:10 INFO - PID 1643 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49235/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:41:11 INFO - PID 1643 | RSS: Main: 337448960 09:41:11 INFO - PID 1643 | 09:41:13 INFO - PID 1643 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49235/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:41:14 INFO - PID 1643 | RSS: Main: 333086720 09:41:14 INFO - PID 1643 | 09:41:17 INFO - PID 1643 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49235/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:41:18 INFO - PID 1643 | RSS: Main: 343711744 09:41:18 INFO - PID 1643 | 09:41:20 INFO - PID 1643 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49235/tests/kraken/driver.html?testName=ai-astar) 09:41:20 INFO - PID 1643 | RSS: Main: 386306048 09:41:20 INFO - PID 1643 | 09:41:20 INFO - PID 1643 | __start_tp_report 09:41:20 INFO - PID 1643 | _x_x_mozilla_page_load 09:41:20 INFO - PID 1643 | _x_x_mozilla_page_load_details 09:41:20 INFO - PID 1643 | |i|pagename|runs| 09:41:20 INFO - PID 1643 | |0;ai-astar;112;109;109;109;109;111;110;110;110;111 09:41:20 INFO - PID 1643 | |1;audio-beat-detection;142;118;137;182;121;105;108;112;159;141 09:41:20 INFO - PID 1643 | |2;audio-dft;184;185;184;186;186;184;184;225;219;184 09:41:20 INFO - PID 1643 | |3;audio-fft;77;58;60;106;49;79;84;82;96;49 09:41:20 INFO - PID 1643 | |4;audio-oscillator;93;70;89;97;101;101;111;95;69;92 09:41:20 INFO - PID 1643 | |5;imaging-gaussian-blur;88;87;87;87;86;86;87;87;88;87 09:41:20 INFO - PID 1643 | |6;imaging-darkroom;102;94;94;96;95;94;95;95;94;95 09:41:20 INFO - PID 1643 | |7;imaging-desaturate;84;84;84;84;83;84;86;83;85;83 09:41:20 INFO - PID 1643 | |8;json-parse-financial;49;47;47;47;48;47;48;47;48;49 09:41:20 INFO - PID 1643 | |9;json-stringify-tinderbox;54;59;60;67;61;58;58;57;58;55 09:41:20 INFO - PID 1643 | |10;stanford-crypto-aes;84;82;84;82;80;82;82;81;82;82 09:41:20 INFO - PID 1643 | |11;stanford-crypto-ccm;137;135;134;135;134;137;138;148;176;146 09:41:20 INFO - PID 1643 | |12;stanford-crypto-pbkdf2;187;187;182;181;188;184;181;184;186;183 09:41:20 INFO - PID 1643 | |13;stanford-crypto-sha256-iterative;61;85;97;92;69;68;68;68;68;69 09:41:20 INFO - PID 1643 | __end_tp_report 09:41:20 INFO - PID 1643 | __start_cc_report 09:41:20 INFO - PID 1643 | _x_x_mozilla_cycle_collect,2205 09:41:20 INFO - PID 1643 | __end_cc_report 09:41:20 INFO - PID 1643 | __startTimestamp1493311280421__endTimestamp 09:41:20 INFO - PID 1643 | 09:41:20 INFO - PID 1643 | ------- Summary: start ------- 09:41:20 INFO - PID 1643 | Number of tests: 14 09:41:20 INFO - PID 1643 | 09:41:20 INFO - PID 1643 | [#0] ai-astar Cycles:10 Average:110.00 Median:110.00 stddev:1.05 (1.0%) stddev-sans-first:0.83 09:41:20 INFO - PID 1643 | Values: 112.0 109.0 109.0 109.0 109.0 111.0 110.0 110.0 110.0 111.0 09:41:20 INFO - PID 1643 | 09:41:20 INFO - PID 1643 | [#1] audio-beat-detection Cycles:10 Average:132.50 Median:139.00 stddev:24.62 (17.7%) stddev-sans-first:25.87 09:41:20 INFO - PID 1643 | Values: 142.0 118.0 137.0 182.0 121.0 105.0 108.0 112.0 159.0 141.0 09:41:20 INFO - PID 1643 | 09:41:20 INFO - PID 1643 | [#2] audio-dft Cycles:10 Average:192.10 Median:185.50 stddev:15.84 (8.5%) stddev-sans-first:16.53 09:41:20 INFO - PID 1643 | Values: 184.0 185.0 184.0 186.0 186.0 184.0 184.0 225.0 219.0 184.0 09:41:20 INFO - PID 1643 | 09:41:20 INFO - PID 1643 | [#3] audio-fft Cycles:10 Average:74.00 Median:78.00 stddev:19.46 (24.9%) stddev-sans-first:20.61 09:41:20 INFO - PID 1643 | Values: 77.0 58.0 60.0 106.0 49.0 79.0 84.0 82.0 96.0 49.0 09:41:20 INFO - PID 1643 | 09:41:20 INFO - PID 1643 | [#4] audio-oscillator Cycles:10 Average:91.80 Median:90.50 stddev:13.25 (14.6%) stddev-sans-first:14.04 09:41:20 INFO - PID 1643 | Values: 93.0 70.0 89.0 97.0 101.0 101.0 111.0 95.0 69.0 92.0 09:41:20 INFO - PID 1643 | 09:41:20 INFO - PID 1643 | [#5] imaging-gaussian-blur Cycles:10 Average:87.00 Median:87.00 stddev:0.67 (0.8%) stddev-sans-first:0.60 09:41:20 INFO - PID 1643 | Values: 88.0 87.0 87.0 87.0 86.0 86.0 87.0 87.0 88.0 87.0 09:41:20 INFO - PID 1643 | 09:41:20 INFO - PID 1643 | [#6] imaging-darkroom Cycles:10 Average:95.40 Median:95.00 stddev:2.41 (2.5%) stddev-sans-first:0.71 09:41:20 INFO - PID 1643 | Values: 102.0 94.0 94.0 96.0 95.0 94.0 95.0 95.0 94.0 95.0 09:41:20 INFO - PID 1643 | 09:41:20 INFO - PID 1643 | [#7] imaging-desaturate Cycles:10 Average:84.00 Median:84.00 stddev:0.94 (1.1%) stddev-sans-first:1.00 09:41:20 INFO - PID 1643 | Values: 84.0 84.0 84.0 84.0 83.0 84.0 86.0 83.0 85.0 83.0 09:41:20 INFO - PID 1643 | 09:41:20 INFO - PID 1643 | [#8] json-parse-financial Cycles:10 Average:47.70 Median:48.00 stddev:0.82 (1.7%) stddev-sans-first:0.73 09:41:20 INFO - PID 1643 | Values: 49.0 47.0 47.0 47.0 48.0 47.0 48.0 47.0 48.0 49.0 09:41:20 INFO - PID 1643 | 09:41:20 INFO - PID 1643 | [#9] json-stringify-tinderbox Cycles:10 Average:58.70 Median:58.50 stddev:3.59 (6.1%) stddev-sans-first:3.38 09:41:20 INFO - PID 1643 | Values: 54.0 59.0 60.0 67.0 61.0 58.0 58.0 57.0 58.0 55.0 09:41:20 INFO - PID 1643 | 09:41:20 INFO - PID 1643 | [#10] stanford-crypto-aes Cycles:10 Average:82.10 Median:82.00 stddev:1.20 (1.5%) stddev-sans-first:1.05 09:41:20 INFO - PID 1643 | Values: 84.0 82.0 84.0 82.0 80.0 82.0 82.0 81.0 82.0 82.0 09:41:20 INFO - PID 1643 | 09:41:20 INFO - PID 1643 | [#11] stanford-crypto-ccm Cycles:10 Average:142.00 Median:137.50 stddev:12.91 (9.4%) stddev-sans-first:13.57 09:41:20 INFO - PID 1643 | Values: 137.0 135.0 134.0 135.0 134.0 137.0 138.0 148.0 176.0 146.0 09:41:20 INFO - PID 1643 | 09:41:20 INFO - PID 1643 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:184.30 Median:185.00 stddev:2.58 (1.4%) stddev-sans-first:2.55 09:41:20 INFO - PID 1643 | Values: 187.0 187.0 182.0 181.0 188.0 184.0 181.0 184.0 186.0 183.0 09:41:20 INFO - PID 1643 | 09:41:20 INFO - PID 1643 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:74.50 Median:69.00 stddev:12.18 (17.6%) stddev-sans-first:11.90 09:41:20 INFO - PID 1643 | Values: 61.0 85.0 97.0 92.0 69.0 68.0 68.0 68.0 68.0 69.0 09:41:20 INFO - PID 1643 | -------- Summary: end -------- 09:41:20 INFO - PID 1643 | 09:41:21 INFO - TEST-INFO | 1643: exit 0 09:41:21 INFO - TEST-OK | kraken | took 60398ms 09:41:21 INFO - SUITE-END | took 1180s 09:41:21 INFO - Completed test suite (00:19:40) 09:41:21 INFO - javascript benchmark 09:41:21 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7649.730296049984, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3476.026712520495, 3514.2268700885797, 3524.559430071241, 3542.2915416916608, 3548.130707976546, 5902.380250073745, 5982.611130276529, 6142.60073095249, 6168.198134242548, 6171.598846075008, 6101.368489499309, 6140.473573783597, 6188.133661287412, 6213.720382582784, 6219.751209951608, 4735.065114035682, 5152.278680984647, 5312.893742125155, 5352.946470535294, 5448.91826622601, 5417.51242388185, 5443.156310771837, 5459.754311055992, 5468.398476167618, 5477.534409575191, 5231.398389185254, 5307.230451584537, 5328.333958255218, 5344.465553444663, 5405.189221616769, 5353.009693206769, 5355.98236335095, 5378.435264297271, 5412.485813847678, 5435.374931882845, 5276.868078298035, 5335.066363386431, 5350.30446042016, 5360.356757189163, 5390.326209223847, 5880.441358070976, 5936.97031514844, 6126.142340072393, 6131.908021379683, 6134.355892631299, 6307.24313082433, 6443.48452123829, 6480.254770701383, 6508.739650413978, 6525.3800888915475, 6325.841853953642, 6584.242812076624, 6591.868162636721, 6609.669516524203, 6619.106420633201, 6199.628022318675, 6223.253209614875, 6254.781082662131, 6285.057241413824, 6285.779997700059, 5435.211894275308, 6348.904766428507, 6394.648294343856, 6413.7113829876835, 6646.567973081735, 6378.0, 6402.743890244431, 6419.807405777834, 6428.067930150102, 6429.678516074177, 6503.804885853432, 6554.672266386661, 6570.474362051024, 6582.670866456658, 6591.242007169141, 6225.470834978987, 6465.612063276219, 6470.6441145737435, 6496.610203387811, 6508.9023664645065, 6315.778947736807, 6315.873682526324, 6354.459870910932, 6470.611763294218, 6521.869562608721, 5184.662996905189, 5185.196294574272, 5213.817516386984, 5228.163493840967, 5242.659227150223, 4535.455745310584, 4557.886052848706, 4607.746573938465, 4639.791209395586, 4707.929381059287, 5991.970040149771, 6073.271207455045, 6175.2589689237575, 6180.598261113103, 6199.3490683477585, 5546.639468434539, 6316.557840951181, 6539.0, 6588.670566471657, 6598.86802263952, 6182.9798083315745, 6202.379762023852, 6206.0690896365, 6210.161628180228, 6215.378462153749, 5716.942830571724, 5744.942550574441, 5752.108423194411, 5758.769649213985, 5760.337561180518, 5405.945940540544, 6537.934620653923, 6540.313267106885, 6546.509011824228, 6774.220964589037, 6383.96808015957, 6389.329120442287, 6393.584417013065, 6414.711337989708, 6543.0, 5672.886542269214, 6692.464602831859, 6733.42765864907, 6759.290274521301, 6769.1876974763345, 6458.321876202931, 6467.676616169267, 6471.417572418505, 6485.643289618927, 6498.090267362668, 6281.340459251713, 6343.429091381798, 6593.80218593443, 6609.008648702733, 6617.702203400955, 6296.212973378328, 6314.715837787402, 6329.30377658448, 6337.081123237197, 6349.587276826992, 5669.659820410789, 6281.968590157203, 6316.431521163117, 6348.555601107878, 6353.205849268841, 6285.560010799383, 6290.465310448663, 6307.148534947907, 6316.084167795552, 6320.589161704658, 6233.625982441068, 6276.278228003655, 6290.559660823881, 6307.873842523032, 6318.936810631835, 5612.915806262991, 5915.231019967377, 6287.654179020014, 6299.6535190564955, 6314.336994615683], "value": 5942.27369049052, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [800.3237264511488, 809.3848675006997, 1122.354646078505, 1144.0218613085806, 1150.5857891159187, 26106.0, 33554.65781368745, 33589.992300231, 36436.0, 36483.90548283556, 38329.42505862414, 38612.61387386125, 38661.0, 38686.419703704465, 38717.225655486945, 8157.388195885303, 8329.50022998619, 8331.791705207388, 8347.582620868932, 8352.999999999969, 5897.292324920994, 5967.283925928895, 5995.940040599582, 5998.55010874184, 8235.011798584179, 6048.334683184846, 7415.0, 8329.958350208271, 8335.916640833604, 8369.33045356373, 8316.251537361637, 8368.163183681674, 8373.916260837435, 8377.664893404257, 8393.160683931557, 8247.628856701464, 8333.29167020804, 8337.416380853343, 8340.749777506684, 8354.039285482126, 25229.495410091695, 25432.10987615443, 25460.745392546207, 25466.326035766164, 25468.617970730455, 3577.713782897362, 3589.820508974567, 3592.892213233581, 3596.8021758803516, 3596.9280614387567, 30132.24669383283, 30286.697133028607, 30297.0, 30329.090127296215, 30337.0, 3073.124159614499, 3115.7818952673324, 3127.9374412511625, 3139.1053549738217, 3143.528470729386, 214817.0, 284037.0, 285125.9999999979, 286143.0, 287365.0, 47826.0, 48102.27846582304, 48130.79673008203, 48135.0, 48179.75910120427, 40918.977025574, 40934.79532602318, 41036.589634103875, 49363.506364936606, 50126.749366253665, 13661.658458538417, 13770.0, 13770.380332885044, 13779.931100344435, 13858.4456621734, 11215.775684486265, 11243.325400475998, 11253.043491303331, 11260.155488338407, 11273.54905803775, 12377.443015064344, 12390.876091239152, 12416.441260143134, 12423.391087871467, 12515.812262816065, 5481.12302031681, 5496.148097044965, 5498.560115190775, 5506.091494903376, 5524.751386187631, 1039.4127318065268, 1043.3739756146404, 1059.9523021464054, 1076.5532304093713, 1082.2045796339685, 22574.774252257266, 23795.881020594785, 23813.285601431984, 23895.641565376533, 24082.0, 1112.7663190730038, 1122.3097794856105, 1158.5076342554548, 1159.686884541169, 1164.441068287227, 10473.476326183812, 11497.540098396137, 12078.33569153705, 12103.455344509342, 12166.714986953473, 308503.914960852, 309595.0, 309716.0, 310050.0, 310476.44761776045, 51568.0, 51642.483575163766, 51728.0, 51795.74102129465, 51814.22278665823, 1513.2963172125014, 1515.3484001879299, 1560.2822701557411, 1564.2960667699354, 1568.913709745975, 20932.895335523226, 21796.237131700313, 23141.88429057844, 23226.883865580563, 23325.41686457852, 37788.62211377851, 37989.0, 38012.859614211615, 38021.04947376338, 38050.85847424582, 283987.0, 284489.0, 284575.0, 284777.0, 285436.5728171346, 29244.70755292505, 29542.81828726827, 32657.0, 33934.32131357408, 34029.31941361209, 41070.38394424026, 42597.0, 42679.0, 42714.359284611375, 42724.78637606792, 27868.442631147667, 28810.7118928808, 29614.851925740233, 29630.81476740906, 29947.251318716335, 27601.895924162807, 28971.0, 29516.557251641672, 29826.85086574553, 29859.0, 32889.0, 35836.462453063745, 35951.460728088576, 35979.82010089933, 36030.0, 22323.10707571679, 26898.462030758885, 27943.16170514888, 29285.35235616112, 30380.24049398783, 21129.471763205427, 21664.35006949794, 21686.8915655427, 23342.299731008097, 23655.408614784767], "value": 16669.121058943863, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [388.2041814280724, 426.4285856951686, 437.5209145985146, 444.26695951679733, 448.2939370491477, 16821.495355139352, 21241.57516849662, 21291.935403229854, 21580.352589422324, 21816.345509634735, 22747.772522274772, 22773.20293789718, 23473.178438754647, 23723.169689060887, 23726.0, 5889.381614930435, 6084.361142080084, 6123.418275263843, 6195.256569211679, 6276.466500347453, 3648.562172539299, 3698.1124530112847, 6112.510999120082, 6214.409631085062, 6225.097360882669, 3678.50340204073, 3690.4833323334756, 3724.776513409204, 3742.307673080475, 5418.593605479585, 4829.9275510867365, 6172.351903050205, 6194.969025154868, 6199.721012554446, 6204.6587437690905, 5347.893042139135, 5431.891362172734, 5501.202325662796, 5506.614536982413, 5519.254900588409, 27026.459470810474, 27931.86034069837, 28025.299367515974, 28207.294817629725, 28295.858520707472, 2180.4221881201493, 2234.4860682043222, 2243.394283543434, 2245.2702871566808, 2250.437390652337, 17302.04838733869, 17481.853266412167, 17817.821821781745, 17905.015224162667, 18107.00411477368, 2120.522882351474, 2128.9148434062618, 2178.923737669174, 2180.5965896309076, 2183.5851188274337, 128374.07438888424, 149830.0, 159868.0, 165724.0, 172419.13790431092, 11481.770364592661, 11847.822282665767, 11873.821892671616, 12462.0, 12548.81176782349, 15259.313330900137, 16303.266353014144, 16521.504354869372, 16682.582935426468, 16703.33186672544, 7301.707931682779, 7936.920630793618, 8622.698205562776, 9042.367034307666, 9170.174684278447, 8563.700270490628, 8568.10034946334, 8585.441946273471, 8723.738287851374, 8734.737957861274, 7662.961685191538, 7818.6090695465, 7955.920440795634, 7999.9600001999615, 8013.2387423194705, 2069.3481553310658, 2111.2391557038777, 2134.1570079818694, 2135.370065830584, 2136.81837043853, 935.4434111703525, 947.4126041854095, 959.7072892767633, 981.8183636027358, 983.7147227304001, 19164.329248476235, 19295.807041929682, 20438.795612043985, 20615.793842061386, 21040.0, 863.3481721300378, 930.2000279759402, 966.5167416291854, 969.5443141723379, 998.6205242007991, 8814.86777698335, 10706.304090234109, 10752.462376881125, 10849.837252441219, 10861.67414977552, 500061.99876002275, 502650.0, 510628.0, 529534.0, 529975.0, 137246.0, 137834.0, 142302.2884885569, 142486.0, 144174.2791286037, 1165.7668466306773, 1171.771768777031, 1185.0874826383808, 1195.862475815275, 1196.2463647901766, 15577.454789082327, 16591.585210369838, 17912.92522448657, 18590.44228673142, 18702.877827330405, 47529.52470475251, 49329.50670493249, 57521.849563009346, 57899.710501447225, 58900.41099588949, 59469.70265148646, 79650.6017469909, 80742.0, 80892.59553702195, 80952.3809523818, 7039.014537964586, 8629.741107766777, 8745.300375970035, 8894.155055269739, 8971.551422428984, 12454.31501267439, 13317.0, 14281.000329976801, 14502.202378869264, 14562.927185364006, 11905.583304584297, 12153.939230303791, 12216.572419965258, 12290.877091229331, 12302.815457767962, 11370.488328025423, 11409.3724845131, 11590.88409115898, 11750.412479375826, 11822.82265765997, 12058.397080146133, 12394.02543389562, 12580.308083055153, 12605.43275552584, 12743.80884286755, 8949.239314658327, 9116.726498205064, 9160.816783664422, 9178.173964343241, 9187.862182067141, 10071.194304455772, 11250.437478125898, 11892.583759568719, 12009.219400738924, 12242.693932651755], "value": 10182.395693194607, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1257.6541451100948, 1436.8419473857873, 1446.7395868743636, 1456.228199054501, 1457.1111621910638, 11215.887841121586, 11707.765844683101, 11714.121440891924, 11720.945114939665, 11736.178467507267, 10992.0, 11600.187986840925, 11675.766484670301, 11698.415079246046, 11704.707382315446, 2510.4728007118483, 2551.336652470362, 2558.1430220876027, 2560.398306397995, 2562.6027965665353, 1994.8204661580455, 2397.7961873240706, 2503.849769013856, 2510.874456277188, 2514.5473814713346, 2121.098533123424, 2329.5457385809773, 2499.825012249143, 2504.060977133575, 2505.9749402506013, 2428.3929017745563, 2431.4286142756437, 2432.100122954518, 2437.536867995093, 2437.9756202437925, 2060.721802556651, 2386.689730335045, 2443.6090225563826, 2491.978288901542, 2498.700155981294, 9757.12185903272, 9852.0, 11369.204155709103, 11592.47833847479, 11596.594119205787, 6493.70778314977, 6750.189977202767, 6772.864542709118, 6773.593584384904, 6780.220274668427, 3827.158025234444, 4158.9376159357635, 4218.198542276958, 4229.429027081335, 4235.428217190702, 932.2821427500786, 1228.5134986666144, 1267.4296566545, 1281.634734100786, 1283.6277479530925, 16389.0, 16461.6707665846, 16480.42318518846, 16503.587410314718, 16538.421155259508, 4948.837023299522, 5237.685738855681, 5315.681059136464, 5353.946460535422, 5632.042552765957, 11721.941390292994, 11742.94313511771, 11745.0, 11758.88241117595, 11761.059115270758, 6126.050462178369, 6546.24718157418, 6551.672416379257, 6553.541252112402, 6554.672266386661, 5902.793402230901, 5932.525397968238, 6017.06735456005, 6149.66176860268, 6265.780697675559, 3554.7867127972404, 4134.37984302357, 4217.156568686275, 4249.702520823513, 4269.829206831692, 1228.5454381878583, 1230.1450491908038, 1239.1016513028162, 1252.768237875996, 1256.1395444120624, 768.769369189241, 784.2118670735874, 797.6849144587856, 805.6334367862609, 806.2703253555542, 6609.537332386687, 6861.210960739479, 6987.580745155307, 7006.75476358325, 7040.6479676016, 911.1799380557419, 931.1852129386787, 940.3464592108419, 943.6697155995485, 951.7002144324516, 3790.1093243087853, 3868.9806550967064, 3976.324024915771, 4094.488188976378, 4331.826726930951, 14949.832274320162, 15064.472743453927, 15240.237988100773, 15247.23763811805, 15421.460248891235, 14432.278386080654, 15089.396424142911, 15192.392304307705, 15214.391424342903, 15247.313870875838, 8301.750947471586, 8538.316934645214, 8542.0, 8568.742937712002, 8568.785780355542, 6483.578567393104, 6731.966340168464, 6976.790696279119, 7000.47496437759, 7143.535670181422, 12865.549705760253, 13645.863541364857, 13654.317284135555, 13905.0, 13914.512992045635, 12040.578579749666, 12114.75770484603, 14077.788833167715, 14110.153390796175, 14163.291835407983, 9063.818723625622, 9176.95411522938, 9192.0, 9334.019927907744, 9334.766630834283, 10324.896751032695, 10611.522481488506, 10638.627648032281, 10647.041766241075, 10648.254622176682, 7588.354989825927, 8779.0781967895, 8940.195382415353, 9107.134822191882, 9161.358704890594, 8807.251383632207, 8834.823303533765, 8865.202131808168, 8982.966958799821, 9151.99328073898, 5830.300363956352, 8139.941807564978, 8178.7955301117945, 8264.752057438287, 8304.211099945496, 5554.222408862844, 6078.300995385587, 6080.635161890301, 6191.566590338633, 6236.937630623635, 6002.909956350571, 6059.121427393092, 6222.502199823913, 6249.875002500015, 6371.55399122057], "value": 5309.868597777317, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [386.5303656057889, 402.29397407549754, 410.40081481037686, 411.66449343784814, 416.997915010425, 5969.7015149242525, 5971.820845374646, 5992.910106348409, 6013.128096426016, 6020.30766461857, 5200.32395788547, 5398.433164517728, 5620.747066382012, 5855.736491857866, 5882.970585147079, 3605.4591811228393, 3930.3711406175016, 4082.6320733974226, 4298.828046878121, 4300.182965236603, 3579.266250418658, 3750.1562148516637, 4309.719868208556, 4329.7402155870595, 4333.046729719456, 4076.429299898017, 4255.4467919170465, 4257.659387249028, 4277.401163837049, 4293.338130359181, 3601.9099522511883, 3602.783832970017, 4219.641330486912, 4221.725587836811, 4244.915101697964, 3516.595591506984, 3689.612590677967, 3691.2617476504806, 3693.150575367654, 3716.6655001049767, 5472.50747432729, 5691.630044047124, 5724.914126288109, 5779.913301300484, 5814.941850581525, 3849.3263678856088, 5005.349304590416, 5028.7988480460735, 5038.362532177057, 5038.546530812245, 4863.927041094386, 5232.633715639907, 6135.417135372132, 6229.906551401733, 6282.277538083134, 3450.5852600433955, 3995.760254384746, 4135.276326642826, 4135.669146468275, 4178.8537401190815, 5898.439648233454, 5909.113632955091, 6306.400891915261, 6464.482841372679, 6573.967130164367, 3512.9297414051575, 3686.281175170816, 3871.2838124946975, 4188.434561334181, 4216.093539888939, 3572.5534308211472, 4075.959240407558, 4106.753594784323, 4260.318349064197, 4279.251131052053, 4873.756312184377, 4908.656394052382, 4972.229304457815, 5026.673266237756, 5037.395512538519, 5279.340082489689, 6300.243970723543, 6303.338149494329, 6313.368663133741, 6313.873722525615, 1274.8278982337451, 1335.2255691698792, 1441.9206943617992, 1455.3087283540444, 1460.7224627320775, 879.2043200903192, 888.8578177042469, 930.1953809954341, 948.4451595816387, 958.4584709639032, 5501.697406642673, 5926.2295901532525, 5968.582199246098, 6001.699915004232, 6007.519398448114, 6014.7594096236535, 6536.967315163393, 6554.3614096475885, 6569.901451478232, 6576.013597960345, 5425.294711687534, 5614.522765564891, 5897.085951677497, 5924.229850119543, 6020.849478762978, 3119.31556959244, 3128.108489080601, 3261.3041218566686, 3360.277540328841, 3407.420738474416, 6439.227292724903, 6706.195256569243, 6758.729650814011, 6773.45812335012, 6810.931890681129, 5548.750306236229, 6724.193096828412, 6793.592384456949, 6802.421794147553, 6831.180258368928, 5335.359756829205, 5733.792489891505, 5889.882202355929, 6655.201375834931, 6687.465002799764, 5654.568535529762, 5792.565557583114, 5894.2926848778425, 6510.218773746991, 6585.868282634417, 6093.329733729198, 6121.816345509642, 6193.318734939063, 6365.267994180544, 6448.742050318122, 4558.931616025696, 5670.546356291569, 6499.155109835691, 6515.413612774683, 6576.177977752781, 4087.2234275487563, 4119.105211602697, 4156.189543039079, 4160.521540022936, 4161.375793630979, 5635.703788128835, 6451.709568187917, 6485.448736857231, 6513.817871013263, 6570.244421891543, 5251.921221181609, 5705.914411283751, 5932.881342373042, 6293.402126797947, 6333.240011198685, 5389.380221274603, 6222.688865556795, 6255.9374406257175, 6258.7809426671665, 6335.746570137143, 6160.383961603804, 6208.348123446973, 6221.5333849960525, 6233.189685340877, 6234.937650623436, 5808.477237048686, 5822.039363505143, 5955.67243801595, 6101.816945491642, 6291.150694656346, 6165.475934545614, 6165.84585385369, 6170.259568851767, 6200.007998720183, 6247.219097612799], "value": 4492.02957008588, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [700.5481464455423, 839.9118092600277, 843.1905370843989, 844.4637655089018, 857.1856736100704, 13245.867541324584, 17754.82245177548, 17755.46733597994, 18839.24643014278, 18890.81109188906, 17106.401275955344, 17118.400855970045, 17473.126343682798, 17503.474895753116, 17549.0, 962.4658314635392, 976.5166242709869, 981.3817295104075, 981.4258658684643, 985.2364417576364, 669.6317025635905, 682.2222666160557, 960.8798900137483, 1005.7284533176038, 1006.4615430744553, 1047.6176195688595, 1049.0244073012095, 1049.2655141401012, 1049.380865289479, 1049.4595283429003, 1046.2728403759313, 1046.4140081554353, 1046.863907691999, 1047.4448542272607, 1056.8678915135608, 502.6255439697412, 519.1356391607968, 742.4728442805615, 773.1688434932414, 775.5540564175622, 16581.005139691537, 17015.744763828552, 17037.7444338335, 17076.402325918534, 17117.31530738769, 16894.0, 16925.3229870805, 17222.655546889117, 17383.565410864703, 17399.130043497775, 13816.93091534546, 13878.722425551432, 14028.368723407471, 14120.364583593762, 14147.221902795342, 3452.7065199458075, 3505.333986542574, 3506.105942984548, 3515.2617950230483, 3515.5781306243416, 129476.0, 129482.0, 131440.0, 131539.0, 133710.33144834312, 11099.667009989713, 13446.260455674836, 13578.321083945762, 13630.045896787327, 13897.513587024609, 17574.824251757575, 19702.70445943312, 20107.19571217135, 20112.39662810118, 25154.874225628755, 7580.393568514505, 7760.223977602308, 7761.68953241864, 7764.0, 7781.0, 3776.8300426480873, 3806.923861522754, 3862.9956211385243, 3905.9804700976315, 3912.158885839558, 4227.175700738388, 4307.483102027777, 4308.612224899774, 4311.956880431156, 4317.892052698645, 912.4662072687552, 953.4184147669915, 959.4627008875052, 962.8940816510178, 963.3834346018554, 628.977985770505, 642.6658137768334, 652.2629428745487, 652.6182183422655, 669.0699927101333, 9169.633214671338, 10131.594736210616, 10988.560457581767, 11123.555057797597, 11986.700332491757, 624.3974564545235, 639.389383139101, 647.543481845298, 671.8219671786981, 674.7638326585655, 5102.515261050195, 5637.859053523613, 5651.491365777018, 5679.716014199274, 5794.333651630117, 82049.58975205086, 106277.0, 107617.0, 108968.65470179378, 110324.89675103307, 95019.0, 95827.52086239523, 96760.4859271115, 96814.51592741991, 97841.0, 84695.0, 86256.56871715726, 87026.68653075186, 88384.5580772092, 88732.0, 11211.0, 11316.962946669679, 11393.14551408631, 11411.771764564828, 11507.021903138328, 42514.78742606267, 43164.13671726485, 43421.56578434175, 43512.12975740404, 43557.475488357755, 56262.15606765984, 63984.68007659932, 64934.0, 69104.0, 69730.65134674295, 16664.50006499807, 17067.317307307567, 17085.914570427067, 17110.058946758047, 17254.827451725323, 17698.5575360617, 18399.54001149982, 18707.25170993145, 18849.6230075395, 18901.621967560848, 16376.263068161723, 16442.588935276715, 16662.91668541698, 16714.913530620957, 17080.0, 14430.927845361126, 16377.181140942666, 16543.586410339838, 16790.412335568195, 16867.240974156437, 15969.520914372588, 16161.75757363664, 16496.83503164953, 16530.256138473556, 16697.332106715596, 11134.944325278322, 11518.53925842957, 11717.238379505305, 11774.764504710029, 12239.877601223874, 11416.393638527526, 12849.35753212317, 13789.448422063406, 13792.517601675097, 13889.236092015037], "value": 8329.199808344034, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1456.1, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 109.0, 109.0, 109.0, 109.0, 111.0, 110.0, 110.0, 110.0, 111.0], "value": 110.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 118.0, 137.0, 182.0, 121.0, 105.0, 108.0, 112.0, 159.0, 141.0], "value": 132.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [184.0, 185.0, 184.0, 186.0, 186.0, 184.0, 184.0, 225.0, 219.0, 184.0], "value": 192.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 58.0, 60.0, 106.0, 49.0, 79.0, 84.0, 82.0, 96.0, 49.0], "value": 74.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 70.0, 89.0, 97.0, 101.0, 101.0, 111.0, 95.0, 69.0, 92.0], "value": 91.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 87.0, 87.0, 87.0, 86.0, 86.0, 87.0, 87.0, 88.0, 87.0], "value": 87.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 94.0, 94.0, 96.0, 95.0, 94.0, 95.0, 95.0, 94.0, 95.0], "value": 95.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 84.0, 84.0, 83.0, 84.0, 86.0, 83.0, 85.0, 83.0], "value": 84.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [49.0, 47.0, 47.0, 47.0, 48.0, 47.0, 48.0, 47.0, 48.0, 49.0], "value": 47.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 59.0, 60.0, 67.0, 61.0, 58.0, 58.0, 57.0, 58.0, 55.0], "value": 58.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 82.0, 84.0, 82.0, 80.0, 82.0, 82.0, 81.0, 82.0, 82.0], "value": 82.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [137.0, 135.0, 134.0, 135.0, 134.0, 137.0, 138.0, 148.0, 176.0, 146.0], "value": 142.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [187.0, 187.0, 182.0, 181.0, 188.0, 184.0, 181.0, 184.0, 186.0, 183.0], "value": 184.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 85.0, 97.0, 92.0, 69.0, 68.0, 68.0, 68.0, 68.0, 69.0], "value": 74.5, "unit": "score"}]}]} 09:41:21 INFO - Return code: 0 09:41:21 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:41:21 ERROR - # TBPL SUCCESS # 09:41:21 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 09:41:21 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 09:41:21 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 09:41:21 INFO - 2017-04-27 09:41:21.747 screenresolution[1647:9787] starting screenresolution argv=screenresolution get 09:41:21 INFO - 2017-04-27 09:41:21.750 screenresolution[1647:9787] Display 0: 1600x1200x32@60 09:41:21 INFO - 2017-04-27 09:41:21.756 screenresolution[1648:9791] starting screenresolution argv=screenresolution list 09:41:21 INFO - Available Modes on Display 0 09:41:21 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 09:41:21 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 09:41:21 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 09:41:21 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 09:41:21 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 09:41:21 INFO - Intel Iris: 09:41:21 INFO - Chipset Model: Intel Iris 09:41:21 INFO - Type: GPU 09:41:21 INFO - Bus: Built-In 09:41:21 INFO - VRAM (Dynamic, Max): 1536 MB 09:41:21 INFO - Vendor: Intel (0x8086) 09:41:21 INFO - Device ID: 0x0a2e 09:41:21 INFO - Revision ID: 0x0009 09:41:21 INFO - Displays: 09:41:21 INFO - Display: 09:41:21 INFO - Resolution: 1600 x 1200 @ 60 Hz 09:41:21 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 09:41:21 INFO - Display Serial Number: 1600x1200 60 09:41:21 INFO - Main Display: Yes 09:41:21 INFO - Mirror: Off 09:41:21 INFO - Online: Yes 09:41:21 INFO - Rotation: Supported 09:41:22 INFO - Return code: 0 09:41:22 INFO - Running post-action listener: _resource_record_post_action 09:41:22 INFO - [mozharness: 2017-04-27 16:41:22.002231Z] Finished run-tests step (success) 09:41:22 INFO - Running post-run listener: _resource_record_post_run 09:41:22 INFO - Total resource usage - Wall time: 1201s; CPU: 53.0%; Read bytes: 44868608; Write bytes: 510703616; Read time: 480; Write time: 1664 09:41:22 INFO - TinderboxPrint: CPU usage
53.3% 09:41:22 INFO - TinderboxPrint: I/O read bytes / time
44,868,608 / 480 09:41:22 INFO - TinderboxPrint: I/O write bytes / time
510,703,616 / 1,664 09:41:22 INFO - TinderboxPrint: CPU idle
2,246.5 (46.7%) 09:41:22 INFO - TinderboxPrint: CPU system
959.7 (20.0%) 09:41:22 INFO - TinderboxPrint: CPU user
1,599.5 (33.3%) 09:41:22 INFO - TinderboxPrint: Swap in / out
247,758,848 / 0 09:41:22 INFO - install - Wall time: 20s; CPU: 55.0%; Read bytes: 213551616; Write bytes: 205228032; Read time: 16280; Write time: 423 09:41:22 INFO - run-tests - Wall time: 1181s; CPU: 53.0%; Read bytes: 34327552; Write bytes: 298274816; Read time: 379; Write time: 1212 09:41:22 INFO - Running post-run listener: _upload_blobber_files 09:41:22 INFO - Blob upload gear active. 09:41:22 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:41:22 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 09:41:22 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'] 09:41:22 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 09:41:22 INFO - (blobuploader) - INFO - Open directory for files ... 09:41:22 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 09:41:22 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:41:22 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:41:23 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 09:41:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:41:23 INFO - (blobuploader) - INFO - Done attempting. 09:41:23 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 09:41:23 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:41:23 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:41:24 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 09:41:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:41:24 INFO - (blobuploader) - INFO - Done attempting. 09:41:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 09:41:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:41:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:41:25 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 09:41:25 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:41:25 INFO - (blobuploader) - INFO - Done attempting. 09:41:25 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:41:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:41:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:41:27 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:41:27 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:41:27 INFO - (blobuploader) - INFO - Done attempting. 09:41:27 INFO - (blobuploader) - INFO - Iteration through files over. 09:41:27 INFO - Return code: 0 09:41:27 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:41:27 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:41:27 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/cd1da933247ed1f6b4ebb05b5aefb6b36cf27e42ead29343fdafde0f9d251ed1c84382182deb3649b106833360a63147a0302a51cd678302357a9c13e67829bb", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ab3c294604319ebc2075b2b8f0ab94e93bc4efd845304ddca4fc31c9b36e2376d640b6b80bfca0fb7af0531dc5e4e0752f9baed43411b17dbcec5ad4f2f04c15", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0ff794556591aec73369362028e68eaf3f33ba315e8ac3049858c0f2cd8b9f981a9db6d4442ea6d93458ba50140e5ccafa53bbbdb3c41fae9f8f954754b6a22e", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3189c58d78aac7e6bd509a3b2196ed878956f3e2636ab072e466de08bfafeea17ba8235a8d48fdd5f39762a3a7f3f004ec45dae5931ed717a141b088184d6793"} 09:41:27 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:41:27 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:41:27 INFO - Contents: 09:41:27 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/cd1da933247ed1f6b4ebb05b5aefb6b36cf27e42ead29343fdafde0f9d251ed1c84382182deb3649b106833360a63147a0302a51cd678302357a9c13e67829bb", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ab3c294604319ebc2075b2b8f0ab94e93bc4efd845304ddca4fc31c9b36e2376d640b6b80bfca0fb7af0531dc5e4e0752f9baed43411b17dbcec5ad4f2f04c15", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0ff794556591aec73369362028e68eaf3f33ba315e8ac3049858c0f2cd8b9f981a9db6d4442ea6d93458ba50140e5ccafa53bbbdb3c41fae9f8f954754b6a22e", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3189c58d78aac7e6bd509a3b2196ed878956f3e2636ab072e466de08bfafeea17ba8235a8d48fdd5f39762a3a7f3f004ec45dae5931ed717a141b088184d6793"} 09:41:27 INFO - Running post-run listener: copy_logs_to_upload_dir 09:41:27 INFO - Copying logs to upload dir... 09:41:27 INFO - mkdir: /builds/slave/test/build/upload/logs 09:41:27 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1284.001268 ========= master_lag: 3.27 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 27 secs) (at 2017-04-27 09:41:31.060924) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-27 09:41:31.064663) ========= 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.xZr80f4b21/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.A7rmB0FSP2/Listeners TMPDIR=/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/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/cd1da933247ed1f6b4ebb05b5aefb6b36cf27e42ead29343fdafde0f9d251ed1c84382182deb3649b106833360a63147a0302a51cd678302357a9c13e67829bb", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ab3c294604319ebc2075b2b8f0ab94e93bc4efd845304ddca4fc31c9b36e2376d640b6b80bfca0fb7af0531dc5e4e0752f9baed43411b17dbcec5ad4f2f04c15", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0ff794556591aec73369362028e68eaf3f33ba315e8ac3049858c0f2cd8b9f981a9db6d4442ea6d93458ba50140e5ccafa53bbbdb3c41fae9f8f954754b6a22e", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3189c58d78aac7e6bd509a3b2196ed878956f3e2636ab072e466de08bfafeea17ba8235a8d48fdd5f39762a3a7f3f004ec45dae5931ed717a141b088184d6793"} build_url:https://queue.taskcluster.net/v1/task/awXcEhMjQgybIQJk36DeUg/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010800 build_url: 'https://queue.taskcluster.net/v1/task/awXcEhMjQgybIQJk36DeUg/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/cd1da933247ed1f6b4ebb05b5aefb6b36cf27e42ead29343fdafde0f9d251ed1c84382182deb3649b106833360a63147a0302a51cd678302357a9c13e67829bb", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ab3c294604319ebc2075b2b8f0ab94e93bc4efd845304ddca4fc31c9b36e2376d640b6b80bfca0fb7af0531dc5e4e0752f9baed43411b17dbcec5ad4f2f04c15", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0ff794556591aec73369362028e68eaf3f33ba315e8ac3049858c0f2cd8b9f981a9db6d4442ea6d93458ba50140e5ccafa53bbbdb3c41fae9f8f954754b6a22e", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3189c58d78aac7e6bd509a3b2196ed878956f3e2636ab072e466de08bfafeea17ba8235a8d48fdd5f39762a3a7f3f004ec45dae5931ed717a141b088184d6793"}' ========= master_lag: 0.20 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-27 09:41:31.272204) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-27 09:41:31.272537) ========= 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.xZr80f4b21/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.A7rmB0FSP2/Listeners TMPDIR=/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/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.005095 ========= master_lag: 0.26 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-27 09:41:31.540343) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-27 09:41:31.540656) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-27 09:41:31.540978) ========= ========= Total master_lag: 5.56 =========