builder: pine_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0159 starttime: 1491336832.63 results: success (0) buildid: 20170404090329 builduid: f31276557b67450ca8aa06528d2763c1 revision: 29799ff6c8a5578fb2939f66815668b18cb15e3b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-04-04 13:13:52.625867) ========= master: http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-04-04 13:13:52.626379) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-04 13:13:52.626674) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-04 13:13:52.653636) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-04 13:13:52.654018) ========= 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.sFkzJEaMMa/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.HrPS7bVRC0/Listeners TMPDIR=/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/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-04 13:13:52-- 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% 57.5M=0s 2017-04-04 13:13:52 (57.5 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.122952 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-04 13:13:52.801155) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-04 13:13:52.801492) ========= 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.sFkzJEaMMa/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.HrPS7bVRC0/Listeners TMPDIR=/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/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.026775 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-04 13:13:52.850582) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-04-04 13:13:52.850929) ========= bash -c 'python archiver_client.py mozharness --repo projects/pine --rev 29799ff6c8a5578fb2939f66815668b18cb15e3b --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo projects/pine --rev 29799ff6c8a5578fb2939f66815668b18cb15e3b --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.sFkzJEaMMa/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.HrPS7bVRC0/Listeners TMPDIR=/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/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-04 13:13:52,955 truncating revision to first 12 chars 2017-04-04 13:13:52,956 Setting DEBUG logging. 2017-04-04 13:13:52,956 attempt 1/10 2017-04-04 13:13:52,956 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/projects/pine/29799ff6c8a5?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-04-04 13:13:53,716 unpacking tar archive at: pine-29799ff6c8a5/testing/mozharness/ program finished with exit code 0 elapsedTime=1.067045 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-04-04 13:13:53.943111) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-04 13:13:53.943672) ========= script_repo_revision: 29799ff6c8a5578fb2939f66815668b18cb15e3b ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-04 13:13:53.944221) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-04 13:13:53.944646) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-04 13:13:53.966447) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 27 secs) (at 2017-04-04 13:13:53.967003) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Pine --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Pine 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', 'Pine', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Pine'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.sFkzJEaMMa/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.HrPS7bVRC0/Listeners TMPDIR=/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/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 13:13:54 INFO - MultiFileLogger online at 20170404 13:13:54 in /builds/slave/test 13:13:54 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Pine --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Pine 13:13:54 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 13:13:54 INFO - {'append_to_log': False, 13:13:54 INFO - 'base_work_dir': '/builds/slave/test', 13:13:54 INFO - 'blob_upload_branch': 'Pine', 13:13:54 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 13:13:54 INFO - 'branch': 'Pine', 13:13:54 INFO - 'buildbot_json_path': 'buildprops.json', 13:13:54 INFO - 'config_files': ('talos/mac_config.py',), 13:13:54 INFO - 'default_actions': ('clobber', 13:13:54 INFO - 'read-buildbot-config', 13:13:54 INFO - 'download-and-extract', 13:13:54 INFO - 'populate-webroot', 13:13:54 INFO - 'create-virtualenv', 13:13:54 INFO - 'install', 13:13:54 INFO - 'run-tests'), 13:13:54 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 13:13:54 INFO - 'download_minidump_stackwalk': True, 13:13:54 INFO - 'download_symbols': 'ondemand', 13:13:54 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 13:13:54 INFO - 'tooltool.py': '/tools/tooltool.py', 13:13:54 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 13:13:54 INFO - '/tools/misc-python/virtualenv.py')}, 13:13:54 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 13:13:54 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 13:13:54 INFO - 'gecko_profile': False, 13:13:54 INFO - 'gecko_profile_interval': 0, 13:13:54 INFO - 'installer_path': 'installer.exe', 13:13:54 INFO - 'log_level': 'info', 13:13:54 INFO - 'log_name': 'talos', 13:13:54 INFO - 'log_to_console': True, 13:13:54 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 13:13:54 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 13:13:54 INFO - 'opt_config_files': (), 13:13:54 INFO - 'pip_index': False, 13:13:54 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 13:13:54 INFO - 'cmd': ('bash', 13:13:54 INFO - '-c', 13:13:54 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 13:13:54 INFO - 'enabled': True, 13:13:54 INFO - 'halt_on_failure': False, 13:13:54 INFO - 'name': 'check_screen_resolution'},), 13:13:54 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 13:13:54 INFO - 'cmd': ('bash', 13:13:54 INFO - '-c', 13:13:54 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 13:13:54 INFO - 'enabled': True, 13:13:54 INFO - 'halt_on_failure': False, 13:13:54 INFO - 'name': 'check_screen_resolution'},), 13:13:54 INFO - 'run_cmd_checks_enabled': True, 13:13:54 INFO - 'suite': 'dromaeojs', 13:13:54 INFO - 'system_bits': '32', 13:13:54 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 13:13:54 INFO - 'title': 't-yosemite-r7-0159', 13:13:54 INFO - 'tooltool_cache': '/builds/tooltool_cache', 13:13:54 INFO - 'use_talos_json': True, 13:13:54 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 13:13:54 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 13:13:54 INFO - 'work_dir': 'build'} 13:13:54 INFO - [mozharness: 2017-04-04 20:13:54.186546Z] Running clobber step. 13:13:54 INFO - Running pre-action listener: _resource_record_pre_action 13:13:54 INFO - Running main action method: clobber 13:13:54 INFO - rmtree: /builds/slave/test/build 13:13:54 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 13:13:56 INFO - Running post-action listener: _resource_record_post_action 13:13:56 INFO - [mozharness: 2017-04-04 20:13:56.794289Z] Finished clobber step (success) 13:13:56 INFO - [mozharness: 2017-04-04 20:13:56.794421Z] Running read-buildbot-config step. 13:13:56 INFO - Running pre-action listener: _resource_record_pre_action 13:13:56 INFO - Running main action method: read_buildbot_config 13:13:56 INFO - Using buildbot properties: 13:13:56 INFO - { 13:13:56 INFO - "project": "", 13:13:56 INFO - "product": "firefox", 13:13:56 INFO - "script_repo_revision": "default", 13:13:56 INFO - "builddir": "pine_yosemite_r7_test-dromaeojs", 13:13:56 INFO - "repository": "", 13:13:56 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 pine talos dromaeojs", 13:13:56 INFO - "buildid": "20170404090329", 13:13:56 INFO - "pgo_build": "False", 13:13:56 INFO - "basedir": "/builds/slave/test", 13:13:56 INFO - "buildnumber": 1, 13:13:56 INFO - "slavename": "t-yosemite-r7-0159", 13:13:56 INFO - "master": "http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/", 13:13:56 INFO - "platform": "yosemite_r7", 13:13:56 INFO - "scheduler": "tests-pine-macosx64-talos", 13:13:56 INFO - "branch": "pine", 13:13:56 INFO - "repo_path": "projects/pine", 13:13:56 INFO - "revision": "29799ff6c8a5578fb2939f66815668b18cb15e3b", 13:13:56 INFO - "stage_platform": "macosx64", 13:13:56 INFO - "builduid": "f31276557b67450ca8aa06528d2763c1", 13:13:56 INFO - "slavebuilddir": "test" 13:13:56 INFO - } 13:13:56 INFO - Found installer url https://queue.taskcluster.net/v1/task/d4iKk8LgRCqYM8jbxQZwcQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg. 13:13:56 INFO - Running post-action listener: _resource_record_post_action 13:13:56 INFO - [mozharness: 2017-04-04 20:13:56.797867Z] Finished read-buildbot-config step (success) 13:13:56 INFO - [mozharness: 2017-04-04 20:13:56.798002Z] Running download-and-extract step. 13:13:56 INFO - Running pre-action listener: _resource_record_pre_action 13:13:56 INFO - Running main action method: download_and_extract 13:13:56 INFO - mkdir: /builds/slave/test/build/tests 13:13:56 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')]} 13:13:56 INFO - trying https://queue.taskcluster.net/v1/task/d4iKk8LgRCqYM8jbxQZwcQ/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json 13:13:56 INFO - Downloading https://queue.taskcluster.net/v1/task/d4iKk8LgRCqYM8jbxQZwcQ/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 13:13:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/d4iKk8LgRCqYM8jbxQZwcQ/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 13:13:57 INFO - Downloaded 1325 bytes. 13:13:57 INFO - Reading from file /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 13:13:57 INFO - Using the following test package requirements: 13:13:57 INFO - {u'awsy': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 13:13:57 INFO - u'firefox-55.0a1.en-US.mac.awsy.tests.zip'], 13:13:57 INFO - u'common': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 13:13:57 INFO - u'cppunittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 13:13:57 INFO - u'firefox-55.0a1.en-US.mac.cppunittest.tests.zip'], 13:13:57 INFO - u'gtest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 13:13:57 INFO - u'firefox-55.0a1.en-US.mac.gtest.tests.zip'], 13:13:57 INFO - u'jittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 13:13:57 INFO - u'jsshell-mac.zip'], 13:13:57 INFO - u'mochitest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 13:13:57 INFO - u'firefox-55.0a1.en-US.mac.mochitest.tests.zip'], 13:13:57 INFO - u'mozbase': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 13:13:57 INFO - u'reftest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 13:13:57 INFO - u'firefox-55.0a1.en-US.mac.reftest.tests.zip'], 13:13:57 INFO - u'talos': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 13:13:57 INFO - u'firefox-55.0a1.en-US.mac.talos.tests.zip'], 13:13:57 INFO - u'web-platform': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 13:13:57 INFO - u'firefox-55.0a1.en-US.mac.web-platform.tests.zip'], 13:13:57 INFO - u'xpcshell': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 13:13:57 INFO - u'firefox-55.0a1.en-US.mac.xpcshell.tests.zip']} 13:13:57 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip'] for test suite category: common 13:13:57 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/d4iKk8LgRCqYM8jbxQZwcQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 13:13:57 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/d4iKk8LgRCqYM8jbxQZwcQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 13:13:57 INFO - Fetch https://queue.taskcluster.net/v1/task/d4iKk8LgRCqYM8jbxQZwcQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 13:13:59 INFO - Expected file size: 52520435 13:13:59 INFO - Obtained file size: 52520435 13:14:15 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 13:14:15 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/d4iKk8LgRCqYM8jbxQZwcQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 13:14:15 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/d4iKk8LgRCqYM8jbxQZwcQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 13:14:15 INFO - Fetch https://queue.taskcluster.net/v1/task/d4iKk8LgRCqYM8jbxQZwcQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 13:14:17 INFO - Expected file size: 52520435 13:14:17 INFO - Obtained file size: 52520435 13:14:32 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/d4iKk8LgRCqYM8jbxQZwcQ/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip 13:14:32 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/d4iKk8LgRCqYM8jbxQZwcQ/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip'}, attempt #1 13:14:32 INFO - Fetch https://queue.taskcluster.net/v1/task/d4iKk8LgRCqYM8jbxQZwcQ/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip into memory 13:14:33 INFO - Expected file size: 14404152 13:14:33 INFO - Obtained file size: 14404152 13:14:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:14:34 INFO - trying https://queue.taskcluster.net/v1/task/d4iKk8LgRCqYM8jbxQZwcQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 13:14:34 INFO - Downloading https://queue.taskcluster.net/v1/task/d4iKk8LgRCqYM8jbxQZwcQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg 13:14:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/d4iKk8LgRCqYM8jbxQZwcQ/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 13:14:36 INFO - Downloaded 75665554 bytes. 13:14:36 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/d4iKk8LgRCqYM8jbxQZwcQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 13:14:36 INFO - mkdir: /builds/slave/test/properties 13:14:36 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 13:14:36 INFO - Writing to file /builds/slave/test/properties/build_url 13:14:36 INFO - Contents: 13:14:36 INFO - build_url:https://queue.taskcluster.net/v1/task/d4iKk8LgRCqYM8jbxQZwcQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 13:14:37 INFO - Running post-action listener: _resource_record_post_action 13:14:37 INFO - Running post-action listener: set_extra_try_arguments 13:14:37 INFO - [mozharness: 2017-04-04 20:14:37.169967Z] Finished download-and-extract step (success) 13:14:37 INFO - [mozharness: 2017-04-04 20:14:37.170105Z] Running populate-webroot step. 13:14:37 INFO - Running pre-action listener: _resource_record_pre_action 13:14:37 INFO - Running main action method: populate_webroot 13:14:37 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 13:14:37 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 13:14:37 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 13:14:37 INFO - '--tppagecycles', 13:14:37 INFO - '7'], 13:14:37 INFO - 'tests': ['tsvgm']}}, 13:14:37 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 13:14:37 INFO - 'tests': ['tresize', 'tcanvasmark']}, 13:14:37 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 13:14:37 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 13:14:37 INFO - 'tests': ['dromaeo_css', 'kraken']}, 13:14:37 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 13:14:37 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 13:14:37 INFO - 'talos_options': ['--disable-e10s'], 13:14:37 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:14:37 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 13:14:37 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:14:37 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 13:14:37 INFO - 'talos_options': ['--disable-e10s'], 13:14:37 INFO - 'tests': ['damp', 'tps']}, 13:14:37 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 13:14:37 INFO - 'tests': ['damp', 'tps']}, 13:14:37 INFO - 'g3': {'talos_options': ['--disable-e10s'], 13:14:37 INFO - 'tests': ['dromaeo_dom']}, 13:14:37 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 13:14:37 INFO - 'g4': {'talos_options': ['--disable-e10s'], 13:14:37 INFO - 'tests': ['basic_compositor_video']}, 13:14:37 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 13:14:37 INFO - 'other': {'talos_options': ['--disable-e10s'], 13:14:37 INFO - 'tests': ['a11yr', 13:14:37 INFO - 'ts_paint', 13:14:37 INFO - 'tpaint', 13:14:37 INFO - 'sessionrestore', 13:14:37 INFO - 'sessionrestore_no_auto_restore', 13:14:37 INFO - 'tabpaint']}, 13:14:37 INFO - 'other-e10s': {'tests': ['a11yr', 13:14:37 INFO - 'ts_paint', 13:14:37 INFO - 'tpaint', 13:14:37 INFO - 'sessionrestore', 13:14:37 INFO - 'sessionrestore_no_auto_restore', 13:14:37 INFO - 'tabpaint']}, 13:14:37 INFO - 'other-e10s_l64': {'tests': ['a11yr', 13:14:37 INFO - 'ts_paint', 13:14:37 INFO - 'tpaint', 13:14:37 INFO - 'sessionrestore', 13:14:37 INFO - 'sessionrestore_no_auto_restore', 13:14:37 INFO - 'tabpaint']}, 13:14:37 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 13:14:37 INFO - 'ts_paint', 13:14:37 INFO - 'tpaint', 13:14:37 INFO - 'sessionrestore', 13:14:37 INFO - 'sessionrestore_no_auto_restore', 13:14:37 INFO - 'tabpaint']}, 13:14:37 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 13:14:37 INFO - 'tests': ['a11yr', 13:14:37 INFO - 'ts_paint', 13:14:37 INFO - 'tpaint', 13:14:37 INFO - 'sessionrestore', 13:14:37 INFO - 'sessionrestore_no_auto_restore', 13:14:37 INFO - 'tabpaint']}, 13:14:37 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 13:14:37 INFO - 'tests': ['a11yr', 13:14:37 INFO - 'ts_paint', 13:14:37 INFO - 'tpaint', 13:14:37 INFO - 'sessionrestore', 13:14:37 INFO - 'sessionrestore_no_auto_restore', 13:14:37 INFO - 'tabpaint']}, 13:14:37 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 13:14:37 INFO - 'tests': ['tsvgx', 13:14:37 INFO - 'tsvgr_opacity', 13:14:37 INFO - 'tart', 13:14:37 INFO - 'tscrollx', 13:14:37 INFO - 'cart', 13:14:37 INFO - 'tsvg_static']}, 13:14:37 INFO - 'svgr-e10s': {'tests': ['tsvgx', 13:14:37 INFO - 'tsvgr_opacity', 13:14:37 INFO - 'tart', 13:14:37 INFO - 'tscrollx', 13:14:37 INFO - 'cart', 13:14:37 INFO - 'tsvg_static']}, 13:14:37 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 13:14:37 INFO - 'talos_options': ['--disable-e10s'], 13:14:37 INFO - 'tests': ['tp5o']}, 13:14:37 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 13:14:37 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 13:14:37 INFO - 'talos_options': ['--disable-e10s', 13:14:37 INFO - '--xperf_path', 13:14:37 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:14:37 INFO - 'tests': ['tp5n']}, 13:14:37 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 13:14:37 INFO - 'talos_options': ['--xperf_path', 13:14:37 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:14:37 INFO - 'tests': ['tp5n']}}, 13:14:37 INFO - 'talos.zip': {'path': '', 13:14:37 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 13:14:37 INFO - Running post-action listener: _resource_record_post_action 13:14:37 INFO - [mozharness: 2017-04-04 20:14:37.188378Z] Finished populate-webroot step (success) 13:14:37 INFO - [mozharness: 2017-04-04 20:14:37.188488Z] Running create-virtualenv step. 13:14:37 INFO - Running pre-action listener: _resource_record_pre_action 13:14:37 INFO - Running main action method: create_virtualenv 13:14:37 INFO - Creating virtualenv /builds/slave/test/build/venv 13:14:37 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 13:14:37 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 13:14:37 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 13:14:37 INFO - Using real prefix '/tools/python27' 13:14:37 INFO - New python executable in /builds/slave/test/build/venv/bin/python 13:14:38 INFO - Installing distribute.............................................................................................................................................................................................done. 13:14:40 INFO - Installing pip.................done. 13:14:40 INFO - Return code: 0 13:14:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 13:14:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 13:14:41 INFO - Reading from file tmpfile_stdout 13:14:41 INFO - Output received: 13:14:41 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) 13:14:41 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 13:14:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:14:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:14:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:14:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:14:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:14:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:14:41 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x103893b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103896768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffd70443b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103671d30>, '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 0x103598db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103666be8>, '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.sFkzJEaMMa/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.HrPS7bVRC0/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/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 13:14:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 13:14:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 13:14:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.sFkzJEaMMa/Render', 13:14:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:14:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:14:41 INFO - 'HOME': '/Users/cltbld', 13:14:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:14:41 INFO - 'LOGNAME': 'cltbld', 13:14:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:14:41 INFO - 'MOZ_NO_REMOTE': '1', 13:14:41 INFO - 'NO_EM_RESTART': '1', 13:14:41 INFO - 'PAGER': '/bin/cat', 13:14:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:14:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:14:41 INFO - 'PWD': '/builds/slave/test', 13:14:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:14:41 INFO - 'SHELL': '/bin/bash', 13:14:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HrPS7bVRC0/Listeners', 13:14:41 INFO - 'TMPDIR': '/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/', 13:14:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:14:41 INFO - 'USER': 'cltbld', 13:14:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:14:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:14:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:14:41 INFO - 'XPC_FLAGS': '0x0', 13:14:41 INFO - 'XPC_SERVICE_NAME': '0', 13:14:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:14:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:14:41 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 13:14:41 INFO - Cleaning up... 13:14:41 INFO - Return code: 0 13:14:41 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 13:14:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:14:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:14:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:14:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:14:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:14:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:14:41 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x103893b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103896768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffd70443b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103671d30>, '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 0x103598db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103666be8>, '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.sFkzJEaMMa/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.HrPS7bVRC0/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/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 13:14:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 13:14:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 13:14:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.sFkzJEaMMa/Render', 13:14:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:14:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:14:41 INFO - 'HOME': '/Users/cltbld', 13:14:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:14:41 INFO - 'LOGNAME': 'cltbld', 13:14:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:14:41 INFO - 'MOZ_NO_REMOTE': '1', 13:14:41 INFO - 'NO_EM_RESTART': '1', 13:14:41 INFO - 'PAGER': '/bin/cat', 13:14:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:14:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:14:41 INFO - 'PWD': '/builds/slave/test', 13:14:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:14:41 INFO - 'SHELL': '/bin/bash', 13:14:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HrPS7bVRC0/Listeners', 13:14:41 INFO - 'TMPDIR': '/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/', 13:14:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:14:41 INFO - 'USER': 'cltbld', 13:14:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:14:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:14:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:14:41 INFO - 'XPC_FLAGS': '0x0', 13:14:41 INFO - 'XPC_SERVICE_NAME': '0', 13:14:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:14:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:14:41 INFO - Downloading/unpacking psutil>=3.1.1 13:14:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:14:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:14:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:14:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:14:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:14:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:14:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 13:14:45 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:14:45 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:14:45 INFO - Installing collected packages: psutil 13:14:45 INFO - Running setup.py install for psutil 13:14:45 INFO - building 'psutil._psutil_osx' extension 13:14:45 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 13:14:45 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 13:14:45 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 13:14:46 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 13:14:46 INFO - building 'psutil._psutil_posix' extension 13:14:46 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 13:14:46 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 13:14:46 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 13:14:46 INFO - ^ 13:14:46 INFO - 1 warning generated. 13:14:46 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 13:14:46 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:14:46 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:14:46 INFO - Successfully installed psutil 13:14:46 INFO - Cleaning up... 13:14:46 INFO - Return code: 0 13:14:46 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 13:14:46 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')]} 13:14:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:14:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:14:46 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')]} 13:14:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:14:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:14:47 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 0x103893b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103896768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffd70443b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103671d30>, '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 0x103598db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103666be8>, '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.sFkzJEaMMa/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.HrPS7bVRC0/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/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 13:14:47 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 13:14:47 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 13:14:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.sFkzJEaMMa/Render', 13:14:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:14:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:14:47 INFO - 'HOME': '/Users/cltbld', 13:14:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:14:47 INFO - 'LOGNAME': 'cltbld', 13:14:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:14:47 INFO - 'MOZ_NO_REMOTE': '1', 13:14:47 INFO - 'NO_EM_RESTART': '1', 13:14:47 INFO - 'PAGER': '/bin/cat', 13:14:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:14:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:14:47 INFO - 'PWD': '/builds/slave/test', 13:14:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:14:47 INFO - 'SHELL': '/bin/bash', 13:14:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HrPS7bVRC0/Listeners', 13:14:47 INFO - 'TMPDIR': '/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/', 13:14:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:14:47 INFO - 'USER': 'cltbld', 13:14:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:14:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:14:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:14:47 INFO - 'XPC_FLAGS': '0x0', 13:14:47 INFO - 'XPC_SERVICE_NAME': '0', 13:14:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:14:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:14:47 INFO - Downloading/unpacking mozsystemmonitor==0.3 13:14:47 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 13:14:47 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 13:14:47 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 13:14:47 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 13:14:47 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 13:14:47 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 13:14:50 INFO - Downloading mozsystemmonitor-0.3.tar.gz 13:14:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 13:14:50 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 13:14:50 INFO - Installing collected packages: mozsystemmonitor 13:14:50 INFO - Running setup.py install for mozsystemmonitor 13:14:50 INFO - Successfully installed mozsystemmonitor 13:14:50 INFO - Cleaning up... 13:14:50 INFO - Return code: 0 13:14:50 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 13:14:50 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')]} 13:14:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:14:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:14:50 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')]} 13:14:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:14:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:14:50 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 0x103893b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103896768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffd70443b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103671d30>, '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 0x103598db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103666be8>, '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.sFkzJEaMMa/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.HrPS7bVRC0/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/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 13:14:50 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 13:14:50 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 13:14:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.sFkzJEaMMa/Render', 13:14:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:14:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:14:50 INFO - 'HOME': '/Users/cltbld', 13:14:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:14:50 INFO - 'LOGNAME': 'cltbld', 13:14:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:14:50 INFO - 'MOZ_NO_REMOTE': '1', 13:14:50 INFO - 'NO_EM_RESTART': '1', 13:14:50 INFO - 'PAGER': '/bin/cat', 13:14:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:14:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:14:50 INFO - 'PWD': '/builds/slave/test', 13:14:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:14:50 INFO - 'SHELL': '/bin/bash', 13:14:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HrPS7bVRC0/Listeners', 13:14:50 INFO - 'TMPDIR': '/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/', 13:14:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:14:50 INFO - 'USER': 'cltbld', 13:14:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:14:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:14:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:14:50 INFO - 'XPC_FLAGS': '0x0', 13:14:50 INFO - 'XPC_SERVICE_NAME': '0', 13:14:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:14:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:14:51 INFO - Downloading/unpacking jsonschema==2.5.1 13:14:51 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 13:14:51 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 13:14:51 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 13:14:51 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 13:14:51 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 13:14:51 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 13:14:53 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 13:14:53 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 13:14:53 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 13:14:53 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 13:14:53 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 13:14:53 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 13:14:53 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 13:14:53 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 13:14:54 INFO - Downloading functools32-3.2.3-2.tar.gz 13:14:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 13:14:54 INFO - warning: no files found matching '*.txt' 13:14:54 INFO - no previously-included directories found matching 'build' 13:14:54 INFO - no previously-included directories found matching 'dist' 13:14:54 INFO - no previously-included directories found matching '.git*' 13:14:54 INFO - Installing collected packages: jsonschema, functools32 13:14:54 INFO - Running setup.py install for functools32 13:14:54 INFO - warning: no files found matching '*.txt' 13:14:54 INFO - no previously-included directories found matching 'build' 13:14:54 INFO - no previously-included directories found matching 'dist' 13:14:54 INFO - no previously-included directories found matching '.git*' 13:14:54 INFO - Successfully installed jsonschema functools32 13:14:54 INFO - Cleaning up... 13:14:54 INFO - Return code: 0 13:14:54 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 13:14:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:14:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:14:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:14:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:14:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:14:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:14:54 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 0x103893b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103896768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffd70443b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103671d30>, '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 0x103598db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103666be8>, '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.sFkzJEaMMa/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.HrPS7bVRC0/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/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 13:14:54 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 13:14:54 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 13:14:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.sFkzJEaMMa/Render', 13:14:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:14:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:14:54 INFO - 'HOME': '/Users/cltbld', 13:14:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:14:54 INFO - 'LOGNAME': 'cltbld', 13:14:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:14:54 INFO - 'MOZ_NO_REMOTE': '1', 13:14:54 INFO - 'NO_EM_RESTART': '1', 13:14:54 INFO - 'PAGER': '/bin/cat', 13:14:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:14:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:14:54 INFO - 'PWD': '/builds/slave/test', 13:14:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:14:54 INFO - 'SHELL': '/bin/bash', 13:14:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HrPS7bVRC0/Listeners', 13:14:54 INFO - 'TMPDIR': '/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/', 13:14:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:14:54 INFO - 'USER': 'cltbld', 13:14:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:14:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:14:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:14:54 INFO - 'XPC_FLAGS': '0x0', 13:14:54 INFO - 'XPC_SERVICE_NAME': '0', 13:14:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:14:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:14:54 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 13:14:54 INFO - Cleaning up... 13:14:54 INFO - Return code: 0 13:14:54 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 13:14:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:14:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:14:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:14:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:14:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:14:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:14:54 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 0x103893b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103896768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffd70443b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103671d30>, '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 0x103598db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103666be8>, '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.sFkzJEaMMa/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.HrPS7bVRC0/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/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 13:14:54 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 13:14:54 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 13:14:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.sFkzJEaMMa/Render', 13:14:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:14:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:14:54 INFO - 'HOME': '/Users/cltbld', 13:14:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:14:54 INFO - 'LOGNAME': 'cltbld', 13:14:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:14:54 INFO - 'MOZ_NO_REMOTE': '1', 13:14:54 INFO - 'NO_EM_RESTART': '1', 13:14:54 INFO - 'PAGER': '/bin/cat', 13:14:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:14:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:14:54 INFO - 'PWD': '/builds/slave/test', 13:14:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:14:54 INFO - 'SHELL': '/bin/bash', 13:14:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HrPS7bVRC0/Listeners', 13:14:54 INFO - 'TMPDIR': '/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/', 13:14:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:14:54 INFO - 'USER': 'cltbld', 13:14:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:14:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:14:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:14:54 INFO - 'XPC_FLAGS': '0x0', 13:14:54 INFO - 'XPC_SERVICE_NAME': '0', 13:14:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:14:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:14:54 INFO - Downloading/unpacking blobuploader==1.2.4 13:14:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:14:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:14:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:14:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:14:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:14:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:14:57 INFO - Downloading blobuploader-1.2.4.tar.gz 13:14:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 13:14:57 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 13:14: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 13:14: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 13:14: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 13:14: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 13:14: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 13:14: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 13:14:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 13:14:58 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 13:14:58 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 13:14:58 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 13:14:58 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 13:14:58 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 13:14:58 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 13:14:58 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 13:14:58 INFO - Downloading docopt-0.6.1.tar.gz 13:14:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 13:14:58 INFO - Installing collected packages: blobuploader, requests, docopt 13:14:58 INFO - Running setup.py install for blobuploader 13:14:59 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 13:14:59 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 13:14:59 INFO - Running setup.py install for requests 13:14:59 INFO - Running setup.py install for docopt 13:14:59 INFO - Successfully installed blobuploader requests docopt 13:14:59 INFO - Cleaning up... 13:14:59 INFO - Return code: 0 13:14:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:14:59 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')]} 13:14:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:14:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:14:59 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')]} 13:14:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:14:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:14:59 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 0x103893b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103896768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffd70443b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103671d30>, '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 0x103598db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103666be8>, '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.sFkzJEaMMa/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.HrPS7bVRC0/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/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 13:14:59 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 13:14:59 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 13:14:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.sFkzJEaMMa/Render', 13:14:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:14:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:14:59 INFO - 'HOME': '/Users/cltbld', 13:14:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:14:59 INFO - 'LOGNAME': 'cltbld', 13:14:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:14:59 INFO - 'MOZ_NO_REMOTE': '1', 13:14:59 INFO - 'NO_EM_RESTART': '1', 13:14:59 INFO - 'PAGER': '/bin/cat', 13:14:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:14:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:14:59 INFO - 'PWD': '/builds/slave/test', 13:14:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:14:59 INFO - 'SHELL': '/bin/bash', 13:14:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HrPS7bVRC0/Listeners', 13:14:59 INFO - 'TMPDIR': '/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/', 13:14:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:14:59 INFO - 'USER': 'cltbld', 13:14:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:14:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:14:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:14:59 INFO - 'XPC_FLAGS': '0x0', 13:14:59 INFO - 'XPC_SERVICE_NAME': '0', 13:14:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:15:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:15:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:15:00 INFO - Running setup.py (path:/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/pip-lQkG9t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:15:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:15:00 INFO - Running setup.py (path:/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/pip-vaKlJ7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:15:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:15:00 INFO - Running setup.py (path:/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/pip-QgaVVP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:15:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:15:00 INFO - Running setup.py (path:/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/pip-uA8b3J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:15:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:15:00 INFO - Running setup.py (path:/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/pip-oI8mNL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:15:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:15:00 INFO - Running setup.py (path:/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/pip-ZOO3na-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:15:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:15:00 INFO - Running setup.py (path:/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/pip-R25dCS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:15:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:15:00 INFO - Running setup.py (path:/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/pip-cwJuNO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:15:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:15:00 INFO - Running setup.py (path:/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/pip-kzHNJC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:15:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:15:00 INFO - Running setup.py (path:/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/pip-rY59Ta-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:15:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:15:01 INFO - Running setup.py (path:/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/pip-dfYVaH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:15:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:15:01 INFO - Running setup.py (path:/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/pip-6yu_Kp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:15:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:15:01 INFO - Running setup.py (path:/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/pip-R0Jdze-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:15:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:15:01 INFO - Running setup.py (path:/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/pip-6omB3W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:15:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:15:01 INFO - Running setup.py (path:/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/pip-xaW3tr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:15:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:15:01 INFO - Running setup.py (path:/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/pip-yYYqW1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:15:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:15:01 INFO - Running setup.py (path:/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/pip-TagMdu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:15:01 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 13:15:01 INFO - Running setup.py install for manifestparser 13:15:01 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 13:15:01 INFO - Running setup.py install for mozcrash 13:15:02 INFO - Running setup.py install for mozdebug 13:15:02 INFO - Running setup.py install for mozdevice 13:15:02 INFO - Installing dm script to /builds/slave/test/build/venv/bin 13:15:02 INFO - Running setup.py install for mozfile 13:15:02 INFO - Running setup.py install for mozhttpd 13:15:02 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 13:15:02 INFO - Running setup.py install for mozinfo 13:15:02 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 13:15:02 INFO - Running setup.py install for mozInstall 13:15:02 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 13:15:02 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 13:15:02 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 13:15:02 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 13:15:02 INFO - Running setup.py install for mozleak 13:15:03 INFO - Running setup.py install for mozlog 13:15:03 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 13:15:03 INFO - Running setup.py install for moznetwork 13:15:03 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 13:15:03 INFO - Running setup.py install for mozprocess 13:15:03 INFO - Running setup.py install for mozprofile 13:15:03 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 13:15:03 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 13:15:03 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 13:15:03 INFO - Running setup.py install for mozrunner 13:15:03 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 13:15:03 INFO - Running setup.py install for mozscreenshot 13:15:04 INFO - Running setup.py install for moztest 13:15:04 INFO - Running setup.py install for mozversion 13:15:04 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 13:15:04 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 13:15:04 INFO - Cleaning up... 13:15:04 INFO - Return code: 0 13:15:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:15: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')]} 13:15:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:15:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:15: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')]} 13:15:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:15:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:15:04 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 0x103893b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103896768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffd70443b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103671d30>, '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 0x103598db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103666be8>, '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.sFkzJEaMMa/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.HrPS7bVRC0/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/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 13:15:04 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 13:15:04 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 13:15:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.sFkzJEaMMa/Render', 13:15:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:15:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:15:04 INFO - 'HOME': '/Users/cltbld', 13:15:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:15:04 INFO - 'LOGNAME': 'cltbld', 13:15:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:15:04 INFO - 'MOZ_NO_REMOTE': '1', 13:15:04 INFO - 'NO_EM_RESTART': '1', 13:15:04 INFO - 'PAGER': '/bin/cat', 13:15:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:15:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:15:04 INFO - 'PWD': '/builds/slave/test', 13:15:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:15:04 INFO - 'SHELL': '/bin/bash', 13:15:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HrPS7bVRC0/Listeners', 13:15:04 INFO - 'TMPDIR': '/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/', 13:15:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:15:04 INFO - 'USER': 'cltbld', 13:15:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:15:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:15:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:15:04 INFO - 'XPC_FLAGS': '0x0', 13:15:04 INFO - 'XPC_SERVICE_NAME': '0', 13:15:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:15:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:15:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:15:04 INFO - Running setup.py (path:/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/pip-vBqlW3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:15:04 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)) 13:15:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:15:04 INFO - Running setup.py (path:/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/pip-P9Ti6C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:15:04 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)) 13:15:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:15:04 INFO - Running setup.py (path:/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/pip-lRwTLJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:15:04 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)) 13:15:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:15:04 INFO - Running setup.py (path:/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/pip-33Sg7e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:15:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 13:15:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:15:05 INFO - Running setup.py (path:/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/pip-o0dNTY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:15:05 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)) 13:15:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:15:05 INFO - Running setup.py (path:/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/pip-CfvFNE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:15:05 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)) 13:15:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:15:05 INFO - Running setup.py (path:/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/pip-7Lj2tz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:15:05 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)) 13:15:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:15:05 INFO - Running setup.py (path:/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/pip-7A8o6z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:15:05 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)) 13:15:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:15:05 INFO - Running setup.py (path:/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/pip-6N8_ey-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:15:05 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)) 13:15:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:15:05 INFO - Running setup.py (path:/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/pip-LdjXLi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:15:05 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)) 13:15:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:15:05 INFO - Running setup.py (path:/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/pip-vI5fqU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:15:05 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)) 13:15:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:15:05 INFO - Running setup.py (path:/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/pip-fBHwTi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:15:05 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)) 13:15:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:15:05 INFO - Running setup.py (path:/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/pip-WC7rC6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:15:06 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)) 13:15:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:15:06 INFO - Running setup.py (path:/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/pip-nTe08f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:15:06 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)) 13:15:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:15:06 INFO - Running setup.py (path:/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/pip-j8OCzi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:15:06 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)) 13:15:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:15:06 INFO - Running setup.py (path:/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/pip-m6dRxA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:15:06 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)) 13:15:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:15:06 INFO - Running setup.py (path:/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/pip-eW1PRT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:15:06 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)) 13:15:06 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)) 13:15:06 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)) 13:15:06 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)) 13:15:06 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 13:15:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 13:15:06 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 13:15:06 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 13:15:06 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 13:15:06 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 13:15:06 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 13:15:06 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 13:15:06 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 13:15:09 INFO - Downloading blessings-1.6.tar.gz 13:15:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 13:15:09 INFO - Installing collected packages: blessings 13:15:09 INFO - Running setup.py install for blessings 13:15:09 INFO - Successfully installed blessings 13:15:09 INFO - Cleaning up... 13:15:09 INFO - Return code: 0 13:15:09 INFO - Done creating virtualenv /builds/slave/test/build/venv. 13:15:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:15:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:15:09 INFO - Reading from file tmpfile_stdout 13:15:09 INFO - Current package versions: 13:15:09 INFO - blessings == 1.6 13:15:09 INFO - blobuploader == 1.2.4 13:15:09 INFO - docopt == 0.6.1 13:15:09 INFO - functools32 == 3.2.3-2 13:15:09 INFO - jsonschema == 2.5.1 13:15:09 INFO - manifestparser == 1.1 13:15:09 INFO - mozInstall == 1.12 13:15:09 INFO - mozcrash == 1.0 13:15:09 INFO - mozdebug == 0.1 13:15:09 INFO - mozdevice == 0.49 13:15:09 INFO - mozfile == 1.2 13:15:09 INFO - mozhttpd == 0.7 13:15:09 INFO - mozinfo == 0.9 13:15:09 INFO - mozleak == 0.1 13:15:09 INFO - mozlog == 3.4 13:15:09 INFO - moznetwork == 0.27 13:15:09 INFO - mozprocess == 0.25 13:15:09 INFO - mozprofile == 0.28 13:15:09 INFO - mozrunner == 6.13 13:15:09 INFO - mozscreenshot == 0.1 13:15:09 INFO - mozsystemmonitor == 0.3 13:15:09 INFO - moztest == 0.8 13:15:09 INFO - mozversion == 1.4 13:15:09 INFO - psutil == 3.1.1 13:15:09 INFO - requests == 1.2.3 13:15:09 INFO - wsgiref == 0.1.2 13:15:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:15: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')]} 13:15:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:15:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:15: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')]} 13:15:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:15:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:15:09 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 0x103893b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103896768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffd70443b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103671d30>, '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 0x103598db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103666be8>, '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.sFkzJEaMMa/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.HrPS7bVRC0/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/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 13:15:09 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 13:15:09 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 13:15:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.sFkzJEaMMa/Render', 13:15:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:15:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:15:09 INFO - 'HOME': '/Users/cltbld', 13:15:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:15:09 INFO - 'LOGNAME': 'cltbld', 13:15:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:15:09 INFO - 'MOZ_NO_REMOTE': '1', 13:15:09 INFO - 'NO_EM_RESTART': '1', 13:15:09 INFO - 'PAGER': '/bin/cat', 13:15:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:15:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:15:09 INFO - 'PWD': '/builds/slave/test', 13:15:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:15:09 INFO - 'SHELL': '/bin/bash', 13:15:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HrPS7bVRC0/Listeners', 13:15:09 INFO - 'TMPDIR': '/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/', 13:15:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:15:09 INFO - 'USER': 'cltbld', 13:15:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:15:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:15:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:15:09 INFO - 'XPC_FLAGS': '0x0', 13:15:09 INFO - 'XPC_SERVICE_NAME': '0', 13:15:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:15:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:15:10 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)) 13:15:10 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)) 13:15:10 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)) 13:15:10 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)) 13:15:10 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)) 13:15:10 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)) 13:15:10 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)) 13:15:10 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)) 13:15:10 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)) 13:15:10 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)) 13:15:10 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)) 13:15:10 INFO - Cleaning up... 13:15:10 INFO - Return code: 0 13:15:10 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 13:15:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:15:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:15:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:15:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:15:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:15:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:15:10 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x103893b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103896768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffd70443b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103671d30>, '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 0x103598db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103666be8>, '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.sFkzJEaMMa/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.HrPS7bVRC0/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/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 13:15:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 13:15:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 13:15:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.sFkzJEaMMa/Render', 13:15:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:15:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:15:10 INFO - 'HOME': '/Users/cltbld', 13:15:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:15:10 INFO - 'LOGNAME': 'cltbld', 13:15:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:15:10 INFO - 'MOZ_NO_REMOTE': '1', 13:15:10 INFO - 'NO_EM_RESTART': '1', 13:15:10 INFO - 'PAGER': '/bin/cat', 13:15:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:15:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:15:10 INFO - 'PWD': '/builds/slave/test', 13:15:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:15:10 INFO - 'SHELL': '/bin/bash', 13:15:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HrPS7bVRC0/Listeners', 13:15:10 INFO - 'TMPDIR': '/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/', 13:15:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:15:10 INFO - 'USER': 'cltbld', 13:15:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:15:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:15:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:15:10 INFO - 'XPC_FLAGS': '0x0', 13:15:10 INFO - 'XPC_SERVICE_NAME': '0', 13:15:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:15:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:15:10 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 13:15:10 INFO - Cleaning up... 13:15:10 INFO - Return code: 0 13:15:10 INFO - Running post-action listener: _resource_record_post_action 13:15:10 INFO - Running post-action listener: _start_resource_monitoring 13:15:10 INFO - Starting resource monitoring. 13:15:10 INFO - [mozharness: 2017-04-04 20:15:10.328039Z] Finished create-virtualenv step (success) 13:15:10 INFO - [mozharness: 2017-04-04 20:15:10.328969Z] Running install step. 13:15:10 INFO - Running pre-action listener: _resource_record_pre_action 13:15:10 INFO - Running main action method: install 13:15:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:15:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:15:10 INFO - Reading from file tmpfile_stdout 13:15:10 INFO - Detecting whether we're running mozinstall >=1.0... 13:15:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 13:15:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 13:15:10 INFO - Reading from file tmpfile_stdout 13:15:10 INFO - Output received: 13:15:10 INFO - Usage: mozinstall [options] installer 13:15:10 INFO - Options: 13:15:10 INFO - -h, --help show this help message and exit 13:15:10 INFO - -d DEST, --destination=DEST 13:15:10 INFO - Directory to install application into. [default: 13:15:10 INFO - "/builds/slave/test"] 13:15:10 INFO - --app=APP Application being installed. [default: firefox] 13:15:10 INFO - mkdir: /builds/slave/test/build/application 13:15:10 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'] 13:15:10 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 13:15:30 INFO - Reading from file tmpfile_stdout 13:15:30 INFO - Output received: 13:15:30 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 13:15:30 INFO - Running post-action listener: _resource_record_post_action 13:15:30 INFO - [mozharness: 2017-04-04 20:15:30.796405Z] Finished install step (success) 13:15:30 INFO - [mozharness: 2017-04-04 20:15:30.796556Z] Running run-tests step. 13:15:30 INFO - Running pre-action listener: _resource_record_pre_action 13:15:30 INFO - Running main action method: run_tests 13:15:30 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 13:15:30 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 13:15:30 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 13:15:30 INFO - 2017-04-04 13:15:30.811 screenresolution[1625:7519] starting screenresolution argv=screenresolution get 13:15:30 INFO - 2017-04-04 13:15:30.813 screenresolution[1625:7519] Display 0: 1600x1200x32@60 13:15:30 INFO - 2017-04-04 13:15:30.819 screenresolution[1626:7521] starting screenresolution argv=screenresolution list 13:15:30 INFO - Available Modes on Display 0 13:15:30 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 13:15:30 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 13:15:30 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 13:15:30 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 13:15:31 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 13:15:31 INFO - Intel Iris: 13:15:31 INFO - Chipset Model: Intel Iris 13:15:31 INFO - Type: GPU 13:15:31 INFO - Bus: Built-In 13:15:31 INFO - VRAM (Dynamic, Max): 1536 MB 13:15:31 INFO - Vendor: Intel (0x8086) 13:15:31 INFO - Device ID: 0x0a2e 13:15:31 INFO - Revision ID: 0x0009 13:15:31 INFO - Displays: 13:15:31 INFO - Display: 13:15:31 INFO - Resolution: 1600 x 1200 @ 60 Hz 13:15:31 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 13:15:31 INFO - Display Serial Number: 1600x1200 60 13:15:31 INFO - Main Display: Yes 13:15:31 INFO - Mirror: Off 13:15:31 INFO - Online: Yes 13:15:31 INFO - Rotation: Supported 13:15:31 INFO - Return code: 0 13:15:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 13:15:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 13:15:31 INFO - Python 2.7.3 13:15:31 INFO - Return code: 0 13:15:31 INFO - grabbing minidump binary from tooltool 13:15:31 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')]} 13:15:31 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 0x103671d30>, '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 0x103598db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103666be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 13:15:31 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 13:15:31 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 13:15:31 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 13:15:31 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 13:15:31 INFO - Return code: 0 13:15:31 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 13:15:31 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 13:15:31 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 13:15:31 INFO - ENV: RUST_BACKTRACE is now 1 13:15:31 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 13:15:31 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 13:15:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Pine', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/d4iKk8LgRCqYM8jbxQZwcQ/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0159', '--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 13:15:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Pine --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/d4iKk8LgRCqYM8jbxQZwcQ/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0159 --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 13:15:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.sFkzJEaMMa/Render', 13:15:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:15:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:15:31 INFO - 'HOME': '/Users/cltbld', 13:15:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:15:31 INFO - 'LOGNAME': 'cltbld', 13:15:31 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 13:15:31 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 13:15:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:15:31 INFO - 'MOZ_NO_REMOTE': '1', 13:15:31 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 13:15:31 INFO - 'NO_EM_RESTART': '1', 13:15:31 INFO - 'PAGER': '/bin/cat', 13:15:31 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:15:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:15:31 INFO - 'PWD': '/builds/slave/test', 13:15:31 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 13:15:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:15:31 INFO - 'RUST_BACKTRACE': '1', 13:15:31 INFO - 'SHELL': '/bin/bash', 13:15:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HrPS7bVRC0/Listeners', 13:15:31 INFO - 'TMPDIR': '/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/', 13:15:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:15:31 INFO - 'USER': 'cltbld', 13:15:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:15:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:15:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:15:31 INFO - 'XPC_FLAGS': '0x0', 13:15:31 INFO - 'XPC_SERVICE_NAME': '0', 13:15:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:15:31 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Pine', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/d4iKk8LgRCqYM8jbxQZwcQ/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0159', '--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 13:15:31 INFO - mozversion application_buildid: 20170404090329 13:15:31 INFO - mozversion application_changeset: 29799ff6c8a5578fb2939f66815668b18cb15e3b 13:15:31 INFO - mozversion application_display_name: Nightly 13:15:31 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 13:15:31 INFO - mozversion application_name: Firefox 13:15:31 INFO - mozversion application_remotingname: firefox 13:15:31 INFO - mozversion application_repository: https://hg.mozilla.org/projects/pine 13:15:31 INFO - mozversion application_vendor: Mozilla 13:15:31 INFO - mozversion application_version: 55.0a1 13:15:31 INFO - mozversion platform_buildid: 20170404090329 13:15:31 INFO - mozversion platform_changeset: 29799ff6c8a5578fb2939f66815668b18cb15e3b 13:15:31 INFO - mozversion platform_repository: https://hg.mozilla.org/projects/pine 13:15:31 INFO - mozversion platform_version: 55.0a1 13:15:31 INFO - using testdate: 1491336931 13:15:31 INFO - actual date: 1491336931 13:15:31 INFO - starting webserver on 'localhost:49243' 13:15:31 INFO - SUITE-START | Running 2 tests 13:15:31 INFO - TEST-START | dromaeo_css 13:15:31 INFO - operating with platform_type : mac_ 13:15:31 INFO - Initialising browser for dromaeo_css test... 13:15:31 INFO - TEST-INFO | started process 1636 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/tmpmKiSZv/profile http://localhost:49243/getInfo.html) 13:15:34 INFO - PID 1636 | __metrics Screen width/height:1600/1200 13:15:34 INFO - PID 1636 | colorDepth:24 13:15:34 INFO - PID 1636 | Browser inner width/height: 1024/689 13:15:34 INFO - PID 1636 | __metrics 13:15:34 INFO - PID 1636 | 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" 13:15:34 INFO - PID 1636 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 13:15:35 INFO - TEST-INFO | 1636: exit 0 13:15:35 INFO - Browser initialized. 13:15:35 INFO - Running cycle 1/1 for dromaeo_css test... 13:15:35 INFO - TEST-INFO | started process 1639 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/tmpmKiSZv/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:15:47 INFO - PID 1639 | RSS: Main: 233910272 13:15:47 INFO - PID 1639 | 13:18:51 INFO - PID 1639 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49243/tests/dromaeo/cssquery-ext.html) 13:18:54 INFO - PID 1639 | RSS: Main: 452370432 13:18:54 INFO - PID 1639 | 13:20:37 INFO - PID 1639 | ************************* 13:20:37 INFO - PID 1639 | A coding exception was thrown and uncaught in a Task. 13:20:37 INFO - PID 1639 | 13:20:37 ERROR - PID 1639 | Full message: TypeError: NetworkError when attempting to fetch resource. 13:20:37 INFO - PID 1639 | Full stack: 13:20:37 INFO - PID 1639 | ************************* 13:20:37 INFO - PID 1639 | ************************* 13:20:37 INFO - PID 1639 | A coding exception was thrown and uncaught in a Task. 13:20:37 INFO - PID 1639 | 13:20:37 ERROR - PID 1639 | Full message: TypeError: NetworkError when attempting to fetch resource. 13:20:37 INFO - PID 1639 | Full stack: 13:20:37 INFO - PID 1639 | ************************* 13:20:37 INFO - PID 1639 | ************************* 13:20:37 INFO - PID 1639 | A coding exception was thrown and uncaught in a Task. 13:20:37 INFO - PID 1639 | 13:20:37 ERROR - PID 1639 | Full message: TypeError: NetworkError when attempting to fetch resource. 13:20:37 INFO - PID 1639 | Full stack: 13:20:37 INFO - PID 1639 | ************************* 13:20:37 INFO - PID 1639 | ************************* 13:20:37 INFO - PID 1639 | A coding exception was thrown and uncaught in a Task. 13:20:37 INFO - PID 1639 | 13:20:37 ERROR - PID 1639 | Full message: TypeError: NetworkError when attempting to fetch resource. 13:20:37 INFO - PID 1639 | Full stack: 13:20:37 INFO - PID 1639 | ************************* 13:21:57 INFO - PID 1639 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-ext.html (next: http://localhost:49243/tests/dromaeo/cssquery-jquery.html) 13:21:58 INFO - PID 1639 | RSS: Main: 366907392 13:21:58 INFO - PID 1639 | 13:25:00 INFO - PID 1639 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49243/tests/dromaeo/cssquery-mootools.html) 13:25:00 INFO - PID 1639 | RSS: Main: 344428544 13:25:00 INFO - PID 1639 | 13:28:02 INFO - PID 1639 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49243/tests/dromaeo/cssquery-prototype.html) 13:28:03 INFO - PID 1639 | RSS: Main: 343130112 13:28:03 INFO - PID 1639 | 13:31:07 INFO - PID 1639 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49243/tests/dromaeo/cssquery-yui.html) 13:31:07 INFO - PID 1639 | RSS: Main: 339652608 13:31:07 INFO - PID 1639 | 13:34:10 INFO - PID 1639 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-yui.html (next: http://localhost:49243/tests/dromaeo/cssquery-dojo.html) 13:34:11 INFO - PID 1639 | RSS: Main: 435167232 13:34:11 INFO - PID 1639 | 13:34:11 INFO - PID 1639 | __start_tp_report 13:34:11 INFO - PID 1639 | _x_x_mozilla_page_load 13:34:11 INFO - PID 1639 | _x_x_mozilla_page_load_details 13:34:11 INFO - PID 1639 | |i|pagename|runs| 13:34:11 INFO - PID 1639 | |0;dojo.html;2929.5605659151133;3492.9825350873243;3510.280392519532;3522.8766993155236;3553.1472446612806;6061.515078793697;6128.442013630949;6181.134641150243;6223.813285601434;6230.470410015148;5348.732563371826;5892.08672655738;6091.116788065728;6104.4288396023;6120;4813.446453657839;5101.642884998052;5289.761960711778;5335.919961200585;5386.91919621206;5166.354205724285;5355;5359.464053594629;5388.299521062257;5410.945890541103;5274.024305503475;5278.181881808326;5285.392179899284;5286.101362768339;5287.312649355597;4832.154372984749;5278.1291086970605;5282.65662731925;5282.867928301785;5366.651167674088;5337.599680024014;5359.464053594609;5359.892802143974;5369.48989845964;5389.326334208224;6063.878722425571;6091.51267898567;6094.207752992127;6102.084687296897;6129.846753831145;6247.625142491465;6412.839679008015;6475.352464753534;6491.967540162316;6500.252470965852;6317.810465686037;6352.1742173517605;6373.6175829450385;6396.392342727433;6515.967420162916;6216;6220.377962203834;6221.129041934133;6225;6240.594361366542;6686.331366863372;6688.899666505006;6690.933090669128;6694.899576506356;6696.531242813054;6246.656433896179;6309.053641953744;6315.873682526324;6321.304656487782;6325.019621958604;6430.164078669743;6499.480041596661;6517.217933847968;6529.183852018497;6541.836454088686;6349.111124442582;6441.066045423388;6454.870902582016;6457.063725759833;6479.157709497735;6460.806175814733;6490.902636460362;6494.837629059311;6505.121808555785;6515;5084.491550844886;5153.819616313411;5163.328767260307;5166.844994650167;5175.094358487249;4568.74871882043;4651.534846515321;4706.764661766898;4723.929141062818;4728.621710263171;5990.191324171268;6059.515238780887;6065.939340606626;6077.088436734525;6090.36051214625;6348.047792831112;6432.292447830735;6491.513136514686;6494.318096599884;6500.927346987789;6134.9693251534345;6138.51101655979;6164.8767024659255;6171.783987560414;6182.598131121553;5729.627574207663;5744.913826292609;5750.511206547407;5755.194272801811;5776.768929242783;5600.299962504687;6439.227292724903;6535.248446428532;6673.632950187786;6750.35871592198;6530.67346632676;6565.540412171294;6568.507361947777;6572.901406479003;6586.934130658824;6772.5936443813525;6774.390304872585;6791.558548694319;6797.660116994031;6799.762008329685;6212.968935155295;6310.747570097328;6332.588381755171;6421.197350331208;6434.099226108255;6415.358464153547;6478.093066970722;6506.41442270198;6512;6513.934860651333;6347.079673447417;6355.078513615407;6355.777547785805;6367.3314301997625;6367.872642547216;6222.128901953821;6308.810735677937;6331.556791024584;6374.553781235269;6375.521835862236;6129.595450690841;6135.110179431366;6143.911070236141;6234.532410069353;6294.961331380271;6183.783567575113;6316.431521163117;6326.177596912372;6347.111404403479;6363.427291543783;5086.64393492452;6163.3836616338;6185.938140618537;6254.155688982111;6307.180066591313 13:34:11 INFO - PID 1639 | |1;ext.html;800.7717800426879;818.2186012358196;967.9903200967988;1159.513004538095;1171.5782318365386;33209.833950830245;37219;37400.69097581585;37513.43729844054;37570.812145939235;38796;39202.607973920254;39440.211195776064;39604.40593391102;39736.801315993376;6139.539534534905;6275.560710750249;8501.659933602665;8678.392512524126;8680.522571258578;8373.665053397857;8556.48661080334;8576.485410875337;8580.828383432328;8597.914020859806;8611.655533778641;8663.436876603033;8666.176713212266;8671.783205419852;8707.303415726727;8590.613422396007;8624.094470080676;8626.137386261387;8641.65433382664;8643;8341.708040218564;8448.32413406932;8505.872411913826;8523.701670441505;8523.701670441567;37201;37475.437868431996;37495.81252093722;37536.24927501462;37553.62446375529;3438.914027149341;3465.1683595936793;3472.8437220325145;3477.9826100869586;3482.1120614243205;29896.701032989607;29967.100986970207;30018;30051.398972020437;30053.39893202124;2651.5359812032816;3073.0627158716584;3129.217695576106;3131.5772370729887;3141.403133404646;334978.32510837534;339960;343194;343339.9999999975;343962;39930.60069399327;40515.18969620591;40531.78404647865;48415.78960526015;48661.5133848657;49832.0033599326;50587.74706126446;50591.74704126529;50716.746416267684;50725.22461713822;12327.630171094881;12474.563390281297;12530.874691252971;14141.929290353482;14291.785623215661;10081.19350451962;10093.646722364681;11297.49161287744;11440.713982150513;11448.370339631234;13379.464821407035;13390.866091339156;13394;13426.932865335611;13509.797353039712;5862.648241105462;5897.321807992136;5912.940870591239;5918.348981612019;5924.7333869975955;848.5375470368664;970.3741086998988;977.6333874796951;992.593036854886;1020.2501161646184;21141.04865281066;22147.06850627003;23796.405089872544;24071;24432.755672443403;1048.9423081730579;1073.9731506712394;1090.19870395261;1104.432195146288;1126.3692332293942;10542.209334299958;11262.605808796652;12079.396030198455;12177.391130443442;12242.510299588095;462246.68876656075;464824;466435;466637;466643;54073.45926540684;54227.72886135623;54409.45590544123;54414;54466.72766636142;1468.4933697874217;1511.2292730707638;1524.6798172383924;1531.6783475470054;1544.980312993419;23264.302070937898;23291.88354058219;23299.650505242094;23312;23338.64992025087;36988.63011369852;37100.51597936052;37112.44331334978;37127.88616341514;37134.8143259282;334658;414077;415883;416170;416675;27341.589876152273;31169.8441507791;31470.842645786626;31709.5243571342;31750.682493174772;40109.59890401176;40197;40500.39249411202;40791.388129177496;40862;25156.74843251544;26926.59610105811;27004.05485807987;27684.307892302855;28902.42195156127;27702.72297277082;28588.14235572936;28755.28111797222;28935.56596651094;29016.274593135342;28360.71639283663;33595.160120996195;35652.46521302131;36067.27865442729;36565.634343656224;28931.276718082216;28959;29663.703362966095;29960.400791984473;29969.400611988076;22362.07405037699;23393.41516462102;23606.937687803747;24273.69399907006;24335.63496547518 13:34:11 INFO - PID 1639 | |2;jquery.html;388.45034276498757;423.9915201695968;430.18909355864224;438.60525527025663;450.62372918612954;19499.805001949975;21145.788542114573;21981.780182198214;22000.669989950162;22020.009099590516;21669.3499195024;23283.95222215;23320.650190247117;23561.882190589065;23707.525849483;5896.321922978869;6168.84577885552;6186.628802271855;6195.070739389105;6197.969010154966;5773.2494775679315;6052.636841789506;6124.785632502863;6125.663088530129;6136.846578835521;5784.971075144618;6088.756449742005;6095.81712548622;6097.176881121059;6098.024316109423;5970.223870896777;6112.449879510866;6114.165750274899;6118.908216376758;6122.877542449149;5200.375954885438;5286.5242128208265;5375.6774593524515;5416.295881535375;5424.267723857268;26556.8672156638;26559.617663085566;26612;26811.195664130108;26928.326791830164;2165.7942495462908;2223.088533701191;2225.5660146271484;2227.643577027684;2230.185982116532;13807.723845523135;17157.399491017753;17557.385491507735;17800.732989005177;18017;2052.9794702052936;2069.7205877206684;2126.33020598511;2133.4453042208984;2136.6260904341834;148014;148285;149419;150355;153051.23474382557;11562;12109.910108090138;12136.575219867262;12152;12188.634340969786;16207.594810129842;16243.675126497405;16245.59386015359;16249.756253656205;16253.756193657104;8556.871646925301;8766.123387661182;8772.912270877338;8817;8920.643174273086;8308;8335.041470230879;8489.575521223915;8499.74500764978;8513.872291915626;5996.910046349309;6036.317846113867;7347.706091756377;7577.355924746458;7612.7368673543;1746.1316391461014;2068.2862770846855;2091.8535702500985;2102.7056212130315;2110.715053467793;858.2147335188233;918.9248579162396;938.4369378373058;950.9429434233969;964.5322018820866;19443.4166974991;20031.899840500704;20361.796382036286;20448.386548403276;20458.181672732924;963.8313295173317;982.7051884434784;991.7570195302197;1011.2718842433436;1018.2922868606247;10212.948935255276;10549.050585447347;10569.947150264199;10597.78553735049;10709.892901071045;689430;690000;698131.5093424602;708103;724413;100208;128603;135011;140643.29678351543;142783.2860835689;1181.6159748081907;1203.4043148641479;1227.1348699167065;1229.6003798765257;1230.655416483386;16139.838601614303;17757.668174886676;21438.92805359757;21618.027188776858;21709;39591.604083959945;59342.703286483295;61084.38915610787;61405;62680;85150;86502;88463;89278.55360723154;90358;6108.358622344767;7055.858882822417;8296.543690096862;8667.609957551798;8781.780455488664;11243;13183.406746696613;13253.933730331286;13459.528916487876;13716.314184290944;11589.942050289694;11624.360660163435;11747.530098795953;11870.940645296718;11948.103892207946;10629.362238265729;10673.733156671145;10698.786024279627;10834.34993900337;11034.393108379116;11481.598144065252;11759.353235572125;11783.941080294544;11953;11972.221805582958;8425.115362886809;8445.704400345958;8706.56467176626;8864.86702699447;8887.466751994642;11446.885531144582;11486.36824974601;11624.88375116238;11769.705757356134;11898.702532436759 13:34:11 INFO - PID 1639 | |3;mootools.html;1238.2508582307703;1398.6713122416231;1418.9361478733456;1436.3177490691917;1444.64606171488;10257.38455692658;10692.305000174993;10708.089812365939;10710.982456666614;10722.624708135218;10174.18606511479;10480.318779279341;10485.947570262138;10507.001834825698;10510.00154985277;2276.2715930902077;2319.060780383947;2320.234322673522;2322.105989194164;2330.475642980333;2194.8353873459473;2296.5292115116363;2446.3394883381475;2448.5470188015183;2448.853068815868;2045.4375046862083;2124.8193903518218;2126.138913739938;2351.670766092748;2446.4740080882607;2424.781769640732;2446.9510609787794;2447.3514518652573;2449.3386785567977;2452.950940981188;2397.7602239775883;2407.277816655014;2436.232586735173;2436.3909022744315;2436.488337449138;10830.891691083067;10922.017018468296;10931.234813563055;10948.45257737118;10956.616518421817;6183.752649893999;6417.96791016042;6421.101045853584;6421.775237866652;6427.485801135945;3102.720755132049;3874.3607304794673;3976.1252524444576;4017.738846974937;4036.2734707752593;1211.87881211879;1235.5366737473448;1248.3446190749928;1251.3242848861694;1268.0933132809994;15049.398024079133;15180.924095379563;15184.848151518454;15189.6202594936;15276.847231527765;5015.648904576645;5136.280920671109;5386.218998245311;5404.162354835007;5406.189071639285;11375;11376;11403.486843092081;11416.086713062936;11431.142664300045;6284.183056202664;6295.307516173218;6297.338779428185;6298.7795427160745;6304.684765761694;5714.342850572154;5733.598648094677;5974.2233509643465;6031.969840150771;6057.7879774207695;4075.572064933199;4184.142250838631;4200.327947528381;4228.619424251832;4265.829366825355;1228.538990495928;1236.190295356543;1260.9684757880943;1261.3377976562379;1266.265565971734;742.3986570877606;745.1468069060895;763.6868883757633;769.9874664815861;792.3265224559194;5753.827385178452;5834.212381328466;5967.8209653710455;6026.276846778414;6066.969665151646;553.9086050801573;573.1259828761089;585.9765609375662;586.6653363597763;588.0884628825304;3609.6931760800103;4213.978930105392;4326.610605045498;4357.542458041923;4522.29904364824;13196.538121165713;13614.18314901109;13634.1137826041;13638.863611363959;13645.181289122684;10940.4529773511;12929.224246545238;13503.662408439672;13523.120997135155;13539.323033848465;9766.462844543476;10067.144292735053;10072.597096116073;10078.38745800683;10084.294099412971;6384.840378990562;6388.64862432552;6416.133821934166;6657;6696.1629796275465;10440;11660.708482288012;12154.574589889666;12443.502259909503;12489.687757805765;12280.631581052583;12622.305773182563;12628.558000469939;12636.936815315865;12642.620721378373;9796.461194634363;9860.753481163028;10069.144122749356;10078.697639070839;10093.243006774375;9743.269254805777;9755.658551950648;9863.802723945337;9875.358101723365;9880.110790028932;8229.876551851607;8594.183552562497;8641.913580864111;8725.825483490422;8812.559372031501;8303.875441868498;8418.536980466133;8463.66145354179;8479.660813567389;8524.573771311285;7662.080550333995;7726.845463090594;7726.922730772845;7809.687612495437;7809.92190078092;5881.794137205177;5916.792912248051;5931.13998470228;5948.464638182584;6026.487748541423;4818.566329030404;5983.640981541122;5998.9100163496705;6011.789587364421;6040.456358927718 13:34:11 INFO - PID 1639 | |4;prototype.html;341.41106591130296;389.42365299356953;393.21161072050535;398.26321305584656;400.77957123582024;4642.466116396616;4851.53910378514;5747.568932330071;5768.798092066779;5881.059030555112;5204.661696989693;5529.447055294469;5636.4927156555905;5713.914291285623;5724.169995350682;3352.0446672698286;3979.2240513099955;4098.692598055143;4435.4899186593475;4455.131249406367;4208.494980602317;4367.781610919441;4369.519352871198;4373.365861950016;4380.787702210379;3785.3943369060958;4106.28140075487;4225.112726327475;4301.548337424557;4302.612764851163;3903.375459926398;4262.445882035347;4315.223259813232;4335.674824388184;4344.717593356453;3237.5629290045777;3729.9254014919547;3771.6039815819217;3772.490713753663;3794.848206071754;5604.131359639263;5630.15547667849;5673.6595804251465;5675;5686.943130568683;4701.929471057937;4797.136515427222;5121.308623335876;5145.8936328689515;5184.351956005499;4880.365552478191;5082.898342033139;6157.415045570709;6202.968985155046;6214.502839772853;3811.4473401356927;3863.9227215455817;4233.767142807144;4238.7032907696475;4245.1934132514725;6286.18279623646;6447.742090316428;6456.322086180978;6540.4440622547145;6619.602823830537;3564.7148228141687;3733.2720119576966;3842.481265029241;4185.288500954845;4193.764298058983;3969.226000929791;4244.172386384687;4352.412424322676;4364.388985542027;4370.628496577827;4408.404865343202;5074.619403544675;5076.847694569169;5081.18701007837;5081.542661160439;5971.760589778833;6168.444839964424;6199.783007594712;6241.968790156111;6251.59364641306;1319.2480286236944;1465.4138344662008;1487.6206567325262;1495.6859059597607;1498.1535432480614;939.915407613318;980.5832521178471;991.5290237137447;998.3610489286863;998.7852611688522;4918.319515863863;5789.8263052108505;5795.667491192581;5806.767729290781;5824.835242801418;6452.805861098693;6455.903161452582;6456.806295811133;6461.709223084972;6512.381323774234;4406.30357312437;4552.544745525421;5522.66863988162;5536.944630553723;5782.88434231313;2741.4517096580366;3313.3042061166943;3350.396928552835;3363.983180084084;3382.1713680148523;6241.313455519889;6264.248290205204;6556.541042127005;6654.26803051664;6703.279679777673;6055.7274922628585;6576.145101136917;6580.5581232667755;6592;6608.926849015231;5273.3935597406025;5443.673379597237;5982.670953097621;6358.268799088164;6653;5261.895241903269;5352.4915133062295;5662.575306852085;6087.421694938974;6466.612003279818;5197.610179236497;5497.312835895513;6380.7447702091395;6385.553011289165;6419.743210271537;6693.665316734046;6703.463722902058;6707.765228216989;6717.010930136043;6733.966330168318;4085.142120154801;4272.316429371285;4291.120320334387;4297.011687311999;4313.61177494027;5683.7442315095095;6127.448529632176;6418.935810641834;6457.967710161419;6509.837254068686;5413.729313534386;5846.532277417881;6202.131701561875;6206.224221972254;6214.875702485834;5435.673859568438;6036.607620504653;6175.857466368736;6178.41305076017;6243.500519958483;5313.096773548584;5884.35272120075;6098.725557349841;6099.9390006099375;6107.816765497042;5410.918836217538;5897.882042359214;6253.654294952179;6254.6537602382505;6286.717097730704;5043.899122017466;5295.099833028317;5588.552915766811;5811.418858114154;6029.487493563096 13:34:11 INFO - PID 1639 | |5;yui.html;797.5573556676046;820.499495307862;830.6843399508186;834.3450391442718;841.8148007438365;15496.767548486781;15800.288986995583;16206.918965405172;16538.173091345445;16654;14697;15083;15107.92446037771;15259.626633602973;15321.616959576017;985.152768618989;1000.2148313573846;1007.6674697349857;1010.151472762879;1010.701842956326;986.0238364019605;1027.9280450368476;1036.6319956415477;1039.3036665434176;1040.4537617750666;1073.3559864081528;1077.6605369308681;1081.2971568480473;1081.3890152064098;1081.7674200046988;1066.3814987307383;1073.962411315608;1074.462768615692;1076.208986394999;1077.0952399984012;799.3365506629484;804.5293503300576;804.5333706450244;805.5126648377706;805.7179987004561;16103.825983492196;16489.010659360356;16518.587035324093;16528.66942661152;16795.748063779054;14483.42066317346;14483.710325793425;14495.202763847985;14558;14629.707405851823;13275.60173194796;13295.933520332434;13397.799033014513;13434.261115638734;13559.25424101674;2917.533194688861;3301.1912081540177;3360.815155166465;3365.7980521168806;3367.057223977266;114743.42628286888;114936.42531787371;116511;117554;117640.41179794131;11142.27575207609;11269.323840569428;11407.022626242579;11532.962033417032;11937.403129843473;25079.749202508105;25095.121670741435;25122;25153.993840246552;25202;7677.30904218623;7754.224577542201;7771.72798952034;7802.414818888606;8084.555349455836;4102.118044620362;4119.608637179464;4188.706790524695;4192.605262634553;4239.792174827005;4013.2174226025645;4082.5305089914445;4099;4126.834926602963;4147.688923330762;755.5957562704037;839.3075712537182;849.7450764770545;852.1265702654829;852.194676031157;613.2120225510198;614.757170917494;641.1952998986243;644.6583310845259;654.4241067860253;9882.555285012191;9995.300328977048;10046.146077583488;10175.421209117938;10229.539670714836;584.6375247346588;602.5059451249933;617.7251123250201;642.8425035866243;653.349916832745;4602.194615942197;4615.5845973862515;4618.699784513996;4621.5378462154185;4712.31671407644;98857;100226;100480.99038019199;103608;104252;88056.559717201;88319.55840220758;88580;88749;89152;69666.60666786636;72849;74557.88163177557;74578.25421745822;77610;8675.175858293453;10946.94924740338;10982.725431864268;10983.890161098287;10998.560057597926;30220;37262;37482.812585936896;37609.43585846269;37731.62268377281;47626.04747905092;57908.4209157903;65820.34179658142;66796;66852.665736671;13180.406881690154;13375.799363009368;13463.865361346261;13555.728885422433;13781.95080931282;11753.412329383667;14028.605954951741;14297.714045719236;14332;14365;13448.731025379633;13499.595012149652;13507.257100859548;13562.254076025913;13607.863921361055;13311.33443327849;13492.730145397234;13835.723285534434;14460.855391445952;14546.85453145455;13339.733205336033;13378.880142581162;13731.794023089462;13792;13825.446982120602;9606.66376676813;10208.438535880598;10286.588536458457;10758.139348851917;10778.784424311312;10495.632652857113;11268.436578171222;11543.928354885762;11616.361100139573;11641 13:34:11 INFO - PID 1639 | __end_tp_report 13:34:11 INFO - PID 1639 | __start_cc_report 13:34:11 INFO - PID 1639 | _x_x_mozilla_cycle_collect,2818 13:34:11 INFO - PID 1639 | __end_cc_report 13:34:11 INFO - PID 1639 | __startTimestamp1491338051154__endTimestamp 13:34:11 INFO - PID 1639 | 13:34:11 INFO - PID 1639 | ------- Summary: start ------- 13:34:11 INFO - PID 1639 | Number of tests: 6 13:34:11 INFO - PID 1639 | 13:34:11 INFO - PID 1639 | [#0] dojo.html Cycles:165 Average:5982.40 Median:6225.00 stddev:705.62 (11.3%) stddev-sans-first:665.91 13:34:11 INFO - PID 1639 | Values: 2929.6 3493.0 3510.3 3522.9 3553.1 6061.5 6128.4 6181.1 6223.8 6230.5 5348.7 5892.1 6091.1 6104.4 6120.0 4813.4 5101.6 5289.8 5335.9 5386.9 5166.4 5355.0 5359.5 5388.3 5410.9 5274.0 5278.2 5285.4 5286.1 5287.3 4832.2 5278.1 5282.7 5282.9 5366.7 5337.6 5359.5 5359.9 5369.5 5389.3 6063.9 6091.5 6094.2 6102.1 6129.8 6247.6 6412.8 6475.4 6492.0 6500.3 6317.8 6352.2 6373.6 6396.4 6516.0 6216.0 6220.4 6221.1 6225.0 6240.6 6686.3 6688.9 6690.9 6694.9 6696.5 6246.7 6309.1 6315.9 6321.3 6325.0 6430.2 6499.5 6517.2 6529.2 6541.8 6349.1 6441.1 6454.9 6457.1 6479.2 6460.8 6490.9 6494.8 6505.1 6515.0 5084.5 5153.8 5163.3 5166.8 5175.1 4568.7 4651.5 4706.8 4723.9 4728.6 5990.2 6059.5 6065.9 6077.1 6090.4 6348.0 6432.3 6491.5 6494.3 6500.9 6135.0 6138.5 6164.9 6171.8 6182.6 5729.6 5744.9 5750.5 5755.2 5776.8 5600.3 6439.2 6535.2 6673.6 6750.4 6530.7 6565.5 6568.5 6572.9 6586.9 6772.6 6774.4 6791.6 6797.7 6799.8 6213.0 6310.7 6332.6 6421.2 6434.1 6415.4 6478.1 6506.4 6512.0 6513.9 6347.1 6355.1 6355.8 6367.3 6367.9 6222.1 6308.8 6331.6 6374.6 6375.5 6129.6 6135.1 6143.9 6234.5 6295.0 6183.8 6316.4 6326.2 6347.1 6363.4 5086.6 6163.4 6185.9 6254.2 6307.2 13:34:11 INFO - PID 1639 | 13:34:11 INFO - PID 1639 | [#1] ext.html Cycles:180 Average:52869.84 Median:3480.05 stddev:107765.00 (3096.7%) stddev-sans-first:107996.39 13:34:11 INFO - PID 1639 | Values: 800.8 818.2 968.0 1159.5 1171.6 33209.8 37219.0 37400.7 37513.4 37570.8 38796.0 39202.6 39440.2 39604.4 39736.8 6139.5 6275.6 8501.7 8678.4 8680.5 8373.7 8556.5 8576.5 8580.8 8597.9 8611.7 8663.4 8666.2 8671.8 8707.3 8590.6 8624.1 8626.1 8641.7 8643.0 8341.7 8448.3 8505.9 8523.7 8523.7 37201.0 37475.4 37495.8 37536.2 37553.6 3438.9 3465.2 3472.8 3478.0 3482.1 29896.7 29967.1 30018.0 30051.4 30053.4 2651.5 3073.1 3129.2 3131.6 3141.4 334978.3 339960.0 343194.0 343340.0 343962.0 39930.6 40515.2 40531.8 48415.8 48661.5 49832.0 50587.7 50591.7 50716.7 50725.2 12327.6 12474.6 12530.9 14141.9 14291.8 10081.2 10093.6 11297.5 11440.7 11448.4 13379.5 13390.9 13394.0 13426.9 13509.8 5862.6 5897.3 5912.9 5918.3 5924.7 848.5 970.4 977.6 992.6 1020.3 21141.0 22147.1 23796.4 24071.0 24432.8 1048.9 1074.0 1090.2 1104.4 1126.4 10542.2 11262.6 12079.4 12177.4 12242.5 462246.7 464824.0 466435.0 466637.0 466643.0 54073.5 54227.7 54409.5 54414.0 54466.7 1468.5 1511.2 1524.7 1531.7 1545.0 23264.3 23291.9 23299.7 23312.0 23338.6 36988.6 37100.5 37112.4 37127.9 37134.8 334658.0 414077.0 415883.0 416170.0 416675.0 27341.6 31169.8 31470.8 31709.5 31750.7 40109.6 40197.0 40500.4 40791.4 40862.0 25156.7 26926.6 27004.1 27684.3 28902.4 27702.7 28588.1 28755.3 28935.6 29016.3 28360.7 33595.2 35652.5 36067.3 36565.6 28931.3 28959.0 29663.7 29960.4 29969.4 22362.1 23393.4 23606.9 24273.7 24335.6 13:34:11 INFO - PID 1639 | 13:34:11 INFO - PID 1639 | [#2] jquery.html Cycles:180 Average:39771.42 Median:2226.60 stddev:117120.56 (5260.1%) stddev-sans-first:117411.78 13:34:11 INFO - PID 1639 | Values: 388.5 424.0 430.2 438.6 450.6 19499.8 21145.8 21981.8 22000.7 22020.0 21669.3 23284.0 23320.7 23561.9 23707.5 5896.3 6168.8 6186.6 6195.1 6198.0 5773.2 6052.6 6124.8 6125.7 6136.8 5785.0 6088.8 6095.8 6097.2 6098.0 5970.2 6112.4 6114.2 6118.9 6122.9 5200.4 5286.5 5375.7 5416.3 5424.3 26556.9 26559.6 26612.0 26811.2 26928.3 2165.8 2223.1 2225.6 2227.6 2230.2 13807.7 17157.4 17557.4 17800.7 18017.0 2053.0 2069.7 2126.3 2133.4 2136.6 148014.0 148285.0 149419.0 150355.0 153051.2 11562.0 12109.9 12136.6 12152.0 12188.6 16207.6 16243.7 16245.6 16249.8 16253.8 8556.9 8766.1 8772.9 8817.0 8920.6 8308.0 8335.0 8489.6 8499.7 8513.9 5996.9 6036.3 7347.7 7577.4 7612.7 1746.1 2068.3 2091.9 2102.7 2110.7 858.2 918.9 938.4 950.9 964.5 19443.4 20031.9 20361.8 20448.4 20458.2 963.8 982.7 991.8 1011.3 1018.3 10212.9 10549.1 10569.9 10597.8 10709.9 689430.0 690000.0 698131.5 708103.0 724413.0 100208.0 128603.0 135011.0 140643.3 142783.3 1181.6 1203.4 1227.1 1229.6 1230.7 16139.8 17757.7 21438.9 21618.0 21709.0 39591.6 59342.7 61084.4 61405.0 62680.0 85150.0 86502.0 88463.0 89278.6 90358.0 6108.4 7055.9 8296.5 8667.6 8781.8 11243.0 13183.4 13253.9 13459.5 13716.3 11589.9 11624.4 11747.5 11870.9 11948.1 10629.4 10673.7 10698.8 10834.3 11034.4 11481.6 11759.4 11783.9 11953.0 11972.2 8425.1 8445.7 8706.6 8864.9 8887.5 11446.9 11486.4 11624.9 11769.7 11898.7 13:34:11 INFO - PID 1639 | 13:34:11 INFO - PID 1639 | [#3] mootools.html Cycles:180 Average:6698.86 Median:2451.14 stddev:4125.71 (168.3%) stddev-sans-first:4116.87 13:34:11 INFO - PID 1639 | Values: 1238.3 1398.7 1418.9 1436.3 1444.6 10257.4 10692.3 10708.1 10711.0 10722.6 10174.2 10480.3 10485.9 10507.0 10510.0 2276.3 2319.1 2320.2 2322.1 2330.5 2194.8 2296.5 2446.3 2448.5 2448.9 2045.4 2124.8 2126.1 2351.7 2446.5 2424.8 2447.0 2447.4 2449.3 2453.0 2397.8 2407.3 2436.2 2436.4 2436.5 10830.9 10922.0 10931.2 10948.5 10956.6 6183.8 6418.0 6421.1 6421.8 6427.5 3102.7 3874.4 3976.1 4017.7 4036.3 1211.9 1235.5 1248.3 1251.3 1268.1 15049.4 15180.9 15184.8 15189.6 15276.8 5015.6 5136.3 5386.2 5404.2 5406.2 11375.0 11376.0 11403.5 11416.1 11431.1 6284.2 6295.3 6297.3 6298.8 6304.7 5714.3 5733.6 5974.2 6032.0 6057.8 4075.6 4184.1 4200.3 4228.6 4265.8 1228.5 1236.2 1261.0 1261.3 1266.3 742.4 745.1 763.7 770.0 792.3 5753.8 5834.2 5967.8 6026.3 6067.0 553.9 573.1 586.0 586.7 588.1 3609.7 4214.0 4326.6 4357.5 4522.3 13196.5 13614.2 13634.1 13638.9 13645.2 10940.5 12929.2 13503.7 13523.1 13539.3 9766.5 10067.1 10072.6 10078.4 10084.3 6384.8 6388.6 6416.1 6657.0 6696.2 10440.0 11660.7 12154.6 12443.5 12489.7 12280.6 12622.3 12628.6 12636.9 12642.6 9796.5 9860.8 10069.1 10078.7 10093.2 9743.3 9755.7 9863.8 9875.4 9880.1 8229.9 8594.2 8641.9 8725.8 8812.6 8303.9 8418.5 8463.7 8479.7 8524.6 7662.1 7726.8 7726.9 7809.7 7809.9 5881.8 5916.8 5931.1 5948.5 6026.5 4818.6 5983.6 5998.9 6011.8 6040.5 13:34:11 INFO - PID 1639 | 13:34:11 INFO - PID 1639 | [#4] prototype.html Cycles:180 Average:4949.52 Median:5526.06 stddev:1556.58 (28.2%) stddev-sans-first:1522.04 13:34:11 INFO - PID 1639 | Values: 341.4 389.4 393.2 398.3 400.8 4642.5 4851.5 5747.6 5768.8 5881.1 5204.7 5529.4 5636.5 5713.9 5724.2 3352.0 3979.2 4098.7 4435.5 4455.1 4208.5 4367.8 4369.5 4373.4 4380.8 3785.4 4106.3 4225.1 4301.5 4302.6 3903.4 4262.4 4315.2 4335.7 4344.7 3237.6 3729.9 3771.6 3772.5 3794.8 5604.1 5630.2 5673.7 5675.0 5686.9 4701.9 4797.1 5121.3 5145.9 5184.4 4880.4 5082.9 6157.4 6203.0 6214.5 3811.4 3863.9 4233.8 4238.7 4245.2 6286.2 6447.7 6456.3 6540.4 6619.6 3564.7 3733.3 3842.5 4185.3 4193.8 3969.2 4244.2 4352.4 4364.4 4370.6 4408.4 5074.6 5076.8 5081.2 5081.5 5971.8 6168.4 6199.8 6242.0 6251.6 1319.2 1465.4 1487.6 1495.7 1498.2 939.9 980.6 991.5 998.4 998.8 4918.3 5789.8 5795.7 5806.8 5824.8 6452.8 6455.9 6456.8 6461.7 6512.4 4406.3 4552.5 5522.7 5536.9 5782.9 2741.5 3313.3 3350.4 3364.0 3382.2 6241.3 6264.2 6556.5 6654.3 6703.3 6055.7 6576.1 6580.6 6592.0 6608.9 5273.4 5443.7 5982.7 6358.3 6653.0 5261.9 5352.5 5662.6 6087.4 6466.6 5197.6 5497.3 6380.7 6385.6 6419.7 6693.7 6703.5 6707.8 6717.0 6734.0 4085.1 4272.3 4291.1 4297.0 4313.6 5683.7 6127.4 6418.9 6458.0 6509.8 5413.7 5846.5 6202.1 6206.2 6214.9 5435.7 6036.6 6175.9 6178.4 6243.5 5313.1 5884.4 6098.7 6099.9 6107.8 5410.9 5897.9 6253.7 6254.7 6286.7 5043.9 5295.1 5588.6 5811.4 6029.5 13:34:11 INFO - PID 1639 | 13:34:11 INFO - PID 1639 | [#5] yui.html Cycles:180 Average:20329.69 Median:16155.37 stddev:29316.79 (181.5%) stddev-sans-first:29362.35 13:34:11 INFO - PID 1639 | Values: 797.6 820.5 830.7 834.3 841.8 15496.8 15800.3 16206.9 16538.2 16654.0 14697.0 15083.0 15107.9 15259.6 15321.6 985.2 1000.2 1007.7 1010.2 1010.7 986.0 1027.9 1036.6 1039.3 1040.5 1073.4 1077.7 1081.3 1081.4 1081.8 1066.4 1074.0 1074.5 1076.2 1077.1 799.3 804.5 804.5 805.5 805.7 16103.8 16489.0 16518.6 16528.7 16795.7 14483.4 14483.7 14495.2 14558.0 14629.7 13275.6 13295.9 13397.8 13434.3 13559.3 2917.5 3301.2 3360.8 3365.8 3367.1 114743.4 114936.4 116511.0 117554.0 117640.4 11142.3 11269.3 11407.0 11533.0 11937.4 25079.7 25095.1 25122.0 25154.0 25202.0 7677.3 7754.2 7771.7 7802.4 8084.6 4102.1 4119.6 4188.7 4192.6 4239.8 4013.2 4082.5 4099.0 4126.8 4147.7 755.6 839.3 849.7 852.1 852.2 613.2 614.8 641.2 644.7 654.4 9882.6 9995.3 10046.1 10175.4 10229.5 584.6 602.5 617.7 642.8 653.3 4602.2 4615.6 4618.7 4621.5 4712.3 98857.0 100226.0 100481.0 103608.0 104252.0 88056.6 88319.6 88580.0 88749.0 89152.0 69666.6 72849.0 74557.9 74578.3 77610.0 8675.2 10946.9 10982.7 10983.9 10998.6 30220.0 37262.0 37482.8 37609.4 37731.6 47626.0 57908.4 65820.3 66796.0 66852.7 13180.4 13375.8 13463.9 13555.7 13782.0 11753.4 14028.6 14297.7 14332.0 14365.0 13448.7 13499.6 13507.3 13562.3 13607.9 13311.3 13492.7 13835.7 14460.9 14546.9 13339.7 13378.9 13731.8 13792.0 13825.4 9606.7 10208.4 10286.6 10758.1 10778.8 10495.6 11268.4 11543.9 11616.4 11641.0 13:34:11 INFO - PID 1639 | -------- Summary: end -------- 13:34:11 INFO - PID 1639 | 13:34:11 INFO - TEST-INFO | 1639: exit 0 13:34:11 INFO - TEST-OK | dromaeo_css | took 1120494ms 13:34:11 INFO - TEST-START | kraken 13:34:11 INFO - operating with platform_type : mac_ 13:34:11 INFO - Initialising browser for kraken test... 13:34:11 INFO - TEST-INFO | started process 1649 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/tmpZJ_4ga/profile http://localhost:49243/getInfo.html) 13:34:14 INFO - PID 1649 | __metrics Screen width/height:1600/1200 13:34:14 INFO - PID 1649 | colorDepth:24 13:34:14 INFO - PID 1649 | Browser inner width/height: 1024/689 13:34:14 INFO - PID 1649 | __metrics 13:34:14 INFO - PID 1649 | 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" 13:34:14 INFO - PID 1649 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 13:34:15 INFO - TEST-INFO | 1649: exit 0 13:34:15 INFO - Browser initialized. 13:34:15 INFO - Running cycle 1/1 for kraken test... 13:34:15 INFO - TEST-INFO | started process 1650 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/tmpZJ_4ga/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:34:27 INFO - PID 1650 | RSS: Main: 234106880 13:34:27 INFO - PID 1650 | 13:34:30 INFO - PID 1650 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49243/tests/kraken/driver.html?testName=audio-beat-detection) 13:34:31 INFO - PID 1650 | RSS: Main: 287342592 13:34:31 INFO - PID 1650 | 13:34:34 INFO - PID 1650 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49243/tests/kraken/driver.html?testName=audio-dft) 13:34:34 INFO - PID 1650 | RSS: Main: 289255424 13:34:34 INFO - PID 1650 | 13:34:38 INFO - PID 1650 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49243/tests/kraken/driver.html?testName=audio-fft) 13:34:38 INFO - PID 1650 | RSS: Main: 381227008 13:34:38 INFO - PID 1650 | 13:34:41 INFO - PID 1650 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49243/tests/kraken/driver.html?testName=audio-oscillator) 13:34:41 INFO - PID 1650 | RSS: Main: 285323264 13:34:41 INFO - PID 1650 | 13:34:43 INFO - PID 1650 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49243/tests/kraken/driver.html?testName=imaging-gaussian-blur) 13:34:44 INFO - PID 1650 | RSS: Main: 287113216 13:34:44 INFO - PID 1650 | 13:34:47 INFO - PID 1650 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49243/tests/kraken/driver.html?testName=imaging-darkroom) 13:34:48 INFO - PID 1650 | RSS: Main: 327561216 13:34:48 INFO - PID 1650 | 13:34:51 INFO - PID 1650 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49243/tests/kraken/driver.html?testName=imaging-desaturate) 13:34:51 INFO - PID 1650 | RSS: Main: 336723968 13:34:51 INFO - PID 1650 | 13:34:55 INFO - PID 1650 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49243/tests/kraken/driver.html?testName=json-parse-financial) 13:34:55 INFO - PID 1650 | RSS: Main: 339378176 13:34:55 INFO - PID 1650 | 13:34:57 INFO - PID 1650 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49243/tests/kraken/driver.html?testName=json-stringify-tinderbox) 13:34:58 INFO - PID 1650 | RSS: Main: 306147328 13:34:58 INFO - PID 1650 | 13:34:59 INFO - PID 1650 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-aes) 13:35:00 INFO - PID 1650 | RSS: Main: 307462144 13:35:00 INFO - PID 1650 | 13:35:02 INFO - PID 1650 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-ccm) 13:35:03 INFO - PID 1650 | RSS: Main: 309641216 13:35:03 INFO - PID 1650 | 13:35:06 INFO - PID 1650 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 13:35:07 INFO - PID 1650 | RSS: Main: 327475200 13:35:07 INFO - PID 1650 | 13:35:10 INFO - PID 1650 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 13:35:11 INFO - PID 1650 | RSS: Main: 321343488 13:35:11 INFO - PID 1650 | 13:35:13 INFO - PID 1650 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49243/tests/kraken/driver.html?testName=ai-astar) 13:35:13 INFO - PID 1650 | RSS: Main: 384024576 13:35:13 INFO - PID 1650 | 13:35:13 INFO - PID 1650 | __start_tp_report 13:35:13 INFO - PID 1650 | _x_x_mozilla_page_load 13:35:13 INFO - PID 1650 | _x_x_mozilla_page_load_details 13:35:13 INFO - PID 1650 | |i|pagename|runs| 13:35:13 INFO - PID 1650 | |0;ai-astar;110;121;123;123;122;123;122;121;124;122 13:35:13 INFO - PID 1650 | |1;audio-beat-detection;159;147;153;182;120;125;115;116;141;115 13:35:13 INFO - PID 1650 | |2;audio-dft;212;211;214;215;213;211;208;213;210;212 13:35:13 INFO - PID 1650 | |3;audio-fft;84;60;77;125;64;61;65;90;98;95 13:35:13 INFO - PID 1650 | |4;audio-oscillator;97;76;96;76;75;73;90;73;75;91 13:35:13 INFO - PID 1650 | |5;imaging-gaussian-blur;90;91;91;89;90;90;90;94;90;90 13:35:13 INFO - PID 1650 | |6;imaging-darkroom;98;99;99;99;99;99;98;99;98;100 13:35:13 INFO - PID 1650 | |7;imaging-desaturate;142;135;101;103;146;135;100;101;101;101 13:35:13 INFO - PID 1650 | |8;json-parse-financial;53;50;49;49;51;53;52;52;50;50 13:35:13 INFO - PID 1650 | |9;json-stringify-tinderbox;58;64;72;70;69;65;64;64;62;63 13:35:13 INFO - PID 1650 | |10;stanford-crypto-aes;91;86;92;88;86;92;88;88;90;89 13:35:13 INFO - PID 1650 | |11;stanford-crypto-ccm;151;153;149;158;151;168;171;169;186;170 13:35:13 INFO - PID 1650 | |12;stanford-crypto-pbkdf2;189;199;200;198;198;199;204;199;198;199 13:35:13 INFO - PID 1650 | |13;stanford-crypto-sha256-iterative;71;73;73;72;72;72;72;73;74;73 13:35:13 INFO - PID 1650 | __end_tp_report 13:35:13 INFO - PID 1650 | __start_cc_report 13:35:13 INFO - PID 1650 | _x_x_mozilla_cycle_collect,2131 13:35:13 INFO - PID 1650 | __end_cc_report 13:35:13 INFO - PID 1650 | __startTimestamp1491338113328__endTimestamp 13:35:13 INFO - PID 1650 | 13:35:13 INFO - PID 1650 | ------- Summary: start ------- 13:35:13 INFO - PID 1650 | Number of tests: 14 13:35:13 INFO - PID 1650 | 13:35:13 INFO - PID 1650 | [#0] ai-astar Cycles:10 Average:121.10 Median:122.50 stddev:4.01 (3.3%) stddev-sans-first:1.00 13:35:13 INFO - PID 1650 | Values: 110.0 121.0 123.0 123.0 122.0 123.0 122.0 121.0 124.0 122.0 13:35:13 INFO - PID 1650 | 13:35:13 INFO - PID 1650 | [#1] audio-beat-detection Cycles:10 Average:137.30 Median:144.00 stddev:22.91 (15.9%) stddev-sans-first:22.91 13:35:13 INFO - PID 1650 | Values: 159.0 147.0 153.0 182.0 120.0 125.0 115.0 116.0 141.0 115.0 13:35:13 INFO - PID 1650 | 13:35:13 INFO - PID 1650 | [#2] audio-dft Cycles:10 Average:211.90 Median:212.50 stddev:2.02 (1.0%) stddev-sans-first:2.15 13:35:13 INFO - PID 1650 | Values: 212.0 211.0 214.0 215.0 213.0 211.0 208.0 213.0 210.0 212.0 13:35:13 INFO - PID 1650 | 13:35:13 INFO - PID 1650 | [#3] audio-fft Cycles:10 Average:81.90 Median:80.50 stddev:20.83 (25.9%) stddev-sans-first:22.08 13:35:13 INFO - PID 1650 | Values: 84.0 60.0 77.0 125.0 64.0 61.0 65.0 90.0 98.0 95.0 13:35:13 INFO - PID 1650 | 13:35:13 INFO - PID 1650 | [#4] audio-oscillator Cycles:10 Average:82.20 Median:83.00 stddev:9.99 (12.0%) stddev-sans-first:9.04 13:35:13 INFO - PID 1650 | Values: 97.0 76.0 96.0 76.0 75.0 73.0 90.0 73.0 75.0 91.0 13:35:13 INFO - PID 1650 | 13:35:13 INFO - PID 1650 | [#5] imaging-gaussian-blur Cycles:10 Average:90.50 Median:90.00 stddev:1.35 (1.5%) stddev-sans-first:1.42 13:35:13 INFO - PID 1650 | Values: 90.0 91.0 91.0 89.0 90.0 90.0 90.0 94.0 90.0 90.0 13:35:13 INFO - PID 1650 | 13:35:13 INFO - PID 1650 | [#6] imaging-darkroom Cycles:10 Average:98.80 Median:99.00 stddev:0.63 (0.6%) stddev-sans-first:0.60 13:35:13 INFO - PID 1650 | Values: 98.0 99.0 99.0 99.0 99.0 99.0 98.0 99.0 98.0 100.0 13:35:13 INFO - PID 1650 | 13:35:13 INFO - PID 1650 | [#7] imaging-desaturate Cycles:10 Average:116.50 Median:119.00 stddev:20.06 (16.9%) stddev-sans-first:19.03 13:35:13 INFO - PID 1650 | Values: 142.0 135.0 101.0 103.0 146.0 135.0 100.0 101.0 101.0 101.0 13:35:13 INFO - PID 1650 | 13:35:13 INFO - PID 1650 | [#8] json-parse-financial Cycles:10 Average:50.90 Median:51.50 stddev:1.52 (3.0%) stddev-sans-first:1.41 13:35:13 INFO - PID 1650 | Values: 53.0 50.0 49.0 49.0 51.0 53.0 52.0 52.0 50.0 50.0 13:35:13 INFO - PID 1650 | 13:35:13 INFO - PID 1650 | [#9] json-stringify-tinderbox Cycles:10 Average:65.10 Median:64.50 stddev:4.15 (6.4%) stddev-sans-first:3.52 13:35:13 INFO - PID 1650 | Values: 58.0 64.0 72.0 70.0 69.0 65.0 64.0 64.0 62.0 63.0 13:35:13 INFO - PID 1650 | 13:35:13 INFO - PID 1650 | [#10] stanford-crypto-aes Cycles:10 Average:89.00 Median:89.50 stddev:2.21 (2.5%) stddev-sans-first:2.22 13:35:13 INFO - PID 1650 | Values: 91.0 86.0 92.0 88.0 86.0 92.0 88.0 88.0 90.0 89.0 13:35:13 INFO - PID 1650 | 13:35:13 INFO - PID 1650 | [#11] stanford-crypto-ccm Cycles:10 Average:162.60 Median:168.50 stddev:12.07 (7.2%) stddev-sans-first:12.05 13:35:13 INFO - PID 1650 | Values: 151.0 153.0 149.0 158.0 151.0 168.0 171.0 169.0 186.0 170.0 13:35:13 INFO - PID 1650 | 13:35:13 INFO - PID 1650 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:198.30 Median:199.00 stddev:3.71 (1.9%) stddev-sans-first:1.87 13:35:13 INFO - PID 1650 | Values: 189.0 199.0 200.0 198.0 198.0 199.0 204.0 199.0 198.0 199.0 13:35:13 INFO - PID 1650 | 13:35:13 INFO - PID 1650 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:72.50 Median:73.00 stddev:0.85 (1.2%) stddev-sans-first:0.71 13:35:13 INFO - PID 1650 | Values: 71.0 73.0 73.0 72.0 72.0 72.0 72.0 73.0 74.0 73.0 13:35:13 INFO - PID 1650 | -------- Summary: end -------- 13:35:13 INFO - PID 1650 | 13:35:14 INFO - TEST-INFO | 1650: exit 0 13:35:14 INFO - TEST-OK | kraken | took 62403ms 13:35:14 INFO - SUITE-END | took 1182s 13:35:14 INFO - Completed test suite (00:19:43) 13:35:14 INFO - javascript benchmark 13:35:14 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7570.8798279617595, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2929.5605659151133, 3492.9825350873243, 3510.280392519532, 3522.8766993155236, 3553.1472446612806, 6061.515078793697, 6128.442013630949, 6181.134641150243, 6223.813285601434, 6230.470410015148, 5348.732563371826, 5892.08672655738, 6091.116788065728, 6104.4288396023, 6120.0, 4813.446453657839, 5101.642884998052, 5289.761960711778, 5335.919961200585, 5386.91919621206, 5166.354205724285, 5355.0, 5359.464053594629, 5388.299521062257, 5410.945890541103, 5274.024305503475, 5278.181881808326, 5285.392179899284, 5286.101362768339, 5287.312649355597, 4832.154372984749, 5278.1291086970605, 5282.65662731925, 5282.867928301785, 5366.651167674088, 5337.599680024014, 5359.464053594609, 5359.892802143974, 5369.48989845964, 5389.326334208224, 6063.878722425571, 6091.51267898567, 6094.207752992127, 6102.084687296897, 6129.846753831145, 6247.625142491465, 6412.839679008015, 6475.352464753534, 6491.967540162316, 6500.252470965852, 6317.810465686037, 6352.1742173517605, 6373.6175829450385, 6396.392342727433, 6515.967420162916, 6216.0, 6220.377962203834, 6221.129041934133, 6225.0, 6240.594361366542, 6686.331366863372, 6688.899666505006, 6690.933090669128, 6694.899576506356, 6696.531242813054, 6246.656433896179, 6309.053641953744, 6315.873682526324, 6321.304656487782, 6325.019621958604, 6430.164078669743, 6499.480041596661, 6517.217933847968, 6529.183852018497, 6541.836454088686, 6349.111124442582, 6441.066045423388, 6454.870902582016, 6457.063725759833, 6479.157709497735, 6460.806175814733, 6490.902636460362, 6494.837629059311, 6505.121808555785, 6515.0, 5084.491550844886, 5153.819616313411, 5163.328767260307, 5166.844994650167, 5175.094358487249, 4568.74871882043, 4651.534846515321, 4706.764661766898, 4723.929141062818, 4728.621710263171, 5990.191324171268, 6059.515238780887, 6065.939340606626, 6077.088436734525, 6090.36051214625, 6348.047792831112, 6432.292447830735, 6491.513136514686, 6494.318096599884, 6500.927346987789, 6134.9693251534345, 6138.51101655979, 6164.8767024659255, 6171.783987560414, 6182.598131121553, 5729.627574207663, 5744.913826292609, 5750.511206547407, 5755.194272801811, 5776.768929242783, 5600.299962504687, 6439.227292724903, 6535.248446428532, 6673.632950187786, 6750.35871592198, 6530.67346632676, 6565.540412171294, 6568.507361947777, 6572.901406479003, 6586.934130658824, 6772.5936443813525, 6774.390304872585, 6791.558548694319, 6797.660116994031, 6799.762008329685, 6212.968935155295, 6310.747570097328, 6332.588381755171, 6421.197350331208, 6434.099226108255, 6415.358464153547, 6478.093066970722, 6506.41442270198, 6512.0, 6513.934860651333, 6347.079673447417, 6355.078513615407, 6355.777547785805, 6367.3314301997625, 6367.872642547216, 6222.128901953821, 6308.810735677937, 6331.556791024584, 6374.553781235269, 6375.521835862236, 6129.595450690841, 6135.110179431366, 6143.911070236141, 6234.532410069353, 6294.961331380271, 6183.783567575113, 6316.431521163117, 6326.177596912372, 6347.111404403479, 6363.427291543783, 5086.64393492452, 6163.3836616338, 6185.938140618537, 6254.155688982111, 6307.180066591313], "value": 5934.7065960294985, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [800.7717800426879, 818.2186012358196, 967.9903200967988, 1159.513004538095, 1171.5782318365386, 33209.833950830245, 37219.0, 37400.69097581585, 37513.43729844054, 37570.812145939235, 38796.0, 39202.607973920254, 39440.211195776064, 39604.40593391102, 39736.801315993376, 6139.539534534905, 6275.560710750249, 8501.659933602665, 8678.392512524126, 8680.522571258578, 8373.665053397857, 8556.48661080334, 8576.485410875337, 8580.828383432328, 8597.914020859806, 8611.655533778641, 8663.436876603033, 8666.176713212266, 8671.783205419852, 8707.303415726727, 8590.613422396007, 8624.094470080676, 8626.137386261387, 8641.65433382664, 8643.0, 8341.708040218564, 8448.32413406932, 8505.872411913826, 8523.701670441505, 8523.701670441567, 37201.0, 37475.437868431996, 37495.81252093722, 37536.24927501462, 37553.62446375529, 3438.914027149341, 3465.1683595936793, 3472.8437220325145, 3477.9826100869586, 3482.1120614243205, 29896.701032989607, 29967.100986970207, 30018.0, 30051.398972020437, 30053.39893202124, 2651.5359812032816, 3073.0627158716584, 3129.217695576106, 3131.5772370729887, 3141.403133404646, 334978.32510837534, 339960.0, 343194.0, 343339.9999999975, 343962.0, 39930.60069399327, 40515.18969620591, 40531.78404647865, 48415.78960526015, 48661.5133848657, 49832.0033599326, 50587.74706126446, 50591.74704126529, 50716.746416267684, 50725.22461713822, 12327.630171094881, 12474.563390281297, 12530.874691252971, 14141.929290353482, 14291.785623215661, 10081.19350451962, 10093.646722364681, 11297.49161287744, 11440.713982150513, 11448.370339631234, 13379.464821407035, 13390.866091339156, 13394.0, 13426.932865335611, 13509.797353039712, 5862.648241105462, 5897.321807992136, 5912.940870591239, 5918.348981612019, 5924.7333869975955, 848.5375470368664, 970.3741086998988, 977.6333874796951, 992.593036854886, 1020.2501161646184, 21141.04865281066, 22147.06850627003, 23796.405089872544, 24071.0, 24432.755672443403, 1048.9423081730579, 1073.9731506712394, 1090.19870395261, 1104.432195146288, 1126.3692332293942, 10542.209334299958, 11262.605808796652, 12079.396030198455, 12177.391130443442, 12242.510299588095, 462246.68876656075, 464824.0, 466435.0, 466637.0, 466643.0, 54073.45926540684, 54227.72886135623, 54409.45590544123, 54414.0, 54466.72766636142, 1468.4933697874217, 1511.2292730707638, 1524.6798172383924, 1531.6783475470054, 1544.980312993419, 23264.302070937898, 23291.88354058219, 23299.650505242094, 23312.0, 23338.64992025087, 36988.63011369852, 37100.51597936052, 37112.44331334978, 37127.88616341514, 37134.8143259282, 334658.0, 414077.0, 415883.0, 416170.0, 416675.0, 27341.589876152273, 31169.8441507791, 31470.842645786626, 31709.5243571342, 31750.682493174772, 40109.59890401176, 40197.0, 40500.39249411202, 40791.388129177496, 40862.0, 25156.74843251544, 26926.59610105811, 27004.05485807987, 27684.307892302855, 28902.42195156127, 27702.72297277082, 28588.14235572936, 28755.28111797222, 28935.56596651094, 29016.274593135342, 28360.71639283663, 33595.160120996195, 35652.46521302131, 36067.27865442729, 36565.634343656224, 28931.276718082216, 28959.0, 29663.703362966095, 29960.400791984473, 29969.400611988076, 22362.07405037699, 23393.41516462102, 23606.937687803747, 24273.69399907006, 24335.63496547518], "value": 17446.90955601189, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [388.45034276498757, 423.9915201695968, 430.18909355864224, 438.60525527025663, 450.62372918612954, 19499.805001949975, 21145.788542114573, 21981.780182198214, 22000.669989950162, 22020.009099590516, 21669.3499195024, 23283.95222215, 23320.650190247117, 23561.882190589065, 23707.525849483, 5896.321922978869, 6168.84577885552, 6186.628802271855, 6195.070739389105, 6197.969010154966, 5773.2494775679315, 6052.636841789506, 6124.785632502863, 6125.663088530129, 6136.846578835521, 5784.971075144618, 6088.756449742005, 6095.81712548622, 6097.176881121059, 6098.024316109423, 5970.223870896777, 6112.449879510866, 6114.165750274899, 6118.908216376758, 6122.877542449149, 5200.375954885438, 5286.5242128208265, 5375.6774593524515, 5416.295881535375, 5424.267723857268, 26556.8672156638, 26559.617663085566, 26612.0, 26811.195664130108, 26928.326791830164, 2165.7942495462908, 2223.088533701191, 2225.5660146271484, 2227.643577027684, 2230.185982116532, 13807.723845523135, 17157.399491017753, 17557.385491507735, 17800.732989005177, 18017.0, 2052.9794702052936, 2069.7205877206684, 2126.33020598511, 2133.4453042208984, 2136.6260904341834, 148014.0, 148285.0, 149419.0, 150355.0, 153051.23474382557, 11562.0, 12109.910108090138, 12136.575219867262, 12152.0, 12188.634340969786, 16207.594810129842, 16243.675126497405, 16245.59386015359, 16249.756253656205, 16253.756193657104, 8556.871646925301, 8766.123387661182, 8772.912270877338, 8817.0, 8920.643174273086, 8308.0, 8335.041470230879, 8489.575521223915, 8499.74500764978, 8513.872291915626, 5996.910046349309, 6036.317846113867, 7347.706091756377, 7577.355924746458, 7612.7368673543, 1746.1316391461014, 2068.2862770846855, 2091.8535702500985, 2102.7056212130315, 2110.715053467793, 858.2147335188233, 918.9248579162396, 938.4369378373058, 950.9429434233969, 964.5322018820866, 19443.4166974991, 20031.899840500704, 20361.796382036286, 20448.386548403276, 20458.181672732924, 963.8313295173317, 982.7051884434784, 991.7570195302197, 1011.2718842433436, 1018.2922868606247, 10212.948935255276, 10549.050585447347, 10569.947150264199, 10597.78553735049, 10709.892901071045, 689430.0, 690000.0, 698131.5093424602, 708103.0, 724413.0, 100208.0, 128603.0, 135011.0, 140643.29678351543, 142783.2860835689, 1181.6159748081907, 1203.4043148641479, 1227.1348699167065, 1229.6003798765257, 1230.655416483386, 16139.838601614303, 17757.668174886676, 21438.92805359757, 21618.027188776858, 21709.0, 39591.604083959945, 59342.703286483295, 61084.38915610787, 61405.0, 62680.0, 85150.0, 86502.0, 88463.0, 89278.55360723154, 90358.0, 6108.358622344767, 7055.858882822417, 8296.543690096862, 8667.609957551798, 8781.780455488664, 11243.0, 13183.406746696613, 13253.933730331286, 13459.528916487876, 13716.314184290944, 11589.942050289694, 11624.360660163435, 11747.530098795953, 11870.940645296718, 11948.103892207946, 10629.362238265729, 10673.733156671145, 10698.786024279627, 10834.34993900337, 11034.393108379116, 11481.598144065252, 11759.353235572125, 11783.941080294544, 11953.0, 11972.221805582958, 8425.115362886809, 8445.704400345958, 8706.56467176626, 8864.86702699447, 8887.466751994642, 11446.885531144582, 11486.36824974601, 11624.88375116238, 11769.705757356134, 11898.702532436759], "value": 10323.920369836946, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1238.2508582307703, 1398.6713122416231, 1418.9361478733456, 1436.3177490691917, 1444.64606171488, 10257.38455692658, 10692.305000174993, 10708.089812365939, 10710.982456666614, 10722.624708135218, 10174.18606511479, 10480.318779279341, 10485.947570262138, 10507.001834825698, 10510.00154985277, 2276.2715930902077, 2319.060780383947, 2320.234322673522, 2322.105989194164, 2330.475642980333, 2194.8353873459473, 2296.5292115116363, 2446.3394883381475, 2448.5470188015183, 2448.853068815868, 2045.4375046862083, 2124.8193903518218, 2126.138913739938, 2351.670766092748, 2446.4740080882607, 2424.781769640732, 2446.9510609787794, 2447.3514518652573, 2449.3386785567977, 2452.950940981188, 2397.7602239775883, 2407.277816655014, 2436.232586735173, 2436.3909022744315, 2436.488337449138, 10830.891691083067, 10922.017018468296, 10931.234813563055, 10948.45257737118, 10956.616518421817, 6183.752649893999, 6417.96791016042, 6421.101045853584, 6421.775237866652, 6427.485801135945, 3102.720755132049, 3874.3607304794673, 3976.1252524444576, 4017.738846974937, 4036.2734707752593, 1211.87881211879, 1235.5366737473448, 1248.3446190749928, 1251.3242848861694, 1268.0933132809994, 15049.398024079133, 15180.924095379563, 15184.848151518454, 15189.6202594936, 15276.847231527765, 5015.648904576645, 5136.280920671109, 5386.218998245311, 5404.162354835007, 5406.189071639285, 11375.0, 11376.0, 11403.486843092081, 11416.086713062936, 11431.142664300045, 6284.183056202664, 6295.307516173218, 6297.338779428185, 6298.7795427160745, 6304.684765761694, 5714.342850572154, 5733.598648094677, 5974.2233509643465, 6031.969840150771, 6057.7879774207695, 4075.572064933199, 4184.142250838631, 4200.327947528381, 4228.619424251832, 4265.829366825355, 1228.538990495928, 1236.190295356543, 1260.9684757880943, 1261.3377976562379, 1266.265565971734, 742.3986570877606, 745.1468069060895, 763.6868883757633, 769.9874664815861, 792.3265224559194, 5753.827385178452, 5834.212381328466, 5967.8209653710455, 6026.276846778414, 6066.969665151646, 553.9086050801573, 573.1259828761089, 585.9765609375662, 586.6653363597763, 588.0884628825304, 3609.6931760800103, 4213.978930105392, 4326.610605045498, 4357.542458041923, 4522.29904364824, 13196.538121165713, 13614.18314901109, 13634.1137826041, 13638.863611363959, 13645.181289122684, 10940.4529773511, 12929.224246545238, 13503.662408439672, 13523.120997135155, 13539.323033848465, 9766.462844543476, 10067.144292735053, 10072.597096116073, 10078.38745800683, 10084.294099412971, 6384.840378990562, 6388.64862432552, 6416.133821934166, 6657.0, 6696.1629796275465, 10440.0, 11660.708482288012, 12154.574589889666, 12443.502259909503, 12489.687757805765, 12280.631581052583, 12622.305773182563, 12628.558000469939, 12636.936815315865, 12642.620721378373, 9796.461194634363, 9860.753481163028, 10069.144122749356, 10078.697639070839, 10093.243006774375, 9743.269254805777, 9755.658551950648, 9863.802723945337, 9875.358101723365, 9880.110790028932, 8229.876551851607, 8594.183552562497, 8641.913580864111, 8725.825483490422, 8812.559372031501, 8303.875441868498, 8418.536980466133, 8463.66145354179, 8479.660813567389, 8524.573771311285, 7662.080550333995, 7726.845463090594, 7726.922730772845, 7809.687612495437, 7809.92190078092, 5881.794137205177, 5916.792912248051, 5931.13998470228, 5948.464638182584, 6026.487748541423, 4818.566329030404, 5983.640981541122, 5998.9100163496705, 6011.789587364421, 6040.456358927718], "value": 5062.596477251695, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [341.41106591130296, 389.42365299356953, 393.21161072050535, 398.26321305584656, 400.77957123582024, 4642.466116396616, 4851.53910378514, 5747.568932330071, 5768.798092066779, 5881.059030555112, 5204.661696989693, 5529.447055294469, 5636.4927156555905, 5713.914291285623, 5724.169995350682, 3352.0446672698286, 3979.2240513099955, 4098.692598055143, 4435.4899186593475, 4455.131249406367, 4208.494980602317, 4367.781610919441, 4369.519352871198, 4373.365861950016, 4380.787702210379, 3785.3943369060958, 4106.28140075487, 4225.112726327475, 4301.548337424557, 4302.612764851163, 3903.375459926398, 4262.445882035347, 4315.223259813232, 4335.674824388184, 4344.717593356453, 3237.5629290045777, 3729.9254014919547, 3771.6039815819217, 3772.490713753663, 3794.848206071754, 5604.131359639263, 5630.15547667849, 5673.6595804251465, 5675.0, 5686.943130568683, 4701.929471057937, 4797.136515427222, 5121.308623335876, 5145.8936328689515, 5184.351956005499, 4880.365552478191, 5082.898342033139, 6157.415045570709, 6202.968985155046, 6214.502839772853, 3811.4473401356927, 3863.9227215455817, 4233.767142807144, 4238.7032907696475, 4245.1934132514725, 6286.18279623646, 6447.742090316428, 6456.322086180978, 6540.4440622547145, 6619.602823830537, 3564.7148228141687, 3733.2720119576966, 3842.481265029241, 4185.288500954845, 4193.764298058983, 3969.226000929791, 4244.172386384687, 4352.412424322676, 4364.388985542027, 4370.628496577827, 4408.404865343202, 5074.619403544675, 5076.847694569169, 5081.18701007837, 5081.542661160439, 5971.760589778833, 6168.444839964424, 6199.783007594712, 6241.968790156111, 6251.59364641306, 1319.2480286236944, 1465.4138344662008, 1487.6206567325262, 1495.6859059597607, 1498.1535432480614, 939.915407613318, 980.5832521178471, 991.5290237137447, 998.3610489286863, 998.7852611688522, 4918.319515863863, 5789.8263052108505, 5795.667491192581, 5806.767729290781, 5824.835242801418, 6452.805861098693, 6455.903161452582, 6456.806295811133, 6461.709223084972, 6512.381323774234, 4406.30357312437, 4552.544745525421, 5522.66863988162, 5536.944630553723, 5782.88434231313, 2741.4517096580366, 3313.3042061166943, 3350.396928552835, 3363.983180084084, 3382.1713680148523, 6241.313455519889, 6264.248290205204, 6556.541042127005, 6654.26803051664, 6703.279679777673, 6055.7274922628585, 6576.145101136917, 6580.5581232667755, 6592.0, 6608.926849015231, 5273.3935597406025, 5443.673379597237, 5982.670953097621, 6358.268799088164, 6653.0, 5261.895241903269, 5352.4915133062295, 5662.575306852085, 6087.421694938974, 6466.612003279818, 5197.610179236497, 5497.312835895513, 6380.7447702091395, 6385.553011289165, 6419.743210271537, 6693.665316734046, 6703.463722902058, 6707.765228216989, 6717.010930136043, 6733.966330168318, 4085.142120154801, 4272.316429371285, 4291.120320334387, 4297.011687311999, 4313.61177494027, 5683.7442315095095, 6127.448529632176, 6418.935810641834, 6457.967710161419, 6509.837254068686, 5413.729313534386, 5846.532277417881, 6202.131701561875, 6206.224221972254, 6214.875702485834, 5435.673859568438, 6036.607620504653, 6175.857466368736, 6178.41305076017, 6243.500519958483, 5313.096773548584, 5884.35272120075, 6098.725557349841, 6099.9390006099375, 6107.816765497042, 5410.918836217538, 5897.882042359214, 6253.654294952179, 6254.6537602382505, 6286.717097730704, 5043.899122017466, 5295.099833028317, 5588.552915766811, 5811.418858114154, 6029.487493563096], "value": 4473.437311982028, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [797.5573556676046, 820.499495307862, 830.6843399508186, 834.3450391442718, 841.8148007438365, 15496.767548486781, 15800.288986995583, 16206.918965405172, 16538.173091345445, 16654.0, 14697.0, 15083.0, 15107.92446037771, 15259.626633602973, 15321.616959576017, 985.152768618989, 1000.2148313573846, 1007.6674697349857, 1010.151472762879, 1010.701842956326, 986.0238364019605, 1027.9280450368476, 1036.6319956415477, 1039.3036665434176, 1040.4537617750666, 1073.3559864081528, 1077.6605369308681, 1081.2971568480473, 1081.3890152064098, 1081.7674200046988, 1066.3814987307383, 1073.962411315608, 1074.462768615692, 1076.208986394999, 1077.0952399984012, 799.3365506629484, 804.5293503300576, 804.5333706450244, 805.5126648377706, 805.7179987004561, 16103.825983492196, 16489.010659360356, 16518.587035324093, 16528.66942661152, 16795.748063779054, 14483.42066317346, 14483.710325793425, 14495.202763847985, 14558.0, 14629.707405851823, 13275.60173194796, 13295.933520332434, 13397.799033014513, 13434.261115638734, 13559.25424101674, 2917.533194688861, 3301.1912081540177, 3360.815155166465, 3365.7980521168806, 3367.057223977266, 114743.42628286888, 114936.42531787371, 116511.0, 117554.0, 117640.41179794131, 11142.27575207609, 11269.323840569428, 11407.022626242579, 11532.962033417032, 11937.403129843473, 25079.749202508105, 25095.121670741435, 25122.0, 25153.993840246552, 25202.0, 7677.30904218623, 7754.224577542201, 7771.72798952034, 7802.414818888606, 8084.555349455836, 4102.118044620362, 4119.608637179464, 4188.706790524695, 4192.605262634553, 4239.792174827005, 4013.2174226025645, 4082.5305089914445, 4099.0, 4126.834926602963, 4147.688923330762, 755.5957562704037, 839.3075712537182, 849.7450764770545, 852.1265702654829, 852.194676031157, 613.2120225510198, 614.757170917494, 641.1952998986243, 644.6583310845259, 654.4241067860253, 9882.555285012191, 9995.300328977048, 10046.146077583488, 10175.421209117938, 10229.539670714836, 584.6375247346588, 602.5059451249933, 617.7251123250201, 642.8425035866243, 653.349916832745, 4602.194615942197, 4615.5845973862515, 4618.699784513996, 4621.5378462154185, 4712.31671407644, 98857.0, 100226.0, 100480.99038019199, 103608.0, 104252.0, 88056.559717201, 88319.55840220758, 88580.0, 88749.0, 89152.0, 69666.60666786636, 72849.0, 74557.88163177557, 74578.25421745822, 77610.0, 8675.175858293453, 10946.94924740338, 10982.725431864268, 10983.890161098287, 10998.560057597926, 30220.0, 37262.0, 37482.812585936896, 37609.43585846269, 37731.62268377281, 47626.04747905092, 57908.4209157903, 65820.34179658142, 66796.0, 66852.665736671, 13180.406881690154, 13375.799363009368, 13463.865361346261, 13555.728885422433, 13781.95080931282, 11753.412329383667, 14028.605954951741, 14297.714045719236, 14332.0, 14365.0, 13448.731025379633, 13499.595012149652, 13507.257100859548, 13562.254076025913, 13607.863921361055, 13311.33443327849, 13492.730145397234, 13835.723285534434, 14460.855391445952, 14546.85453145455, 13339.733205336033, 13378.880142581162, 13731.794023089462, 13792.0, 13825.446982120602, 9606.66376676813, 10208.438535880598, 10286.588536458457, 10758.139348851917, 10778.784424311312, 10495.632652857113, 11268.436578171222, 11543.928354885762, 11616.361100139573, 11641.0], "value": 7777.972241438683, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1578.5999999999997, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 121.0, 123.0, 123.0, 122.0, 123.0, 122.0, 121.0, 124.0, 122.0], "value": 121.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 147.0, 153.0, 182.0, 120.0, 125.0, 115.0, 116.0, 141.0, 115.0], "value": 137.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [212.0, 211.0, 214.0, 215.0, 213.0, 211.0, 208.0, 213.0, 210.0, 212.0], "value": 211.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 60.0, 77.0, 125.0, 64.0, 61.0, 65.0, 90.0, 98.0, 95.0], "value": 81.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 76.0, 96.0, 76.0, 75.0, 73.0, 90.0, 73.0, 75.0, 91.0], "value": 82.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 91.0, 91.0, 89.0, 90.0, 90.0, 90.0, 94.0, 90.0, 90.0], "value": 90.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [98.0, 99.0, 99.0, 99.0, 99.0, 99.0, 98.0, 99.0, 98.0, 100.0], "value": 98.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 135.0, 101.0, 103.0, 146.0, 135.0, 100.0, 101.0, 101.0, 101.0], "value": 116.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 50.0, 49.0, 49.0, 51.0, 53.0, 52.0, 52.0, 50.0, 50.0], "value": 50.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 64.0, 72.0, 70.0, 69.0, 65.0, 64.0, 64.0, 62.0, 63.0], "value": 65.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 86.0, 92.0, 88.0, 86.0, 92.0, 88.0, 88.0, 90.0, 89.0], "value": 89.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 153.0, 149.0, 158.0, 151.0, 168.0, 171.0, 169.0, 186.0, 170.0], "value": 162.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [189.0, 199.0, 200.0, 198.0, 198.0, 199.0, 204.0, 199.0, 198.0, 199.0], "value": 198.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 73.0, 73.0, 72.0, 72.0, 72.0, 72.0, 73.0, 74.0, 73.0], "value": 72.5, "unit": "score"}]}]} 13:35:14 INFO - Return code: 0 13:35:14 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 13:35:14 ERROR - # TBPL SUCCESS # 13:35:14 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 13:35:14 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 13:35:14 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 13:35:14 INFO - 2017-04-04 13:35:14.616 screenresolution[1654:9827] starting screenresolution argv=screenresolution get 13:35:14 INFO - 2017-04-04 13:35:14.618 screenresolution[1654:9827] Display 0: 1600x1200x32@60 13:35:14 INFO - 2017-04-04 13:35:14.625 screenresolution[1655:9830] starting screenresolution argv=screenresolution list 13:35:14 INFO - Available Modes on Display 0 13:35:14 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 13:35:14 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 13:35:14 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 13:35:14 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 13:35:14 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 13:35:14 INFO - Intel Iris: 13:35:14 INFO - Chipset Model: Intel Iris 13:35:14 INFO - Type: GPU 13:35:14 INFO - Bus: Built-In 13:35:14 INFO - VRAM (Dynamic, Max): 1536 MB 13:35:14 INFO - Vendor: Intel (0x8086) 13:35:14 INFO - Device ID: 0x0a2e 13:35:14 INFO - Revision ID: 0x0009 13:35:14 INFO - Displays: 13:35:14 INFO - Display: 13:35:14 INFO - Resolution: 1600 x 1200 @ 60 Hz 13:35:14 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 13:35:14 INFO - Display Serial Number: 1600x1200 60 13:35:14 INFO - Main Display: Yes 13:35:14 INFO - Mirror: Off 13:35:14 INFO - Online: Yes 13:35:14 INFO - Rotation: Supported 13:35:14 INFO - Return code: 0 13:35:14 INFO - Running post-action listener: _resource_record_post_action 13:35:14 INFO - [mozharness: 2017-04-04 20:35:14.863905Z] Finished run-tests step (success) 13:35:14 INFO - Running post-run listener: _resource_record_post_run 13:35:14 INFO - Total resource usage - Wall time: 1204s; CPU: 53.0%; Read bytes: 39134208; Write bytes: 513814528; Read time: 380; Write time: 1592 13:35:14 INFO - TinderboxPrint: CPU usage
53.4% 13:35:14 INFO - TinderboxPrint: I/O read bytes / time
39,134,208 / 380 13:35:14 INFO - TinderboxPrint: I/O write bytes / time
513,814,528 / 1,592 13:35:14 INFO - TinderboxPrint: CPU idle
2,246.6 (46.6%) 13:35:14 INFO - TinderboxPrint: CPU system
959.9 (19.9%) 13:35:14 INFO - TinderboxPrint: CPU user
1,611.2 (33.4%) 13:35:14 INFO - TinderboxPrint: Swap in / out
264,589,312 / 0 13:35:14 INFO - install - Wall time: 20s; CPU: 54.0%; Read bytes: 207374848; Write bytes: 204588544; Read time: 15651; Write time: 425 13:35:14 INFO - run-tests - Wall time: 1184s; CPU: 53.0%; Read bytes: 37123072; Write bytes: 298359296; Read time: 358; Write time: 1109 13:35:15 INFO - Running post-run listener: _upload_blobber_files 13:35:15 INFO - Blob upload gear active. 13:35:15 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 13:35:15 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 13:35:15 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', 'Pine', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 13:35:15 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 Pine -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 13:35:15 INFO - (blobuploader) - INFO - Open directory for files ... 13:35:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 13:35:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:35:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:35:16 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 13:35:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:35:16 INFO - (blobuploader) - INFO - Done attempting. 13:35:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 13:35:16 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:35:16 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:35:17 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 13:35:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:35:17 INFO - (blobuploader) - INFO - Done attempting. 13:35:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 13:35:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:35:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:35:18 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 13:35:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:35:18 INFO - (blobuploader) - INFO - Done attempting. 13:35:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 13:35:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:35:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:35:21 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 13:35:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:35:21 INFO - (blobuploader) - INFO - Done attempting. 13:35:21 INFO - (blobuploader) - INFO - Iteration through files over. 13:35:21 INFO - Return code: 0 13:35:21 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 13:35:21 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 13:35:21 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Pine/sha512/ddcff7ae0b0fdecf2aedcc992dd3b201777e1469b5292a850afa49f584086235966f587bd257ee82455bbfb4370a4bb19d8fccf750778f97b07a948bd0819274", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Pine/sha512/3108a65ae64025d31d681b72c5067cb95b035751720f576a167a66aa00f6eaddd829dd8eae31082ca5bc5bf96a87fc2f2ae2a970bb775fa970ba57ea96f0732f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Pine/sha512/968eb601e8bf16bbcf858c7339ddba29ac4d03cfd667ad3a7b853519767ccf46859a7cc09cba1d81def1f69dc73cf9e5928628c28c2dc80c28c1d416dcc80c94", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Pine/sha512/3ef1cbd389e7a968ec0db48b2b2fe64b77bb20e80c0f6ffa02157af5bcecc6cf6a8b870b840d881f275dd4341e2db7f94f3364eac99ff50f48ac0de8f7693308"} 13:35:21 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 13:35:21 INFO - Writing to file /builds/slave/test/properties/blobber_files 13:35:21 INFO - Contents: 13:35:21 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Pine/sha512/ddcff7ae0b0fdecf2aedcc992dd3b201777e1469b5292a850afa49f584086235966f587bd257ee82455bbfb4370a4bb19d8fccf750778f97b07a948bd0819274", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Pine/sha512/3108a65ae64025d31d681b72c5067cb95b035751720f576a167a66aa00f6eaddd829dd8eae31082ca5bc5bf96a87fc2f2ae2a970bb775fa970ba57ea96f0732f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Pine/sha512/968eb601e8bf16bbcf858c7339ddba29ac4d03cfd667ad3a7b853519767ccf46859a7cc09cba1d81def1f69dc73cf9e5928628c28c2dc80c28c1d416dcc80c94", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Pine/sha512/3ef1cbd389e7a968ec0db48b2b2fe64b77bb20e80c0f6ffa02157af5bcecc6cf6a8b870b840d881f275dd4341e2db7f94f3364eac99ff50f48ac0de8f7693308"} 13:35:21 INFO - Running post-run listener: copy_logs_to_upload_dir 13:35:21 INFO - Copying logs to upload dir... 13:35:21 INFO - mkdir: /builds/slave/test/build/upload/logs 13:35:21 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1287.198272 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 27 secs) (at 2017-04-04 13:35:21.215198) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-04 13:35:21.218861) ========= 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.sFkzJEaMMa/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.HrPS7bVRC0/Listeners TMPDIR=/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/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/Pine/sha512/ddcff7ae0b0fdecf2aedcc992dd3b201777e1469b5292a850afa49f584086235966f587bd257ee82455bbfb4370a4bb19d8fccf750778f97b07a948bd0819274", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Pine/sha512/3108a65ae64025d31d681b72c5067cb95b035751720f576a167a66aa00f6eaddd829dd8eae31082ca5bc5bf96a87fc2f2ae2a970bb775fa970ba57ea96f0732f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Pine/sha512/968eb601e8bf16bbcf858c7339ddba29ac4d03cfd667ad3a7b853519767ccf46859a7cc09cba1d81def1f69dc73cf9e5928628c28c2dc80c28c1d416dcc80c94", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Pine/sha512/3ef1cbd389e7a968ec0db48b2b2fe64b77bb20e80c0f6ffa02157af5bcecc6cf6a8b870b840d881f275dd4341e2db7f94f3364eac99ff50f48ac0de8f7693308"} build_url:https://queue.taskcluster.net/v1/task/d4iKk8LgRCqYM8jbxQZwcQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011187 build_url: 'https://queue.taskcluster.net/v1/task/d4iKk8LgRCqYM8jbxQZwcQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Pine/sha512/ddcff7ae0b0fdecf2aedcc992dd3b201777e1469b5292a850afa49f584086235966f587bd257ee82455bbfb4370a4bb19d8fccf750778f97b07a948bd0819274", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Pine/sha512/3108a65ae64025d31d681b72c5067cb95b035751720f576a167a66aa00f6eaddd829dd8eae31082ca5bc5bf96a87fc2f2ae2a970bb775fa970ba57ea96f0732f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Pine/sha512/968eb601e8bf16bbcf858c7339ddba29ac4d03cfd667ad3a7b853519767ccf46859a7cc09cba1d81def1f69dc73cf9e5928628c28c2dc80c28c1d416dcc80c94", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Pine/sha512/3ef1cbd389e7a968ec0db48b2b2fe64b77bb20e80c0f6ffa02157af5bcecc6cf6a8b870b840d881f275dd4341e2db7f94f3364eac99ff50f48ac0de8f7693308"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-04 13:35:21.258249) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-04 13:35:21.259007) ========= 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.sFkzJEaMMa/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.HrPS7bVRC0/Listeners TMPDIR=/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/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.005164 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-04 13:35:21.308332) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-04 13:35:21.308697) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-04 13:35:21.309026) ========= ========= Total master_lag: 0.19 =========