builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0082 starttime: 1482076833.17 results: success (0) buildid: 20161218064235 builduid: 104c04687f884ea1b57956d636e12f71 revision: 2824deb82146bba070995a762cfc98ddb2d1decb ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-12-18 08:00:33.169198) ========= master: http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-12-18 08:00:33.169665) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-18 08:00:33.169953) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-18 08:00:33.354041) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-18 08:00:33.354323) ========= 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.9Ap333bYcz/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.4vSwSpYsC7/Listeners TMPDIR=/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/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 --2016-12-18 08:00:33-- 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% 14.2M=0.001s 2016-12-18 08:00:33 (14.2 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.136481 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-18 08:00:33.535550) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-18 08:00:33.535881) ========= 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.9Ap333bYcz/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.4vSwSpYsC7/Listeners TMPDIR=/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/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.019756 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-18 08:00:33.598897) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-12-18 08:00:33.602260) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 2824deb82146bba070995a762cfc98ddb2d1decb --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 2824deb82146bba070995a762cfc98ddb2d1decb --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.9Ap333bYcz/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.4vSwSpYsC7/Listeners TMPDIR=/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/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 2016-12-18 08:00:33,697 truncating revision to first 12 chars 2016-12-18 08:00:33,697 Setting DEBUG logging. 2016-12-18 08:00:33,697 attempt 1/10 2016-12-18 08:00:33,697 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/2824deb82146?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-12-18 08:00:34,958 unpacking tar archive at: mozilla-central-2824deb82146/testing/mozharness/ program finished with exit code 0 elapsedTime=1.517956 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-12-18 08:00:35.143762) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-18 08:00:35.147111) ========= script_repo_revision: 2824deb82146bba070995a762cfc98ddb2d1decb ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-18 08:00:35.147520) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-18 08:00:35.147796) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-18 08:00:35.168518) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 5 secs) (at 2016-12-18 08:00:35.168795) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.9Ap333bYcz/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.4vSwSpYsC7/Listeners TMPDIR=/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/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 08:00:35 INFO - MultiFileLogger online at 20161218 08:00:35 in /builds/slave/test 08:00:35 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 08:00:35 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:00:35 INFO - {'append_to_log': False, 08:00:35 INFO - 'base_work_dir': '/builds/slave/test', 08:00:35 INFO - 'blob_upload_branch': 'Firefox', 08:00:35 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:00:35 INFO - 'branch': 'Firefox', 08:00:35 INFO - 'buildbot_json_path': 'buildprops.json', 08:00:35 INFO - 'config_files': ('talos/mac_config.py',), 08:00:35 INFO - 'default_actions': ('clobber', 08:00:35 INFO - 'read-buildbot-config', 08:00:35 INFO - 'download-and-extract', 08:00:35 INFO - 'populate-webroot', 08:00:35 INFO - 'create-virtualenv', 08:00:35 INFO - 'install', 08:00:35 INFO - 'run-tests'), 08:00:35 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:00:35 INFO - 'download_minidump_stackwalk': True, 08:00:35 INFO - 'download_symbols': 'ondemand', 08:00:35 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:00:35 INFO - 'tooltool.py': '/tools/tooltool.py', 08:00:35 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:00:35 INFO - '/tools/misc-python/virtualenv.py')}, 08:00:35 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:00:35 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:00:35 INFO - 'installer_path': 'installer.exe', 08:00:35 INFO - 'log_level': 'info', 08:00:35 INFO - 'log_name': 'talos', 08:00:35 INFO - 'log_to_console': True, 08:00:35 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 08:00:35 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 08:00:35 INFO - 'opt_config_files': (), 08:00:35 INFO - 'pip_index': False, 08:00:35 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 08:00:35 INFO - 'cmd': ('bash', 08:00:35 INFO - '-c', 08:00:35 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 08:00:35 INFO - 'enabled': True, 08:00:35 INFO - 'halt_on_failure': False, 08:00:35 INFO - 'name': 'check_screen_resolution'},), 08:00:35 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 08:00:35 INFO - 'cmd': ('bash', 08:00:35 INFO - '-c', 08:00:35 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 08:00:35 INFO - 'enabled': True, 08:00:35 INFO - 'halt_on_failure': False, 08:00:35 INFO - 'name': 'check_screen_resolution'},), 08:00:35 INFO - 'run_cmd_checks_enabled': True, 08:00:35 INFO - 'sps_profile': False, 08:00:35 INFO - 'sps_profile_interval': 0, 08:00:35 INFO - 'suite': 'dromaeojs', 08:00:35 INFO - 'system_bits': '32', 08:00:35 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:00:35 INFO - 'title': 't-yosemite-r7-0082', 08:00:35 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:00:35 INFO - 'use_talos_json': True, 08:00:35 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:00:35 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:00:35 INFO - 'work_dir': 'build'} 08:00:35 INFO - [mozharness: 2016-12-18 16:00:35.391612Z] Running clobber step. 08:00:35 INFO - Running pre-action listener: _resource_record_pre_action 08:00:35 INFO - Running main action method: clobber 08:00:35 INFO - rmtree: /builds/slave/test/build 08:00:35 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:00:36 INFO - Running post-action listener: _resource_record_post_action 08:00:36 INFO - [mozharness: 2016-12-18 16:00:36.950470Z] Finished clobber step (success) 08:00:36 INFO - [mozharness: 2016-12-18 16:00:36.950698Z] Running read-buildbot-config step. 08:00:36 INFO - Running pre-action listener: _resource_record_pre_action 08:00:36 INFO - Running main action method: read_buildbot_config 08:00:36 INFO - Using buildbot properties: 08:00:36 INFO - { 08:00:36 INFO - "project": "", 08:00:36 INFO - "product": "firefox", 08:00:36 INFO - "script_repo_revision": "production", 08:00:36 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 08:00:36 INFO - "repository": "", 08:00:36 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 08:00:36 INFO - "buildid": "20161218064235", 08:00:36 INFO - "pgo_build": "False", 08:00:36 INFO - "basedir": "/builds/slave/test", 08:00:36 INFO - "buildnumber": 33, 08:00:36 INFO - "slavename": "t-yosemite-r7-0082", 08:00:36 INFO - "master": "http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/", 08:00:36 INFO - "platform": "yosemite_r7", 08:00:36 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 08:00:36 INFO - "branch": "mozilla-central", 08:00:36 INFO - "repo_path": "mozilla-central", 08:00:36 INFO - "revision": "2824deb82146bba070995a762cfc98ddb2d1decb", 08:00:36 INFO - "stage_platform": "macosx64", 08:00:36 INFO - "builduid": "104c04687f884ea1b57956d636e12f71", 08:00:36 INFO - "slavebuilddir": "test" 08:00:36 INFO - } 08:00:36 INFO - Found installer url https://queue.taskcluster.net/v1/task/LxqZjBktTqumWn3nkUrvRg/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg. 08:00:36 INFO - Running post-action listener: _resource_record_post_action 08:00:36 INFO - [mozharness: 2016-12-18 16:00:36.955266Z] Finished read-buildbot-config step (success) 08:00:36 INFO - [mozharness: 2016-12-18 16:00:36.955404Z] Running download-and-extract step. 08:00:36 INFO - Running pre-action listener: _resource_record_pre_action 08:00:36 INFO - Running main action method: download_and_extract 08:00:36 INFO - mkdir: /builds/slave/test/build/tests 08:00:36 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')]} 08:00:36 INFO - trying https://queue.taskcluster.net/v1/task/LxqZjBktTqumWn3nkUrvRg/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json 08:00:36 INFO - Downloading https://queue.taskcluster.net/v1/task/LxqZjBktTqumWn3nkUrvRg/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json 08:00:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/LxqZjBktTqumWn3nkUrvRg/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json'}, attempt #1 08:00:38 INFO - Downloaded 1199 bytes. 08:00:38 INFO - Reading from file /builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json 08:00:38 INFO - Using the following test package requirements: 08:00:38 INFO - {u'common': [u'firefox-53.0a1.en-US.mac.common.tests.zip'], 08:00:38 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 08:00:38 INFO - u'firefox-53.0a1.en-US.mac.cppunittest.tests.zip'], 08:00:38 INFO - u'gtest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 08:00:38 INFO - u'firefox-53.0a1.en-US.mac.gtest.tests.zip'], 08:00:38 INFO - u'jittest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 08:00:38 INFO - u'jsshell-mac.zip'], 08:00:38 INFO - u'mochitest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 08:00:38 INFO - u'firefox-53.0a1.en-US.mac.mochitest.tests.zip'], 08:00:38 INFO - u'mozbase': [u'firefox-53.0a1.en-US.mac.common.tests.zip'], 08:00:38 INFO - u'reftest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 08:00:38 INFO - u'firefox-53.0a1.en-US.mac.reftest.tests.zip'], 08:00:38 INFO - u'talos': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 08:00:38 INFO - u'firefox-53.0a1.en-US.mac.talos.tests.zip'], 08:00:38 INFO - u'web-platform': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 08:00:38 INFO - u'firefox-53.0a1.en-US.mac.web-platform.tests.zip'], 08:00:38 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 08:00:38 INFO - u'firefox-53.0a1.en-US.mac.xpcshell.tests.zip']} 08:00:38 INFO - Downloading packages: [u'firefox-53.0a1.en-US.mac.common.tests.zip'] for test suite category: common 08:00:38 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/LxqZjBktTqumWn3nkUrvRg/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip 08:00:38 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/LxqZjBktTqumWn3nkUrvRg/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip'}, attempt #1 08:00:38 INFO - Fetch https://queue.taskcluster.net/v1/task/LxqZjBktTqumWn3nkUrvRg/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip into memory 08:00:39 INFO - Expected file size: 16275300 08:00:39 INFO - Obtained file size: 16275300 08:00:45 INFO - Downloading packages: [u'firefox-53.0a1.en-US.mac.common.tests.zip', u'firefox-53.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 08:00:45 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/LxqZjBktTqumWn3nkUrvRg/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip 08:00:45 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/LxqZjBktTqumWn3nkUrvRg/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip'}, attempt #1 08:00:45 INFO - Fetch https://queue.taskcluster.net/v1/task/LxqZjBktTqumWn3nkUrvRg/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip into memory 08:00:46 INFO - Expected file size: 16275300 08:00:46 INFO - Obtained file size: 16275300 08:00:53 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/LxqZjBktTqumWn3nkUrvRg/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip 08:00:53 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/LxqZjBktTqumWn3nkUrvRg/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip'}, attempt #1 08:00:53 INFO - Fetch https://queue.taskcluster.net/v1/task/LxqZjBktTqumWn3nkUrvRg/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip into memory 08:00:55 INFO - Expected file size: 14409734 08:00:55 INFO - Obtained file size: 14409734 08:00:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:00:55 INFO - trying https://queue.taskcluster.net/v1/task/LxqZjBktTqumWn3nkUrvRg/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 08:00:55 INFO - Downloading https://queue.taskcluster.net/v1/task/LxqZjBktTqumWn3nkUrvRg/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg 08:00:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/LxqZjBktTqumWn3nkUrvRg/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg'}, attempt #1 08:00:57 INFO - Downloaded 69571905 bytes. 08:00:57 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/LxqZjBktTqumWn3nkUrvRg/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 08:00:57 INFO - mkdir: /builds/slave/test/properties 08:00:57 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:00:57 INFO - Writing to file /builds/slave/test/properties/build_url 08:00:57 INFO - Contents: 08:00:57 INFO - build_url:https://queue.taskcluster.net/v1/task/LxqZjBktTqumWn3nkUrvRg/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 08:00:58 INFO - Running post-action listener: _resource_record_post_action 08:00:58 INFO - Running post-action listener: set_extra_try_arguments 08:00:58 INFO - [mozharness: 2016-12-18 16:00:58.622049Z] Finished download-and-extract step (success) 08:00:58 INFO - [mozharness: 2016-12-18 16:00:58.622205Z] Running populate-webroot step. 08:00:58 INFO - Running pre-action listener: _resource_record_pre_action 08:00:58 INFO - Running main action method: populate_webroot 08:00:58 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:00:58 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:00:58 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:00:58 INFO - '--tppagecycles', 08:00:58 INFO - '7'], 08:00:58 INFO - 'tests': ['tsvgm']}}, 08:00:58 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:00:58 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:00:58 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:00:58 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:00:58 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:00:58 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:00:58 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 08:00:58 INFO - 'talos_options': ['--disable-e10s'], 08:00:58 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:00:58 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 08:00:58 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:00:58 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 08:00:58 INFO - 'talos_options': ['--disable-e10s'], 08:00:58 INFO - 'tests': ['damp', 'tps']}, 08:00:58 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 08:00:58 INFO - 'tests': ['damp', 'tps']}, 08:00:58 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:00:58 INFO - 'tests': ['dromaeo_dom']}, 08:00:58 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:00:58 INFO - 'g4': {'talos_options': ['--disable-e10s'], 08:00:58 INFO - 'tests': ['basic_compositor_video']}, 08:00:58 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 08:00:58 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:00:58 INFO - 'tests': ['a11yr', 08:00:58 INFO - 'ts_paint', 08:00:58 INFO - 'tpaint', 08:00:58 INFO - 'sessionrestore', 08:00:58 INFO - 'sessionrestore_no_auto_restore', 08:00:58 INFO - 'tabpaint']}, 08:00:58 INFO - 'other-e10s': {'tests': ['a11yr', 08:00:58 INFO - 'ts_paint', 08:00:58 INFO - 'tpaint', 08:00:58 INFO - 'sessionrestore', 08:00:58 INFO - 'sessionrestore_no_auto_restore', 08:00:58 INFO - 'tabpaint']}, 08:00:58 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:00:58 INFO - 'ts_paint', 08:00:58 INFO - 'tpaint', 08:00:58 INFO - 'sessionrestore', 08:00:58 INFO - 'sessionrestore_no_auto_restore', 08:00:58 INFO - 'tabpaint']}, 08:00:58 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:00:58 INFO - 'ts_paint', 08:00:58 INFO - 'tpaint', 08:00:58 INFO - 'sessionrestore', 08:00:58 INFO - 'sessionrestore_no_auto_restore', 08:00:58 INFO - 'tabpaint']}, 08:00:58 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:00:58 INFO - 'tests': ['a11yr', 08:00:58 INFO - 'ts_paint', 08:00:58 INFO - 'tpaint', 08:00:58 INFO - 'sessionrestore', 08:00:58 INFO - 'sessionrestore_no_auto_restore', 08:00:58 INFO - 'tabpaint']}, 08:00:58 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:00:58 INFO - 'tests': ['a11yr', 08:00:58 INFO - 'ts_paint', 08:00:58 INFO - 'tpaint', 08:00:58 INFO - 'sessionrestore', 08:00:58 INFO - 'sessionrestore_no_auto_restore', 08:00:58 INFO - 'tabpaint']}, 08:00:58 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:00:58 INFO - 'tests': ['tsvgx', 08:00:58 INFO - 'tsvgr_opacity', 08:00:58 INFO - 'tart', 08:00:58 INFO - 'tscrollx', 08:00:58 INFO - 'cart', 08:00:58 INFO - 'tsvg_static']}, 08:00:58 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:00:58 INFO - 'tsvgr_opacity', 08:00:58 INFO - 'tart', 08:00:58 INFO - 'tscrollx', 08:00:58 INFO - 'cart', 08:00:58 INFO - 'tsvg_static']}, 08:00:58 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 08:00:58 INFO - 'talos_options': ['--disable-e10s'], 08:00:58 INFO - 'tests': ['tp5o']}, 08:00:58 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 08:00:58 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 08:00:58 INFO - 'talos_options': ['--disable-e10s', 08:00:58 INFO - '--xperf_path', 08:00:58 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:00:58 INFO - 'tests': ['tp5n']}, 08:00:58 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 08:00:58 INFO - 'talos_options': ['--xperf_path', 08:00:58 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:00:58 INFO - 'tests': ['tp5n']}}, 08:00:58 INFO - 'talos.zip': {'path': '', 08:00:58 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:00:58 INFO - Running post-action listener: _resource_record_post_action 08:00:58 INFO - [mozharness: 2016-12-18 16:00:58.640808Z] Finished populate-webroot step (success) 08:00:58 INFO - [mozharness: 2016-12-18 16:00:58.640918Z] Running create-virtualenv step. 08:00:58 INFO - Running pre-action listener: _resource_record_pre_action 08:00:58 INFO - Running main action method: create_virtualenv 08:00:58 INFO - Creating virtualenv /builds/slave/test/build/venv 08:00:58 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 08:00:58 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:00:58 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:00:58 INFO - Using real prefix '/tools/python27' 08:00:58 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:00:59 INFO - Installing distribute.............................................................................................................................................................................................done. 08:01:02 INFO - Installing pip.................done. 08:01:02 INFO - Return code: 0 08:01:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 08:01:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 08:01:02 INFO - Reading from file tmpfile_stdout 08:01:02 INFO - Output received: 08:01:02 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) 08:01:02 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:01:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:01:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:01:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:01:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:01:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:01:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:01:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x100b13b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100b16768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd070575f40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1008f1d30>, '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 0x100818db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1008e6be8>, '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.9Ap333bYcz/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.4vSwSpYsC7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/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 08:01:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 08:01:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 08:01:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.9Ap333bYcz/Render', 08:01:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:01:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:01:02 INFO - 'HOME': '/Users/cltbld', 08:01:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:01:02 INFO - 'LOGNAME': 'cltbld', 08:01:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:01:02 INFO - 'MOZ_NO_REMOTE': '1', 08:01:02 INFO - 'NO_EM_RESTART': '1', 08:01:02 INFO - 'PAGER': '/bin/cat', 08:01:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:01:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:01:02 INFO - 'PWD': '/builds/slave/test', 08:01:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:01:02 INFO - 'SHELL': '/bin/bash', 08:01:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4vSwSpYsC7/Listeners', 08:01:02 INFO - 'TMPDIR': '/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/', 08:01:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:01:02 INFO - 'USER': 'cltbld', 08:01:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:01:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:01:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:01:02 INFO - 'XPC_FLAGS': '0x0', 08:01:02 INFO - 'XPC_SERVICE_NAME': '0', 08:01:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:01:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:01:02 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 08:01:02 INFO - Cleaning up... 08:01:03 INFO - Return code: 0 08:01:03 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:01:03 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')]} 08:01:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:01:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:01:03 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')]} 08:01:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:01:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:01:03 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 0x100b13b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100b16768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd070575f40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1008f1d30>, '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 0x100818db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1008e6be8>, '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.9Ap333bYcz/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.4vSwSpYsC7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/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 08:01:03 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 08:01:03 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 08:01:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.9Ap333bYcz/Render', 08:01:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:01:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:01:03 INFO - 'HOME': '/Users/cltbld', 08:01:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:01:03 INFO - 'LOGNAME': 'cltbld', 08:01:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:01:03 INFO - 'MOZ_NO_REMOTE': '1', 08:01:03 INFO - 'NO_EM_RESTART': '1', 08:01:03 INFO - 'PAGER': '/bin/cat', 08:01:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:01:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:01:03 INFO - 'PWD': '/builds/slave/test', 08:01:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:01:03 INFO - 'SHELL': '/bin/bash', 08:01:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4vSwSpYsC7/Listeners', 08:01:03 INFO - 'TMPDIR': '/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/', 08:01:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:01:03 INFO - 'USER': 'cltbld', 08:01:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:01:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:01:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:01:03 INFO - 'XPC_FLAGS': '0x0', 08:01:03 INFO - 'XPC_SERVICE_NAME': '0', 08:01:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:01:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:01:03 INFO - Downloading/unpacking psutil>=3.1.1 08:01:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:01:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:01:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:01:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:01:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:01:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:01:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:01:07 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:01:07 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:01:07 INFO - Installing collected packages: psutil 08:01:07 INFO - Running setup.py install for psutil 08:01:07 INFO - building 'psutil._psutil_osx' extension 08:01:07 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 08:01:07 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 08:01:07 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 08:01:07 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 08:01:07 INFO - building 'psutil._psutil_posix' extension 08:01:07 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 08:01:07 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 08:01:07 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 08:01:07 INFO - ^ 08:01:07 INFO - 1 warning generated. 08:01:07 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 08:01:07 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:01:07 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:01:07 INFO - Successfully installed psutil 08:01:07 INFO - Cleaning up... 08:01:08 INFO - Return code: 0 08:01:08 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:01:08 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')]} 08:01:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:01:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:01:08 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')]} 08:01:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:01:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:01:08 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 0x100b13b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100b16768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd070575f40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1008f1d30>, '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 0x100818db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1008e6be8>, '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.9Ap333bYcz/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.4vSwSpYsC7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/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 08:01:08 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 08:01:08 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 08:01:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.9Ap333bYcz/Render', 08:01:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:01:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:01:08 INFO - 'HOME': '/Users/cltbld', 08:01:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:01:08 INFO - 'LOGNAME': 'cltbld', 08:01:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:01:08 INFO - 'MOZ_NO_REMOTE': '1', 08:01:08 INFO - 'NO_EM_RESTART': '1', 08:01:08 INFO - 'PAGER': '/bin/cat', 08:01:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:01:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:01:08 INFO - 'PWD': '/builds/slave/test', 08:01:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:01:08 INFO - 'SHELL': '/bin/bash', 08:01:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4vSwSpYsC7/Listeners', 08:01:08 INFO - 'TMPDIR': '/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/', 08:01:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:01:08 INFO - 'USER': 'cltbld', 08:01:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:01:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:01:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:01:08 INFO - 'XPC_FLAGS': '0x0', 08:01:08 INFO - 'XPC_SERVICE_NAME': '0', 08:01:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:01:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:01:08 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:01:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:01:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:01:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:01:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:01:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:01:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:01:10 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:01:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:01:10 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:01:10 INFO - Installing collected packages: mozsystemmonitor 08:01:10 INFO - Running setup.py install for mozsystemmonitor 08:01:11 INFO - Successfully installed mozsystemmonitor 08:01:11 INFO - Cleaning up... 08:01:11 INFO - Return code: 0 08:01:11 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:01:11 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')]} 08:01:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:01:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:01:11 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')]} 08:01:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:01:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:01:11 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 0x100b13b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100b16768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd070575f40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1008f1d30>, '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 0x100818db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1008e6be8>, '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.9Ap333bYcz/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.4vSwSpYsC7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/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 08:01:11 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 08:01:11 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 08:01:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.9Ap333bYcz/Render', 08:01:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:01:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:01:11 INFO - 'HOME': '/Users/cltbld', 08:01:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:01:11 INFO - 'LOGNAME': 'cltbld', 08:01:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:01:11 INFO - 'MOZ_NO_REMOTE': '1', 08:01:11 INFO - 'NO_EM_RESTART': '1', 08:01:11 INFO - 'PAGER': '/bin/cat', 08:01:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:01:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:01:11 INFO - 'PWD': '/builds/slave/test', 08:01:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:01:11 INFO - 'SHELL': '/bin/bash', 08:01:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4vSwSpYsC7/Listeners', 08:01:11 INFO - 'TMPDIR': '/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/', 08:01:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:01:11 INFO - 'USER': 'cltbld', 08:01:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:01:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:01:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:01:11 INFO - 'XPC_FLAGS': '0x0', 08:01:11 INFO - 'XPC_SERVICE_NAME': '0', 08:01:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:01:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:01:11 INFO - Downloading/unpacking jsonschema==2.5.1 08:01:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:01:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:01:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:01:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:01:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:01:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:01:14 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:01:14 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:01:14 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 08:01:14 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 08:01:14 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 08:01:14 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 08:01:14 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 08:01:14 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 08:01:14 INFO - Downloading functools32-3.2.3-2.tar.gz 08:01:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:01:14 INFO - warning: no files found matching '*.txt' 08:01:14 INFO - no previously-included directories found matching 'build' 08:01:14 INFO - no previously-included directories found matching 'dist' 08:01:14 INFO - no previously-included directories found matching '.git*' 08:01:14 INFO - Installing collected packages: jsonschema, functools32 08:01:14 INFO - Running setup.py install for functools32 08:01:14 INFO - warning: no files found matching '*.txt' 08:01:14 INFO - no previously-included directories found matching 'build' 08:01:14 INFO - no previously-included directories found matching 'dist' 08:01:14 INFO - no previously-included directories found matching '.git*' 08:01:14 INFO - Successfully installed jsonschema functools32 08:01:14 INFO - Cleaning up... 08:01:14 INFO - Return code: 0 08:01:14 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 08:01:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:01:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:01:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:01:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:01:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:01:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:01:14 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x100b13b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100b16768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd070575f40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1008f1d30>, '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 0x100818db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1008e6be8>, '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.9Ap333bYcz/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.4vSwSpYsC7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/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 08:01:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 08:01:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 08:01:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.9Ap333bYcz/Render', 08:01:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:01:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:01:14 INFO - 'HOME': '/Users/cltbld', 08:01:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:01:14 INFO - 'LOGNAME': 'cltbld', 08:01:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:01:14 INFO - 'MOZ_NO_REMOTE': '1', 08:01:14 INFO - 'NO_EM_RESTART': '1', 08:01:14 INFO - 'PAGER': '/bin/cat', 08:01:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:01:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:01:14 INFO - 'PWD': '/builds/slave/test', 08:01:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:01:14 INFO - 'SHELL': '/bin/bash', 08:01:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4vSwSpYsC7/Listeners', 08:01:14 INFO - 'TMPDIR': '/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/', 08:01:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:01:14 INFO - 'USER': 'cltbld', 08:01:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:01:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:01:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:01:14 INFO - 'XPC_FLAGS': '0x0', 08:01:14 INFO - 'XPC_SERVICE_NAME': '0', 08:01:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:01:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:01:15 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 08:01:15 INFO - Cleaning up... 08:01:15 INFO - Return code: 0 08:01:15 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:01:15 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')]} 08:01:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:01:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:01:15 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')]} 08:01:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:01:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:01:15 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 0x100b13b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100b16768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd070575f40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1008f1d30>, '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 0x100818db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1008e6be8>, '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.9Ap333bYcz/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.4vSwSpYsC7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/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 08:01:15 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 08:01:15 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 08:01:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.9Ap333bYcz/Render', 08:01:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:01:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:01:15 INFO - 'HOME': '/Users/cltbld', 08:01:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:01:15 INFO - 'LOGNAME': 'cltbld', 08:01:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:01:15 INFO - 'MOZ_NO_REMOTE': '1', 08:01:15 INFO - 'NO_EM_RESTART': '1', 08:01:15 INFO - 'PAGER': '/bin/cat', 08:01:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:01:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:01:15 INFO - 'PWD': '/builds/slave/test', 08:01:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:01:15 INFO - 'SHELL': '/bin/bash', 08:01:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4vSwSpYsC7/Listeners', 08:01:15 INFO - 'TMPDIR': '/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/', 08:01:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:01:15 INFO - 'USER': 'cltbld', 08:01:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:01:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:01:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:01:15 INFO - 'XPC_FLAGS': '0x0', 08:01:15 INFO - 'XPC_SERVICE_NAME': '0', 08:01:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:01:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:01:15 INFO - Downloading/unpacking blobuploader==1.2.4 08:01:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:01:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:01:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:01:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:01:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:01:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:01:17 INFO - Downloading blobuploader-1.2.4.tar.gz 08:01:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:01:18 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:01:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:01:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:01:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:01:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:01:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:01:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:01:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:01:18 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:01:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:01:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:01:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:01:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:01:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:01:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:01:19 INFO - Downloading docopt-0.6.1.tar.gz 08:01:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:01:19 INFO - Installing collected packages: blobuploader, requests, docopt 08:01:19 INFO - Running setup.py install for blobuploader 08:01:19 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:01:19 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:01:19 INFO - Running setup.py install for requests 08:01:19 INFO - Running setup.py install for docopt 08:01:20 INFO - Successfully installed blobuploader requests docopt 08:01:20 INFO - Cleaning up... 08:01:20 INFO - Return code: 0 08:01:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:01:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:01:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:01:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:01:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:01:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:01:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:01:20 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 0x100b13b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100b16768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd070575f40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1008f1d30>, '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 0x100818db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1008e6be8>, '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.9Ap333bYcz/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.4vSwSpYsC7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/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 08:01:20 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 08:01:20 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 08:01:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.9Ap333bYcz/Render', 08:01:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:01:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:01:20 INFO - 'HOME': '/Users/cltbld', 08:01:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:01:20 INFO - 'LOGNAME': 'cltbld', 08:01:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:01:20 INFO - 'MOZ_NO_REMOTE': '1', 08:01:20 INFO - 'NO_EM_RESTART': '1', 08:01:20 INFO - 'PAGER': '/bin/cat', 08:01:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:01:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:01:20 INFO - 'PWD': '/builds/slave/test', 08:01:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:01:20 INFO - 'SHELL': '/bin/bash', 08:01:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4vSwSpYsC7/Listeners', 08:01:20 INFO - 'TMPDIR': '/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/', 08:01:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:01:20 INFO - 'USER': 'cltbld', 08:01:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:01:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:01:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:01:20 INFO - 'XPC_FLAGS': '0x0', 08:01:20 INFO - 'XPC_SERVICE_NAME': '0', 08:01:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:01:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:01:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:01:20 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-BOsGvY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:01:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:01:20 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-iS7kWV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:01:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:01:20 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-tJOPva-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:01:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:01:20 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-Rf6JGz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:01:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:01:20 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-Xa8ued-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:01:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:01:20 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-bFvGVP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:01:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:01:21 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-Y63V5h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:01:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:01:21 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-U4H6kv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:01:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:01:21 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-UcPx6D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:01:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:01:21 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-HQ3RNi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:01:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:01:21 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-OR_Yne-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:01:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:01:21 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-yPVF67-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:01:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:01:21 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-86zlsd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:01:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:01:21 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-7wEg1q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:01:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:01:21 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-_OoWL0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:01:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:01:21 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-o7m5Tr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:01:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:01:22 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-hn08Y9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:01:22 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:01:22 INFO - Running setup.py install for manifestparser 08:01:22 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:01:22 INFO - Running setup.py install for mozcrash 08:01:22 INFO - Running setup.py install for mozdebug 08:01:22 INFO - Running setup.py install for mozdevice 08:01:22 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:01:22 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:01:22 INFO - Running setup.py install for mozfile 08:01:22 INFO - Running setup.py install for mozhttpd 08:01:23 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:01:23 INFO - Running setup.py install for mozinfo 08:01:23 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:01:23 INFO - Running setup.py install for mozInstall 08:01:23 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:01:23 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:01:23 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:01:23 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:01:23 INFO - Running setup.py install for mozleak 08:01:23 INFO - Running setup.py install for mozlog 08:01:23 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:01:23 INFO - Running setup.py install for moznetwork 08:01:23 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:01:23 INFO - Running setup.py install for mozprocess 08:01:23 INFO - Running setup.py install for mozprofile 08:01:24 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:01:24 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:01:24 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:01:24 INFO - Running setup.py install for mozrunner 08:01:24 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:01:24 INFO - Running setup.py install for mozscreenshot 08:01:24 INFO - Running setup.py install for moztest 08:01:24 INFO - Running setup.py install for mozversion 08:01:24 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:01:24 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:01:24 INFO - Cleaning up... 08:01:24 INFO - Return code: 0 08:01:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:01:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:01:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:01:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:01:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:01:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:01:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:01:24 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x100b13b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100b16768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd070575f40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1008f1d30>, '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 0x100818db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1008e6be8>, '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.9Ap333bYcz/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.4vSwSpYsC7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/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 08:01:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 08:01:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:01:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.9Ap333bYcz/Render', 08:01:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:01:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:01:24 INFO - 'HOME': '/Users/cltbld', 08:01:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:01:24 INFO - 'LOGNAME': 'cltbld', 08:01:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:01:24 INFO - 'MOZ_NO_REMOTE': '1', 08:01:24 INFO - 'NO_EM_RESTART': '1', 08:01:24 INFO - 'PAGER': '/bin/cat', 08:01:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:01:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:01:24 INFO - 'PWD': '/builds/slave/test', 08:01:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:01:24 INFO - 'SHELL': '/bin/bash', 08:01:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4vSwSpYsC7/Listeners', 08:01:24 INFO - 'TMPDIR': '/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/', 08:01:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:01:24 INFO - 'USER': 'cltbld', 08:01:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:01:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:01:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:01:24 INFO - 'XPC_FLAGS': '0x0', 08:01:24 INFO - 'XPC_SERVICE_NAME': '0', 08:01:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:01:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:01:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:01:25 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-b72SN6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:01:25 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)) 08:01:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:01:25 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-4pTNr1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:01:25 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)) 08:01:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:01:25 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-ByFSQV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:01:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 08:01:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:01:25 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-MR_Yfm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:01:25 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)) 08:01:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:01:25 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-Py28lh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:01:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 08:01:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:01:25 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-1hEQEY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:01:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 08:01:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:01:25 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-Lx3qTi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:01:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 08:01:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:01:25 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-frZ10T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:01:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 08:01:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:01:25 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-8bNiKr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:01:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 08:01:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:01:25 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-BI98HT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:01:26 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)) 08:01:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:01:26 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-UTvfyB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:01:26 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)) 08:01:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:01:26 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-06e_4H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:01:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 08:01:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:01:26 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-MrnTV2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:01:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 08:01:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:01:26 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-kc7Lsf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:01:26 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)) 08:01:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:01:26 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-ZFUUHQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:01:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 08:01:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:01:26 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-suJJoI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:01:26 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 08:01:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:01:26 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-KUb8dH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:01:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 08:01:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:01:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:01:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 08:01:26 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:01:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:01:26 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:01:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:01:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:01:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:01:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:01:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:01:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:01:29 INFO - Downloading blessings-1.6.tar.gz 08:01:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:01:29 INFO - Installing collected packages: blessings 08:01:29 INFO - Running setup.py install for blessings 08:01:29 INFO - Successfully installed blessings 08:01:29 INFO - Cleaning up... 08:01:29 INFO - Return code: 0 08:01:29 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:01:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:01:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:01:30 INFO - Reading from file tmpfile_stdout 08:01:30 INFO - Current package versions: 08:01:30 INFO - blessings == 1.6 08:01:30 INFO - blobuploader == 1.2.4 08:01:30 INFO - docopt == 0.6.1 08:01:30 INFO - functools32 == 3.2.3-2 08:01:30 INFO - jsonschema == 2.5.1 08:01:30 INFO - manifestparser == 1.1 08:01:30 INFO - mozInstall == 1.12 08:01:30 INFO - mozcrash == 1.0 08:01:30 INFO - mozdebug == 0.1 08:01:30 INFO - mozdevice == 0.49 08:01:30 INFO - mozfile == 1.2 08:01:30 INFO - mozhttpd == 0.7 08:01:30 INFO - mozinfo == 0.9 08:01:30 INFO - mozleak == 0.1 08:01:30 INFO - mozlog == 3.4 08:01:30 INFO - moznetwork == 0.27 08:01:30 INFO - mozprocess == 0.23 08:01:30 INFO - mozprofile == 0.28 08:01:30 INFO - mozrunner == 6.13 08:01:30 INFO - mozscreenshot == 0.1 08:01:30 INFO - mozsystemmonitor == 0.3 08:01:30 INFO - moztest == 0.7 08:01:30 INFO - mozversion == 1.4 08:01:30 INFO - psutil == 3.1.1 08:01:30 INFO - requests == 1.2.3 08:01:30 INFO - wsgiref == 0.1.2 08:01:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:01:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:01:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:01:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:01:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:01:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:01:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:01:30 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 0x100b13b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100b16768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd070575f40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1008f1d30>, '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 0x100818db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1008e6be8>, '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.9Ap333bYcz/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.4vSwSpYsC7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/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 08:01:30 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 08:01:30 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 08:01:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.9Ap333bYcz/Render', 08:01:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:01:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:01:30 INFO - 'HOME': '/Users/cltbld', 08:01:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:01:30 INFO - 'LOGNAME': 'cltbld', 08:01:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:01:30 INFO - 'MOZ_NO_REMOTE': '1', 08:01:30 INFO - 'NO_EM_RESTART': '1', 08:01:30 INFO - 'PAGER': '/bin/cat', 08:01:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:01:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:01:30 INFO - 'PWD': '/builds/slave/test', 08:01:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:01:30 INFO - 'SHELL': '/bin/bash', 08:01:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4vSwSpYsC7/Listeners', 08:01:30 INFO - 'TMPDIR': '/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/', 08:01:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:01:30 INFO - 'USER': 'cltbld', 08:01:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:01:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:01:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:01:30 INFO - 'XPC_FLAGS': '0x0', 08:01:30 INFO - 'XPC_SERVICE_NAME': '0', 08:01:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:01:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:01:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 08:01:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 08:01:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 08:01:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 08:01:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 08:01:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 08:01:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 08:01:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 08:01:30 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 08:01:30 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 08:01:30 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 08:01:30 INFO - Cleaning up... 08:01:30 INFO - Return code: 0 08:01:30 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:01:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:01:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:01:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:01:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:01:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:01:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:01:30 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x100b13b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100b16768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd070575f40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1008f1d30>, '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 0x100818db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1008e6be8>, '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.9Ap333bYcz/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.4vSwSpYsC7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/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 08:01:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 08:01:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 08:01:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.9Ap333bYcz/Render', 08:01:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:01:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:01:30 INFO - 'HOME': '/Users/cltbld', 08:01:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:01:30 INFO - 'LOGNAME': 'cltbld', 08:01:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:01:30 INFO - 'MOZ_NO_REMOTE': '1', 08:01:30 INFO - 'NO_EM_RESTART': '1', 08:01:30 INFO - 'PAGER': '/bin/cat', 08:01:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:01:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:01:30 INFO - 'PWD': '/builds/slave/test', 08:01:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:01:30 INFO - 'SHELL': '/bin/bash', 08:01:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4vSwSpYsC7/Listeners', 08:01:30 INFO - 'TMPDIR': '/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/', 08:01:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:01:30 INFO - 'USER': 'cltbld', 08:01:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:01:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:01:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:01:30 INFO - 'XPC_FLAGS': '0x0', 08:01:30 INFO - 'XPC_SERVICE_NAME': '0', 08:01:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:01:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:01:30 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:01:30 INFO - Cleaning up... 08:01:30 INFO - Return code: 0 08:01:30 INFO - Running post-action listener: _resource_record_post_action 08:01:30 INFO - Running post-action listener: _start_resource_monitoring 08:01:30 INFO - Starting resource monitoring. 08:01:30 INFO - [mozharness: 2016-12-18 16:01:30.630243Z] Finished create-virtualenv step (success) 08:01:30 INFO - [mozharness: 2016-12-18 16:01:30.631091Z] Running install step. 08:01:30 INFO - Running pre-action listener: _resource_record_pre_action 08:01:30 INFO - Running main action method: install 08:01:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:01:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:01:30 INFO - Reading from file tmpfile_stdout 08:01:30 INFO - Detecting whether we're running mozinstall >=1.0... 08:01:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:01:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:01:30 INFO - Reading from file tmpfile_stdout 08:01:30 INFO - Output received: 08:01:30 INFO - Usage: mozinstall [options] installer 08:01:30 INFO - Options: 08:01:30 INFO - -h, --help show this help message and exit 08:01:30 INFO - -d DEST, --destination=DEST 08:01:30 INFO - Directory to install application into. [default: 08:01:30 INFO - "/builds/slave/test"] 08:01:30 INFO - --app=APP Application being installed. [default: firefox] 08:01:30 INFO - mkdir: /builds/slave/test/build/application 08:01:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 08:01:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 08:01:52 INFO - Reading from file tmpfile_stdout 08:01:52 INFO - Output received: 08:01:52 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 08:01:52 INFO - Running post-action listener: _resource_record_post_action 08:01:52 INFO - [mozharness: 2016-12-18 16:01:52.870528Z] Finished install step (success) 08:01:52 INFO - [mozharness: 2016-12-18 16:01:52.870656Z] Running run-tests step. 08:01:52 INFO - Running pre-action listener: _resource_record_pre_action 08:01:52 INFO - Running main action method: run_tests 08:01:52 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 08:01:52 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 08:01:52 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 08:01:52 INFO - 2016-12-18 08:01:52.884 screenresolution[2210:29118] starting screenresolution argv=screenresolution get 08:01:52 INFO - 2016-12-18 08:01:52.887 screenresolution[2210:29118] Display 0: 1600x1200x32@60 08:01:52 INFO - 2016-12-18 08:01:52.893 screenresolution[2211:29122] starting screenresolution argv=screenresolution list 08:01:52 INFO - Available Modes on Display 0 08:01:52 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 08:01:52 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 08:01:52 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 08:01:52 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 08:01:53 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 08:01:53 INFO - Intel Iris: 08:01:53 INFO - Chipset Model: Intel Iris 08:01:53 INFO - Type: GPU 08:01:53 INFO - Bus: Built-In 08:01:53 INFO - VRAM (Dynamic, Max): 1536 MB 08:01:53 INFO - Vendor: Intel (0x8086) 08:01:53 INFO - Device ID: 0x0a2e 08:01:53 INFO - Revision ID: 0x0009 08:01:53 INFO - Displays: 08:01:53 INFO - Display: 08:01:53 INFO - Resolution: 1600 x 1200 @ 60 Hz 08:01:53 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 08:01:53 INFO - Display Serial Number: 1600x1200 60 08:01:53 INFO - Main Display: Yes 08:01:53 INFO - Mirror: Off 08:01:53 INFO - Online: Yes 08:01:53 INFO - Rotation: Supported 08:01:53 INFO - Return code: 0 08:01:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:01:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:01:53 INFO - Python 2.7.3 08:01:53 INFO - Return code: 0 08:01:53 INFO - grabbing minidump binary from tooltool 08:01:53 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')]} 08:01:53 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 0x1008f1d30>, '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 0x100818db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1008e6be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:01:53 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 08:01:53 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 08:01:53 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 08:01:53 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:01:53 INFO - Return code: 0 08:01:53 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 08:01:53 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:01:53 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:01:53 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 08:01:53 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:01:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/LxqZjBktTqumWn3nkUrvRg/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0082', '--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 08:01:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/LxqZjBktTqumWn3nkUrvRg/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0082 --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 08:01:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.9Ap333bYcz/Render', 08:01:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:01:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:01:53 INFO - 'HOME': '/Users/cltbld', 08:01:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:01:53 INFO - 'LOGNAME': 'cltbld', 08:01:53 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:01:53 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 08:01:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:01:53 INFO - 'MOZ_NO_REMOTE': '1', 08:01:53 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:01:53 INFO - 'NO_EM_RESTART': '1', 08:01:53 INFO - 'PAGER': '/bin/cat', 08:01:53 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:01:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:01:53 INFO - 'PWD': '/builds/slave/test', 08:01:53 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:01:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:01:53 INFO - 'SHELL': '/bin/bash', 08:01:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4vSwSpYsC7/Listeners', 08:01:53 INFO - 'TMPDIR': '/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/', 08:01:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:01:53 INFO - 'USER': 'cltbld', 08:01:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:01:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:01:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:01:53 INFO - 'XPC_FLAGS': '0x0', 08:01:53 INFO - 'XPC_SERVICE_NAME': '0', 08:01:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:01:53 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/LxqZjBktTqumWn3nkUrvRg/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0082', '--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 08:01:53 INFO - mozversion application_buildid: 20161218064235 08:01:53 INFO - mozversion application_changeset: 2824deb82146bba070995a762cfc98ddb2d1decb 08:01:53 INFO - mozversion application_display_name: Nightly 08:01:53 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:01:53 INFO - mozversion application_name: Firefox 08:01:53 INFO - mozversion application_remotingname: firefox 08:01:53 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 08:01:53 INFO - mozversion application_vendor: Mozilla 08:01:53 INFO - mozversion application_version: 53.0a1 08:01:53 INFO - mozversion platform_buildid: 20161218064235 08:01:53 INFO - mozversion platform_changeset: 2824deb82146bba070995a762cfc98ddb2d1decb 08:01:53 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 08:01:53 INFO - mozversion platform_version: 53.0a1 08:01:53 INFO - using testdate: 1482076913 08:01:53 INFO - actual date: 1482076913 08:01:53 INFO - starting webserver on 'localhost:56629' 08:01:53 INFO - SUITE-START | Running 2 tests 08:01:53 INFO - TEST-START | dromaeo_css 08:01:53 INFO - operating with platform_type : mac_ 08:01:53 INFO - Initialising browser for dromaeo_css test... 08:01:53 INFO - TEST-INFO | started process 2221 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/tmpTvHClV/profile http://localhost:56629/getInfo.html) 08:01:55 INFO - PROCESS | 2221 | __metrics Screen width/height:1600/1200 08:01:55 INFO - PROCESS | 2221 | colorDepth:24 08:01:55 INFO - PROCESS | 2221 | Browser inner width/height: 1024/689 08:01:55 INFO - PROCESS | 2221 | __metrics 08:01:56 INFO - PROCESS | 2221 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 08:01:56 INFO - PROCESS | 2221 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:01:56 INFO - TEST-INFO | 2221: exit 0 08:01:56 INFO - Browser initialized. 08:01:56 INFO - Running cycle 1/1 for dromaeo_css test... 08:01:56 INFO - TEST-INFO | started process 2223 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/tmpTvHClV/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:02:08 INFO - PROCESS | 2223 | RSS: Main: 238575616 08:02:08 INFO - PROCESS | 2223 | 08:02:59 INFO - PROCESS | 2223 | 1482076979639 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 08:05:13 INFO - PROCESS | 2223 | Cycle 1(1): loaded http://localhost:56629/tests/dromaeo/cssquery-dojo.html (next: http://localhost:56629/tests/dromaeo/cssquery-ext.html) 08:05:15 INFO - PROCESS | 2223 | RSS: Main: 401981440 08:05:15 INFO - PROCESS | 2223 | 08:08:18 INFO - PROCESS | 2223 | Cycle 1(1): loaded http://localhost:56629/tests/dromaeo/cssquery-ext.html (next: http://localhost:56629/tests/dromaeo/cssquery-jquery.html) 08:08:19 INFO - PROCESS | 2223 | RSS: Main: 374685696 08:08:19 INFO - PROCESS | 2223 | 08:11:21 INFO - PROCESS | 2223 | Cycle 1(1): loaded http://localhost:56629/tests/dromaeo/cssquery-jquery.html (next: http://localhost:56629/tests/dromaeo/cssquery-mootools.html) 08:11:22 INFO - PROCESS | 2223 | RSS: Main: 358535168 08:11:22 INFO - PROCESS | 2223 | 08:14:24 INFO - PROCESS | 2223 | Cycle 1(1): loaded http://localhost:56629/tests/dromaeo/cssquery-mootools.html (next: http://localhost:56629/tests/dromaeo/cssquery-prototype.html) 08:14:25 INFO - PROCESS | 2223 | RSS: Main: 341913600 08:14:25 INFO - PROCESS | 2223 | 08:17:29 INFO - PROCESS | 2223 | Cycle 1(1): loaded http://localhost:56629/tests/dromaeo/cssquery-prototype.html (next: http://localhost:56629/tests/dromaeo/cssquery-yui.html) 08:17:29 INFO - PROCESS | 2223 | RSS: Main: 336924672 08:17:29 INFO - PROCESS | 2223 | 08:20:33 INFO - PROCESS | 2223 | Cycle 1(1): loaded http://localhost:56629/tests/dromaeo/cssquery-yui.html (next: http://localhost:56629/tests/dromaeo/cssquery-dojo.html) 08:20:33 INFO - PROCESS | 2223 | RSS: Main: 399863808 08:20:33 INFO - PROCESS | 2223 | 08:20:33 INFO - PROCESS | 2223 | __start_tp_report 08:20:33 INFO - PROCESS | 2223 | _x_x_mozilla_page_load 08:20:33 INFO - PROCESS | 2223 | _x_x_mozilla_page_load_details 08:20:33 INFO - PROCESS | 2223 | |i|pagename|runs| 08:20:33 INFO - PROCESS | 2223 | |0;dojo.html;3204.7436205103595;3205.8557364918593;3219.1308346746396;3226.370857682752;3254.0400581828358;5122.871928201787;5191.558717509016;5292.259083728276;5312.203169524573;5343.492368225017;5233.921491177626;5282.418933917275;5395.0558652235795;5395.919061214076;5419.620626556142;4839.44346400165;4847.12751704693;4852.150873597124;4925.285833554132;4935.23503856901;3972;5018.774155163008;5033.647644664875;5040.7731652075745;5100.234964755279;4800.903981920377;4991.351124353847;5005.974970125162;5011.298418221452;5097.515736005093;4824.49342819006;4892.804287828518;4895.681780684244;4906.484819094015;4914.04176185644;4835.685680430761;4851.296561998526;4862.5623693867365;4868.05073010763;4877.926831097537;5204.479552044765;5269.578433725293;5271.341082364705;5293.550048245904;5294.126469132589;5661.405552416978;5666.603337766358;5668.97165514174;5671.63134396267;5676.687782171979;5594.720263986785;5610.66336019836;5666.036773748431;5667.773289068432;5668.121441176624;5246.265522826808;5286.841394758163;5304.973475132639;5317.973410133002;5320.600954928396;5976.820695379146;5984.7606095756555;5993.130996005642;6038.879222415615;6069.575129740876;5698.3162020556965;5712.171735098387;5714.7428365723645;5730.484256416942;5739.282589676291;5619.690916999604;5620.409856965041;5642.153676948491;5802.448767367094;5879.970600146972;4756.476787553366;4768.213244814567;5810.360860305363;5826.038703613856;5841.357450680422;5833.066709326487;5837.124431335334;5838.211841401441;5841.649501029951;5858.238429004202;4554.7039442436135;4598.1033698429155;4605;4696.459907110726;4705.176594096088;4151.91696166075;4153.356229784388;4203.684723645678;4234.957650423518;4240.98216428055;5530.723463826793;5545.861353466115;5548.72256387179;5553.805616803393;5591.888162236733;5623.887522249532;5669.951059054089;5865.736041878125;5871.295444546682;5888.057910734347;5399.70301633414;5474.7262636868;5528.695921724344;5529.170624406372;5601.215829783833;5109.9744501277255;5122.820701275437;5135.794568217229;5144.43411224765;5144.562712169432;6249.0626406039455;6289.559730818982;6298.1812364392335;6313.40022697843;6324.620522768557;5631.521320687623;5663.858403539944;5674.205611214351;5739.110437882135;5795.681237531976;6210.503159747119;6281.497480201664;6287.811365659038;6290.056491526308;6295.150154729053;5711.685857277889;5734.655920644775;5744.511716504144;5744.798932037359;5761.164631128379;5604.579656525695;5743.540516758733;5750.741216645178;5782.392848750989;5805.245318108618;5510.8071217507195;5604.439556044363;5605.80379686709;5637;5712.200291959212;5652.943470565407;5657.179708942263;5669.943300566942;5675;5688.459596338341;5476.507114359727;5535.557155427637;5546.528545073714;5550.195221692751;5583.637063590853;5441.455854414527;5478.506934375925;5617.662940223599;5636.3799982002765;5675.943240567542;5535.059039963136;5572.749226284745;5588.608797384307;5600;5625.381208067028 08:20:33 INFO - PROCESS | 2223 | |1;ext.html;425.1751601892329;437.4641064695748;447.4228245563224;495.0989199656626;508.84734579626127;29847.55228671569;31618.367632647332;31670.049898503054;37558.24883502328;39313.41029884554;40670.593294067054;40955;41126.17747645045;41148.38277425834;41223.79388103055;9087.136722011399;9312.44125352481;9321.161095501404;9323.673671421502;9343.018983006788;8404.705835295767;8603.31173506118;9203.493807840567;9343.906560934405;10910.5090270938;11010;11240.325580465198;11261.66215013551;11261.887381126166;11273.267237629569;11062.612808551663;11137.276077054965;11140.33158010522;11142.665720028372;11143.997040266333;8314.70898518555;8510.191531804468;11002.889971100267;11090.168237382148;11106.944465277622;39415.21169576621;40143;40212.59787402118;40235.39646905299;40321.59678403208;3361.9159521011925;3375.628680845105;3386.6782655647676;3437.845296961618;3462.3248466549035;29122.563161552593;29464.968726094485;30212.8489357554;30336.089917302517;30422;3053.40458610571;3176.9205769855707;3179.5707579476707;3180.6501284858646;3198.296374797541;427343;448210;449554;457210;459803.7009814963;57576.71211643915;57816.71091644515;58028.83942321214;58044.41955580474;58151.546211345056;60408.395916040274;60411;60495.69752151211;60562.69718651378;60572.697136514034;15491.457798976982;15778.526644200692;15801.604959875865;15813.920930395505;15823.841761582236;12284.1401101922;12320.81518777219;12321.753564928651;12343.567975120828;12351;14041.297935103205;14439.35022923971;14453.205073721047;15733.292001859943;16039.03765774034;6475.384838440341;6704.357432429086;6838.521303508806;6963.1644202696;7185.856282874313;744.8361360500681;844.0673056272852;1016.9373005209574;1041.4116024446316;1074.1567869222622;28500;28633.427331453255;28946.565801512996;29293.707062929523;29335.266618334284;1013.3160116921049;1033.2715435617872;1095;1126.4592995362273;1184.680136363177;11685.240459370114;12833.807492887614;12871.22772633645;14925;15342.539723808304;515145;519209;519269;521483;522855;44045.11909761787;47910.08359665644;49078;54230.186547201825;54669.1799623006;1359.4766015084067;1374.4639590559689;1404.7471455137968;1405.142862853638;1408.845027047024;24132.15537456251;24343.89814102419;24404.87797561001;29460.410791784474;30341.848290758404;48225;48621;48695.26957095575;48820.77948051327;48900;698857;714974;715640;718210;719003;23716.762832372147;23989.280321589682;24035.399115022265;24128.638070429308;24139;39498;39696.801515992236;40046.39930400988;40477.79761101293;40575.57985470494;32440.83779581087;33023.174420639676;33656.83171584126;34508.58439909182;34649.48025779565;33498.49752253767;33608;34260.82869585636;34606;34708;28142.859285703442;31881.8405907969;32215.516767248042;32501;33742.49386259257;28286;29041.10407158778;29995.850020749756;30220;30227.942022029125;19254.61490770205;21697.478069628392;22218.44453888601;22271.554568908854;22870.885645571667 08:20:33 INFO - PROCESS | 2223 | |2;jquery.html;346.11740062839755;363.96360363963606;367.93561126802814;375.59060623919925;399.6263493633453;14431.711365772691;14605.196714180716;15653.608659783496;19862.20551177951;20346.593068138667;19480.902595487038;19856.305029323976;20448.386548403534;20566.868822214772;20765.480862978395;5581.0512212923795;5813.157092221625;5818.505427038707;5820.883582328351;5829.504492118153;4704.576588107069;6330.715117819686;6375.4580860626675;6439.323870993549;6439.388258115471;6048.576599638027;6227.159333489989;6269.122322874801;6277.748890044393;6386.201724784402;6293;6299.559030867864;6319.273283572402;6329.525285603599;6332.430081292706;5282.102042652758;5475.780968761244;5515.889682206373;5568.52667523261;5570.721463926828;24646.383840403952;25294.98820047196;25333.366665833317;25462.98148074075;25782.871085644638;2204.6252137136726;2379.702537182852;2471.6910386201725;2597.623344615039;2830.985845070782;14262.786058209134;15176.46882359123;15704.371825126982;15739.370425182979;15763;1745.5985123421558;1803.1885651456896;1804.7924488683839;1809.6380723855282;1813.2656274208966;109142;110334;111190;114080.42959785232;114163;10455.68632941013;10620.946895265473;10702.678919632424;10756.677299681021;10897.073748731287;13617.863821361858;13631;13635.250061246528;13667;13675.726485470235;5907.852303692442;8291.8341633167;8349.206825351583;8369;8398.748037558884;6972.372486476242;8357.824026869872;8367.205115514016;8579.65681372738;8614.396992210484;6451.548391612542;6561.770338038145;6569.408753212234;6569.57297775643;6569.835754106186;1544.328217225488;1774.2193434888607;1813.6191399805925;1817.8909265444115;1818.563544749277;800.3237264511479;923.4505469245788;941.4680705401427;943.2454036770556;1002.7844013537125;20049.298274560322;20867;21689.457763556038;21760.891195544238;21923.013464394142;902.386377263454;950.1543626172712;972.2562239886493;977.672479719302;1010.4038617215878;11261.493232804543;11444.427778611036;11505.07811720578;11681.76636467266;11694.239874408137;488403;493917;496195.5326254327;545556;546103;88929;97492.51253743687;104425;110846;111881;974.8878878929014;1023.1967905194387;1044.9341671495033;1053.3311347294523;1055.2244100586063;15415.768763468333;15646.295916683548;18696.906515467337;19238.903805481445;19342.8065719341;40969.59030409658;43039.784801075795;44193;44543.55456445394;45564.088718226114;48970.75514622546;62476.68761656163;63299.6835015822;63742.3625763755;64914.83309085629;7449.776506704808;7744.961275193588;7950.4832185907735;8025.558594277138;8187.549684767157;12746.68133296675;12846.935765321488;12905.935470322589;12939.870601293867;13224.206547607175;10934.890651093705;11141.331520108819;11155.776884462428;11237.71905702364;11486.368249746343;8660.826783464421;10468.581256749645;10669.199810014436;10846.891531084588;11310.377929213972;9395.85906211421;11044.282121662067;11141.387223702774;11201.97546662413;11208.327500350006;7791.805204869924;7804.619591024565;7947;7953.721619743281;7968.84062318762;10910.399928004035;11082.390468524309;11150.219484636322;11338;11423.828642570534 08:20:33 INFO - PROCESS | 2223 | |3;mootools.html;1267.2143271171872;1352.1278775190008;1497.3711041362624;1653.4047742812586;1900.7053906644467;7546.283103105203;7886.802829929255;8208.343332533397;8487.618057187427;8491.363147763912;8349.62426690799;8426.410151289412;8427.789305267372;8442.324614030878;8445.366597505197;2053.1889903488186;2305.5849947009488;2335.929922102331;2344.78896899279;2346.249200255919;1797.1643185918545;1884.4723477426273;2292.1175347491253;2370.288913326004;2382.868942208178;2315.0855412112205;2334.8832558372096;2335.532893421314;2341.906323747048;2346.5541547105995;2302.9769702303015;2327.1273272522803;2329.94175145621;2332.3586013846157;2332.9066837326486;2321.9883900580558;2342.730585982617;2348.473492230047;2360.1031607989025;2362.11420717231;8298.128696486843;8323.334133269324;8357.206065423776;8454.196851299117;8465.195806398444;5102.693838369672;5270.077736396115;5270.130428479335;5270.947290527122;5288.788448462057;3312.1554003729134;3320.6181289151814;3449.5688038995127;3531.4879342495196;3534.045807631925;970.6604885258369;1004.7638804880847;1026.5329275179774;1046.9581216751321;1064.4252103863905;10683.305585137019;10940.945295273552;11022.952819482136;11025.558977640885;11030.393328366936;4136.9793151034055;4533.410656614619;4719.764011799396;4797.376341075638;4800.831970881002;8520.70177543783;8532.616032278562;8787.736367908972;8807.383483156118;8857.64569417229;5018.447970723218;5171.534561889448;5179.844604661791;5180.740962951837;5196.220566914917;4325.697201195886;4485.215087359764;4672.95327046732;4777.8327758528285;4824.155772739757;3110.315730539278;3622.637736226409;3694.9445758313645;3703.8517659757276;3725.2921944830396;967.2358836519071;1146.7534480086822;1147.428023607663;1161.7153797319543;1161.73280145567;791.8297566023217;794.3446656508404;889.8476472967523;968.3173362779223;972.1153750087386;4800.711957282574;5596.3284405871555;5792.913106303409;5950.434708702666;6148.262208535004;866.85142186603;894.8478758611052;902.9367944243971;925.634374422113;946.944157264645;3595.5505561804775;3778.886633401002;3839.308924393636;3974.18529201513;3976.960230397659;10027.247956403298;10305;10398.27212095146;10405.115565177044;10420.32267902584;9539.14147726708;9963.252756043326;9979.301448898508;10191.286609937233;10375.481225938673;7631.809204769926;7745.8450830983065;7864.567448790372;7866.213378661973;7887.408444366695;5529.391766905556;5565.471280228372;5622.297212848394;5947.375525569752;5995.424937578896;9324.813503730024;9600.807983840425;9615.807683846424;9629.181519570915;9643.807123857623;7374.815629609088;9531.90468095338;9534.85697714521;9645;9665.855012174963;6630.403263706289;7143.642817858982;7276.454265930182;7315;7316.304951029643;7406.444516661164;7566.394688425023;7660.80847978805;7780.88328675059;7939.880901786362;5872.354041055566;6960.617166055916;7016.964915175596;7215.67529461165;7284.927150728637;7059.329363710439;7077.7168913242895;7104.928950710427;7140.5358651687475;7185.173705023989;5609.27079479665;6597.307282735435;6654.4676425884845;6668.3331666834865;6727.058211850443;4814.20565606671;4825.118203900412;4833.758312084452;4894.290327902506;5006.449290578106;3580.373434648978;4784.593309568726;4927.1131196384995;4934;5050.368703912011 08:20:33 INFO - PROCESS | 2223 | |4;prototype.html;348.75587089037674;354.13944115798614;359.72121605755535;368.8524590163934;369.53254133521085;4603.769811509428;4967.602591792657;4970.776315065827;5013.3983921929375;5077;4707.388039554853;4780.956091323652;4790.640701947351;4913.9189378336705;4948.505149485059;3925.9018524536827;3951.308521008826;3972.443857859902;3988.2621714982674;3997.580254073324;3936.547297060846;3954.5056867891512;3964.484616999786;3968.583298753633;3983.5219773627205;3273.903242413794;3650.689691376236;3720.627937206285;3884.0872394987296;3958.9904574333505;3429.696715248215;3496.702495718988;3666.651668091527;3905.9609403905883;3983.6695533113166;3001.9943318988167;3323.7673362864607;3516.384632689295;3520.099146460908;3531.5055892175114;4120.907959390764;4761.047970332182;4797.592204662608;4881.658283920127;4928.236123400879;3493.9126521837156;3719.3119272934323;4238.894027649302;4488.304312831517;4527;4374.956250437519;4492.303692927601;4535.9773201133785;4588.403507543998;4919.048570857457;3834.559025712051;3886.434952931052;3888.416737489399;3897.688184945226;3897.922041559153;5145.871353216199;5439.918401223985;5520.751566179451;5528.364238112628;5550.750216240279;3365.663433656615;3388.966110338865;3575.12409459684;3641.487373712183;3663.157473781045;3120.4851199551817;3677.2093999790172;3713.4960341061915;3715.6098609646137;3718.8140592970785;4281.272183728774;4290.485141782943;4300.2904520754355;4302.698811083194;4318.481782186158;4916.3362946001835;4929.827456039022;5197.168453047494;5310.575153987749;5323.733813309319;1155.8901904319075;1168.8889555492215;1199.0347770045198;1272.9943344757537;1306.6798634334648;865.7272959017889;891.028778631295;892.0856122474515;900.9773906616037;926.0876290460178;4039.6970227233073;4192.748435093904;4302;4657.322039827113;4766.998930224691;4650.67445278834;4762.9761851191215;5117.462666419972;5158.105630249138;5198.376194856642;4541.704789188692;4705.976470117627;4706.670533062721;4757.500462451462;4822.662413631082;2325.453518423169;2394.9642803616784;2663.920082397531;2682.9731702682725;2702.8378297302224;4817.662763606584;4917.729524876167;5168.095583272912;5336.879255356341;5354.598405119632;4524.47968483622;4877.609791216694;5219.347581552306;5236.816711415082;5305.734713264322;4873.636286401093;5019.499747826646;5287.9735601321745;5357.8392648220615;5477.534409575151;4097.848629469552;4521.706089104197;5061.240813877947;5073.492650734897;5211.55701765339;4311.762853043113;4809.5430934061205;4981.128302547112;5036.773345199402;5086.669366491166;4911.705297682151;5143.434222235476;5181.005312954464;5404.459554044564;5406.162044883049;3208.2620997170316;3296.571445712042;3667.1213097718164;3743.73793834429;3757.4363845423404;4010.3382941814275;4176.874693759192;4564;4598.321612611306;5074.340335756328;4125.555161440231;4949.133901567283;4981.402231732215;4983.227599722049;4997.8250761224635;4380.540043295408;4768.499307572655;4921.8523444296725;4951.687802732351;4961.975190124026;4548.135854187693;4743.525647435229;4803;4855.514448555116;5170.224466330081;5084.771185296744;5170.767315470737;5238.7688893109325;5239.4236633970995;5307.99148161848;5173.948260517347;5175.094358487325;5175.981367266693;5212.739363031757;5217.478252174752 08:20:33 INFO - PROCESS | 2223 | |5;yui.html;730.2989130434786;732.3226015935259;737.9667914943827;773.0723132241312;808.7695006923028;15180.165090919994;15815.60460988473;15827.208639568033;15827.366905323788;15888.761668574965;14141.292935353242;14190.148591084542;14258.001939864187;14322.641933951656;14343.282835858192;542.8859939412728;701.5790525684599;707.3951771235596;754.6076040458958;844.8014716541608;837.9916200837974;857.0957639690124;869.026690107081;871.9084496127911;875.1379890807549;893.6246776353914;898.1961144775422;899.1952202778509;915.5925613102172;933.0156684697641;721.783464960515;746.8730315846265;897.6768363389175;929.2798081486834;933.4212788071371;678.0168755304778;681.6353251010686;681.9727210911558;682.4233522673383;685.5612408058846;14439.989200755952;14781.260936953217;14840.257987100602;14853.257337133207;14888.255587220596;12455.439505222286;12622.495100195982;12660.240385576803;13049.673758156123;13475.932620336933;12613.621591352274;12886.162399444007;12946.31697879279;13057.21656700601;13234.602961911158;4345.717528360647;4381.9123617527475;4387.3638322443385;4523.95476045242;4533.229351010336;97936;98510.50744746302;98654;100719;101472.49263753709;10383.53274102652;10513.211509136845;10564.10205132557;10682.51928663212;10749.89250107489;20007.099680514413;20393.286234981704;20443.795562044488;20506.179752810018;20572.485687857923;7547.245275472409;7553.395728341719;7642.961785191039;7703.653335599912;7718.961405192938;4223.450951376301;4233.184932020172;4326.15639950213;4392.868213953587;4494.280915053576;3391.0505058583635;3480.973112931691;3499.825008749603;3503.159241781954;3504.7021003215013;507.6294305157182;509.2946269416884;519.4675457655858;520.2378515474848;520.3001962360695;548.8380927626359;553.3138907754355;554.717094281911;565.8245943757448;617.9391728585218;8549.316054715608;8821.69124080667;8947.821043579092;9050.818983620291;9051.321150913707;596.1326270276737;608.528390497368;617.7745123030152;632.4150161101055;642.7177780328275;4139.234241665302;4323.913521729548;4327.956720432819;4346.913061738811;4396.669765024542;102121.48939255257;107332;107977.4601127005;110256.4487177575;110755;82132;85071;86373.56813215894;86602.56698716467;88395.55802220947;67060.32939670736;69489.95765063528;70440;70946.64526677334;77530.22469775342;9634.7591310215;9890.406575605486;9900.455474948947;9917.900820991697;9954.751131221778;47465.76267118642;49254.33575138905;50480.49519504905;53027.93944121019;53330.20004699855;68739.3126068733;72813.63593182;73828.63085684537;74190.62904685442;75744;12235;12747.49010039588;12921.224726516439;13117.540886068942;13390.129641573267;14289.857101429268;14431.567052988426;14667.559973200821;15089.849101508844;15213.6196595086;12614.810777838156;13161.078724489194;13561.660958476117;13589.388477518338;13636.250006249751;13197.868021320048;13218.537351192663;13535.59393218205;13781.242031688353;13976.301184940916;13146.60560183196;13305.268210248529;13305.66735831612;13329.66675833112;13337;10801.729956751144;10913.214862036137;11402.600908968147;11408.942955285502;11522.539098436304;9500.239980801382;11261.380624065427;11289.322640641587;11290.94354528255;11547.307161570332 08:20:33 INFO - PROCESS | 2223 | __end_tp_report 08:20:33 INFO - PROCESS | 2223 | __start_cc_report 08:20:33 INFO - PROCESS | 2223 | _x_x_mozilla_cycle_collect,1834 08:20:33 INFO - PROCESS | 2223 | __end_cc_report 08:20:33 INFO - PROCESS | 2223 | __startTimestamp1482078033403__endTimestamp 08:20:33 INFO - PROCESS | 2223 | 08:20:33 INFO - PROCESS | 2223 | ------- Summary: start ------- 08:20:33 INFO - PROCESS | 2223 | Number of tests: 6 08:20:33 INFO - PROCESS | 2223 | 08:20:33 INFO - PROCESS | 2223 | [#0] dojo.html Cycles:165 Average:5374.10 Median:5553.81 stddev:602.84 (10.9%) stddev-sans-first:580.18 08:20:33 INFO - PROCESS | 2223 | Values: 3204.7 3205.9 3219.1 3226.4 3254.0 5122.9 5191.6 5292.3 5312.2 5343.5 5233.9 5282.4 5395.1 5395.9 5419.6 4839.4 4847.1 4852.2 4925.3 4935.2 3972.0 5018.8 5033.6 5040.8 5100.2 4800.9 4991.4 5006.0 5011.3 5097.5 4824.5 4892.8 4895.7 4906.5 4914.0 4835.7 4851.3 4862.6 4868.1 4877.9 5204.5 5269.6 5271.3 5293.6 5294.1 5661.4 5666.6 5669.0 5671.6 5676.7 5594.7 5610.7 5666.0 5667.8 5668.1 5246.3 5286.8 5305.0 5318.0 5320.6 5976.8 5984.8 5993.1 6038.9 6069.6 5698.3 5712.2 5714.7 5730.5 5739.3 5619.7 5620.4 5642.2 5802.4 5880.0 4756.5 4768.2 5810.4 5826.0 5841.4 5833.1 5837.1 5838.2 5841.6 5858.2 4554.7 4598.1 4605.0 4696.5 4705.2 4151.9 4153.4 4203.7 4235.0 4241.0 5530.7 5545.9 5548.7 5553.8 5591.9 5623.9 5670.0 5865.7 5871.3 5888.1 5399.7 5474.7 5528.7 5529.2 5601.2 5110.0 5122.8 5135.8 5144.4 5144.6 6249.1 6289.6 6298.2 6313.4 6324.6 5631.5 5663.9 5674.2 5739.1 5795.7 6210.5 6281.5 6287.8 6290.1 6295.2 5711.7 5734.7 5744.5 5744.8 5761.2 5604.6 5743.5 5750.7 5782.4 5805.2 5510.8 5604.4 5605.8 5637.0 5712.2 5652.9 5657.2 5669.9 5675.0 5688.5 5476.5 5535.6 5546.5 5550.2 5583.6 5441.5 5478.5 5617.7 5636.4 5675.9 5535.1 5572.7 5588.6 5600.0 5625.4 08:20:33 INFO - PROCESS | 2223 | 08:20:33 INFO - PROCESS | 2223 | [#1] ext.html Cycles:180 Average:67732.99 Median:33260.84 stddev:153359.05 (461.1%) stddev-sans-first:153706.00 08:20:33 INFO - PROCESS | 2223 | Values: 425.2 437.5 447.4 495.1 508.8 29847.6 31618.4 31670.0 37558.2 39313.4 40670.6 40955.0 41126.2 41148.4 41223.8 9087.1 9312.4 9321.2 9323.7 9343.0 8404.7 8603.3 9203.5 9343.9 10910.5 11010.0 11240.3 11261.7 11261.9 11273.3 11062.6 11137.3 11140.3 11142.7 11144.0 8314.7 8510.2 11002.9 11090.2 11106.9 39415.2 40143.0 40212.6 40235.4 40321.6 3361.9 3375.6 3386.7 3437.8 3462.3 29122.6 29465.0 30212.8 30336.1 30422.0 3053.4 3176.9 3179.6 3180.7 3198.3 427343.0 448210.0 449554.0 457210.0 459803.7 57576.7 57816.7 58028.8 58044.4 58151.5 60408.4 60411.0 60495.7 60562.7 60572.7 15491.5 15778.5 15801.6 15813.9 15823.8 12284.1 12320.8 12321.8 12343.6 12351.0 14041.3 14439.4 14453.2 15733.3 16039.0 6475.4 6704.4 6838.5 6963.2 7185.9 744.8 844.1 1016.9 1041.4 1074.2 28500.0 28633.4 28946.6 29293.7 29335.3 1013.3 1033.3 1095.0 1126.5 1184.7 11685.2 12833.8 12871.2 14925.0 15342.5 515145.0 519209.0 519269.0 521483.0 522855.0 44045.1 47910.1 49078.0 54230.2 54669.2 1359.5 1374.5 1404.7 1405.1 1408.8 24132.2 24343.9 24404.9 29460.4 30341.8 48225.0 48621.0 48695.3 48820.8 48900.0 698857.0 714974.0 715640.0 718210.0 719003.0 23716.8 23989.3 24035.4 24128.6 24139.0 39498.0 39696.8 40046.4 40477.8 40575.6 32440.8 33023.2 33656.8 34508.6 34649.5 33498.5 33608.0 34260.8 34606.0 34708.0 28142.9 31881.8 32215.5 32501.0 33742.5 28286.0 29041.1 29995.9 30220.0 30227.9 19254.6 21697.5 22218.4 22271.6 22870.9 08:20:33 INFO - PROCESS | 2223 | 08:20:33 INFO - PROCESS | 2223 | [#2] jquery.html Cycles:180 Average:31098.15 Median:13883.34 stddev:85672.31 (617.1%) stddev-sans-first:85881.53 08:20:33 INFO - PROCESS | 2223 | Values: 346.1 364.0 367.9 375.6 399.6 14431.7 14605.2 15653.6 19862.2 20346.6 19480.9 19856.3 20448.4 20566.9 20765.5 5581.1 5813.2 5818.5 5820.9 5829.5 4704.6 6330.7 6375.5 6439.3 6439.4 6048.6 6227.2 6269.1 6277.7 6386.2 6293.0 6299.6 6319.3 6329.5 6332.4 5282.1 5475.8 5515.9 5568.5 5570.7 24646.4 25295.0 25333.4 25463.0 25782.9 2204.6 2379.7 2471.7 2597.6 2831.0 14262.8 15176.5 15704.4 15739.4 15763.0 1745.6 1803.2 1804.8 1809.6 1813.3 109142.0 110334.0 111190.0 114080.4 114163.0 10455.7 10620.9 10702.7 10756.7 10897.1 13617.9 13631.0 13635.3 13667.0 13675.7 5907.9 8291.8 8349.2 8369.0 8398.7 6972.4 8357.8 8367.2 8579.7 8614.4 6451.5 6561.8 6569.4 6569.6 6569.8 1544.3 1774.2 1813.6 1817.9 1818.6 800.3 923.5 941.5 943.2 1002.8 20049.3 20867.0 21689.5 21760.9 21923.0 902.4 950.2 972.3 977.7 1010.4 11261.5 11444.4 11505.1 11681.8 11694.2 488403.0 493917.0 496195.5 545556.0 546103.0 88929.0 97492.5 104425.0 110846.0 111881.0 974.9 1023.2 1044.9 1053.3 1055.2 15415.8 15646.3 18696.9 19238.9 19342.8 40969.6 43039.8 44193.0 44543.6 45564.1 48970.8 62476.7 63299.7 63742.4 64914.8 7449.8 7745.0 7950.5 8025.6 8187.5 12746.7 12846.9 12905.9 12939.9 13224.2 10934.9 11141.3 11155.8 11237.7 11486.4 8660.8 10468.6 10669.2 10846.9 11310.4 9395.9 11044.3 11141.4 11202.0 11208.3 7791.8 7804.6 7947.0 7953.7 7968.8 10910.4 11082.4 11150.2 11338.0 11423.8 08:20:33 INFO - PROCESS | 2223 | 08:20:33 INFO - PROCESS | 2223 | [#3] mootools.html Cycles:180 Average:5413.66 Median:5188.48 stddev:2989.76 (57.6%) stddev-sans-first:2981.90 08:20:33 INFO - PROCESS | 2223 | Values: 1267.2 1352.1 1497.4 1653.4 1900.7 7546.3 7886.8 8208.3 8487.6 8491.4 8349.6 8426.4 8427.8 8442.3 8445.4 2053.2 2305.6 2335.9 2344.8 2346.2 1797.2 1884.5 2292.1 2370.3 2382.9 2315.1 2334.9 2335.5 2341.9 2346.6 2303.0 2327.1 2329.9 2332.4 2332.9 2322.0 2342.7 2348.5 2360.1 2362.1 8298.1 8323.3 8357.2 8454.2 8465.2 5102.7 5270.1 5270.1 5270.9 5288.8 3312.2 3320.6 3449.6 3531.5 3534.0 970.7 1004.8 1026.5 1047.0 1064.4 10683.3 10940.9 11023.0 11025.6 11030.4 4137.0 4533.4 4719.8 4797.4 4800.8 8520.7 8532.6 8787.7 8807.4 8857.6 5018.4 5171.5 5179.8 5180.7 5196.2 4325.7 4485.2 4673.0 4777.8 4824.2 3110.3 3622.6 3694.9 3703.9 3725.3 967.2 1146.8 1147.4 1161.7 1161.7 791.8 794.3 889.8 968.3 972.1 4800.7 5596.3 5792.9 5950.4 6148.3 866.9 894.8 902.9 925.6 946.9 3595.6 3778.9 3839.3 3974.2 3977.0 10027.2 10305.0 10398.3 10405.1 10420.3 9539.1 9963.3 9979.3 10191.3 10375.5 7631.8 7745.8 7864.6 7866.2 7887.4 5529.4 5565.5 5622.3 5947.4 5995.4 9324.8 9600.8 9615.8 9629.2 9643.8 7374.8 9531.9 9534.9 9645.0 9665.9 6630.4 7143.6 7276.5 7315.0 7316.3 7406.4 7566.4 7660.8 7780.9 7939.9 5872.4 6960.6 7017.0 7215.7 7284.9 7059.3 7077.7 7104.9 7140.5 7185.2 5609.3 6597.3 6654.5 6668.3 6727.1 4814.2 4825.1 4833.8 4894.3 5006.4 3580.4 4784.6 4927.1 4934.0 5050.4 08:20:33 INFO - PROCESS | 2223 | 08:20:33 INFO - PROCESS | 2223 | [#4] prototype.html Cycles:180 Average:4162.62 Median:4627.22 stddev:1224.48 (26.5%) stddev-sans-first:1193.98 08:20:33 INFO - PROCESS | 2223 | Values: 348.8 354.1 359.7 368.9 369.5 4603.8 4967.6 4970.8 5013.4 5077.0 4707.4 4781.0 4790.6 4913.9 4948.5 3925.9 3951.3 3972.4 3988.3 3997.6 3936.5 3954.5 3964.5 3968.6 3983.5 3273.9 3650.7 3720.6 3884.1 3959.0 3429.7 3496.7 3666.7 3906.0 3983.7 3002.0 3323.8 3516.4 3520.1 3531.5 4120.9 4761.0 4797.6 4881.7 4928.2 3493.9 3719.3 4238.9 4488.3 4527.0 4375.0 4492.3 4536.0 4588.4 4919.0 3834.6 3886.4 3888.4 3897.7 3897.9 5145.9 5439.9 5520.8 5528.4 5550.8 3365.7 3389.0 3575.1 3641.5 3663.2 3120.5 3677.2 3713.5 3715.6 3718.8 4281.3 4290.5 4300.3 4302.7 4318.5 4916.3 4929.8 5197.2 5310.6 5323.7 1155.9 1168.9 1199.0 1273.0 1306.7 865.7 891.0 892.1 901.0 926.1 4039.7 4192.7 4302.0 4657.3 4767.0 4650.7 4763.0 5117.5 5158.1 5198.4 4541.7 4706.0 4706.7 4757.5 4822.7 2325.5 2395.0 2663.9 2683.0 2702.8 4817.7 4917.7 5168.1 5336.9 5354.6 4524.5 4877.6 5219.3 5236.8 5305.7 4873.6 5019.5 5288.0 5357.8 5477.5 4097.8 4521.7 5061.2 5073.5 5211.6 4311.8 4809.5 4981.1 5036.8 5086.7 4911.7 5143.4 5181.0 5404.5 5406.2 3208.3 3296.6 3667.1 3743.7 3757.4 4010.3 4176.9 4564.0 4598.3 5074.3 4125.6 4949.1 4981.4 4983.2 4997.8 4380.5 4768.5 4921.9 4951.7 4962.0 4548.1 4743.5 4803.0 4855.5 5170.2 5084.8 5170.8 5238.8 5239.4 5308.0 5173.9 5175.1 5176.0 5212.7 5217.5 08:20:33 INFO - PROCESS | 2223 | 08:20:33 INFO - PROCESS | 2223 | [#5] yui.html Cycles:180 Average:20237.70 Median:4390.12 stddev:28995.47 (660.5%) stddev-sans-first:29039.81 08:20:33 INFO - PROCESS | 2223 | Values: 730.3 732.3 738.0 773.1 808.8 15180.2 15815.6 15827.2 15827.4 15888.8 14141.3 14190.1 14258.0 14322.6 14343.3 542.9 701.6 707.4 754.6 844.8 838.0 857.1 869.0 871.9 875.1 893.6 898.2 899.2 915.6 933.0 721.8 746.9 897.7 929.3 933.4 678.0 681.6 682.0 682.4 685.6 14440.0 14781.3 14840.3 14853.3 14888.3 12455.4 12622.5 12660.2 13049.7 13475.9 12613.6 12886.2 12946.3 13057.2 13234.6 4345.7 4381.9 4387.4 4524.0 4533.2 97936.0 98510.5 98654.0 100719.0 101472.5 10383.5 10513.2 10564.1 10682.5 10749.9 20007.1 20393.3 20443.8 20506.2 20572.5 7547.2 7553.4 7643.0 7703.7 7719.0 4223.5 4233.2 4326.2 4392.9 4494.3 3391.1 3481.0 3499.8 3503.2 3504.7 507.6 509.3 519.5 520.2 520.3 548.8 553.3 554.7 565.8 617.9 8549.3 8821.7 8947.8 9050.8 9051.3 596.1 608.5 617.8 632.4 642.7 4139.2 4323.9 4328.0 4346.9 4396.7 102121.5 107332.0 107977.5 110256.4 110755.0 82132.0 85071.0 86373.6 86602.6 88395.6 67060.3 69490.0 70440.0 70946.6 77530.2 9634.8 9890.4 9900.5 9917.9 9954.8 47465.8 49254.3 50480.5 53027.9 53330.2 68739.3 72813.6 73828.6 74190.6 75744.0 12235.0 12747.5 12921.2 13117.5 13390.1 14289.9 14431.6 14667.6 15089.8 15213.6 12614.8 13161.1 13561.7 13589.4 13636.3 13197.9 13218.5 13535.6 13781.2 13976.3 13146.6 13305.3 13305.7 13329.7 13337.0 10801.7 10913.2 11402.6 11408.9 11522.5 9500.2 11261.4 11289.3 11290.9 11547.3 08:20:33 INFO - PROCESS | 2223 | -------- Summary: end -------- 08:20:33 INFO - PROCESS | 2223 | 08:20:34 INFO - TEST-INFO | 2223: exit 0 08:20:34 INFO - TEST-OK | dromaeo_css | took 1120606ms 08:20:34 INFO - TEST-START | kraken 08:20:34 INFO - operating with platform_type : mac_ 08:20:34 INFO - Initialising browser for kraken test... 08:20:34 INFO - TEST-INFO | started process 2225 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/tmpkZmh74/profile http://localhost:56629/getInfo.html) 08:20:36 INFO - PROCESS | 2225 | __metrics Screen width/height:1600/1200 08:20:36 INFO - PROCESS | 2225 | colorDepth:24 08:20:36 INFO - PROCESS | 2225 | Browser inner width/height: 1024/689 08:20:36 INFO - PROCESS | 2225 | __metrics 08:20:36 INFO - PROCESS | 2225 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 08:20:36 INFO - PROCESS | 2225 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:20:37 INFO - TEST-INFO | 2225: exit 0 08:20:37 INFO - Browser initialized. 08:20:37 INFO - Running cycle 1/1 for kraken test... 08:20:37 INFO - TEST-INFO | started process 2226 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/tmpkZmh74/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:20:49 INFO - PROCESS | 2226 | RSS: Main: 237547520 08:20:49 INFO - PROCESS | 2226 | 08:20:51 INFO - PROCESS | 2226 | Cycle 1(1): loaded http://localhost:56629/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:56629/tests/kraken/driver.html?testName=audio-beat-detection) 08:20:52 INFO - PROCESS | 2226 | RSS: Main: 289226752 08:20:52 INFO - PROCESS | 2226 | 08:20:55 INFO - PROCESS | 2226 | Cycle 1(1): loaded http://localhost:56629/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:56629/tests/kraken/driver.html?testName=audio-dft) 08:20:55 INFO - PROCESS | 2226 | RSS: Main: 290172928 08:20:55 INFO - PROCESS | 2226 | 08:20:59 INFO - PROCESS | 2226 | Cycle 1(1): loaded http://localhost:56629/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:56629/tests/kraken/driver.html?testName=audio-fft) 08:21:00 INFO - PROCESS | 2226 | RSS: Main: 383643648 08:21:00 INFO - PROCESS | 2226 | 08:21:01 INFO - PROCESS | 2226 | Cycle 1(1): loaded http://localhost:56629/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:56629/tests/kraken/driver.html?testName=audio-oscillator) 08:21:02 INFO - PROCESS | 2226 | RSS: Main: 284639232 08:21:02 INFO - PROCESS | 2226 | 08:21:04 INFO - PROCESS | 2226 | Cycle 1(1): loaded http://localhost:56629/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:56629/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:21:05 INFO - PROCESS | 2226 | RSS: Main: 289267712 08:21:05 INFO - PROCESS | 2226 | 08:21:08 INFO - PROCESS | 2226 | Cycle 1(1): loaded http://localhost:56629/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:56629/tests/kraken/driver.html?testName=imaging-darkroom) 08:21:08 INFO - PROCESS | 2226 | RSS: Main: 331788288 08:21:08 INFO - PROCESS | 2226 | 08:21:11 INFO - PROCESS | 2226 | Cycle 1(1): loaded http://localhost:56629/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:56629/tests/kraken/driver.html?testName=imaging-desaturate) 08:21:12 INFO - PROCESS | 2226 | RSS: Main: 334012416 08:21:12 INFO - PROCESS | 2226 | 08:21:15 INFO - PROCESS | 2226 | Cycle 1(1): loaded http://localhost:56629/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:56629/tests/kraken/driver.html?testName=json-parse-financial) 08:21:15 INFO - PROCESS | 2226 | RSS: Main: 329900032 08:21:15 INFO - PROCESS | 2226 | 08:21:17 INFO - PROCESS | 2226 | Cycle 1(1): loaded http://localhost:56629/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:56629/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:21:18 INFO - PROCESS | 2226 | RSS: Main: 305577984 08:21:18 INFO - PROCESS | 2226 | 08:21:20 INFO - PROCESS | 2226 | Cycle 1(1): loaded http://localhost:56629/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:56629/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:21:20 INFO - PROCESS | 2226 | RSS: Main: 309096448 08:21:20 INFO - PROCESS | 2226 | 08:21:22 INFO - PROCESS | 2226 | Cycle 1(1): loaded http://localhost:56629/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:56629/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:21:23 INFO - PROCESS | 2226 | RSS: Main: 311050240 08:21:23 INFO - PROCESS | 2226 | 08:21:26 INFO - PROCESS | 2226 | Cycle 1(1): loaded http://localhost:56629/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:56629/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:21:27 INFO - PROCESS | 2226 | RSS: Main: 330342400 08:21:27 INFO - PROCESS | 2226 | 08:21:30 INFO - PROCESS | 2226 | Cycle 1(1): loaded http://localhost:56629/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:56629/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:21:30 INFO - PROCESS | 2226 | RSS: Main: 324489216 08:21:30 INFO - PROCESS | 2226 | 08:21:32 INFO - PROCESS | 2226 | Cycle 1(1): loaded http://localhost:56629/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:56629/tests/kraken/driver.html?testName=ai-astar) 08:21:32 INFO - PROCESS | 2226 | RSS: Main: 368136192 08:21:32 INFO - PROCESS | 2226 | 08:21:32 INFO - PROCESS | 2226 | __start_tp_report 08:21:32 INFO - PROCESS | 2226 | _x_x_mozilla_page_load 08:21:32 INFO - PROCESS | 2226 | _x_x_mozilla_page_load_details 08:21:32 INFO - PROCESS | 2226 | |i|pagename|runs| 08:21:32 INFO - PROCESS | 2226 | |0;ai-astar;113;114;113;113;113;114;112;113;114;112 08:21:32 INFO - PROCESS | 2226 | |1;audio-beat-detection;141;113;110;147;107;110;111;112;128;109 08:21:32 INFO - PROCESS | 2226 | |2;audio-dft;185;184;185;186;184;184;181;183;185;228 08:21:32 INFO - PROCESS | 2226 | |3;audio-fft;81;59;60;87;61;60;59;59;75;60 08:21:32 INFO - PROCESS | 2226 | |4;audio-oscillator;89;70;85;68;68;69;84;69;68;84 08:21:32 INFO - PROCESS | 2226 | |5;imaging-gaussian-blur;111;113;111;113;110;113;111;114;111;118 08:21:32 INFO - PROCESS | 2226 | |6;imaging-darkroom;101;126;96;95;96;95;95;95;95;114 08:21:32 INFO - PROCESS | 2226 | |7;imaging-desaturate;85;86;87;87;86;87;87;87;89;88 08:21:32 INFO - PROCESS | 2226 | |8;json-parse-financial;57;57;57;56;54;57;55;55;57;56 08:21:32 INFO - PROCESS | 2226 | |9;json-stringify-tinderbox;65;66;82;76;74;73;71;73;73;73 08:21:32 INFO - PROCESS | 2226 | |10;stanford-crypto-aes;87;87;90;86;88;99;104;105;80;87 08:21:32 INFO - PROCESS | 2226 | |11;stanford-crypto-ccm;141;140;141;138;142;140;137;140;185;159 08:21:32 INFO - PROCESS | 2226 | |12;stanford-crypto-pbkdf2;172;172;171;173;175;180;228;207;178;176 08:21:32 INFO - PROCESS | 2226 | |13;stanford-crypto-sha256-iterative;67;67;66;67;68;67;67;64;67;66 08:21:32 INFO - PROCESS | 2226 | __end_tp_report 08:21:32 INFO - PROCESS | 2226 | __start_cc_report 08:21:32 INFO - PROCESS | 2226 | _x_x_mozilla_cycle_collect,2030 08:21:32 INFO - PROCESS | 2226 | __end_cc_report 08:21:32 INFO - PROCESS | 2226 | __startTimestamp1482078092834__endTimestamp 08:21:32 INFO - PROCESS | 2226 | 08:21:32 INFO - PROCESS | 2226 | ------- Summary: start ------- 08:21:32 INFO - PROCESS | 2226 | Number of tests: 14 08:21:32 INFO - PROCESS | 2226 | 08:21:32 INFO - PROCESS | 2226 | [#0] ai-astar Cycles:10 Average:113.10 Median:113.00 stddev:0.74 (0.7%) stddev-sans-first:0.78 08:21:32 INFO - PROCESS | 2226 | Values: 113.0 114.0 113.0 113.0 113.0 114.0 112.0 113.0 114.0 112.0 08:21:32 INFO - PROCESS | 2226 | 08:21:32 INFO - PROCESS | 2226 | [#1] audio-beat-detection Cycles:10 Average:118.80 Median:112.50 stddev:14.54 (12.9%) stddev-sans-first:13.02 08:21:32 INFO - PROCESS | 2226 | Values: 141.0 113.0 110.0 147.0 107.0 110.0 111.0 112.0 128.0 109.0 08:21:32 INFO - PROCESS | 2226 | 08:21:32 INFO - PROCESS | 2226 | [#2] audio-dft Cycles:10 Average:188.50 Median:185.00 stddev:13.95 (7.5%) stddev-sans-first:14.73 08:21:32 INFO - PROCESS | 2226 | Values: 185.0 184.0 185.0 186.0 184.0 184.0 181.0 183.0 185.0 228.0 08:21:32 INFO - PROCESS | 2226 | 08:21:32 INFO - PROCESS | 2226 | [#3] audio-fft Cycles:10 Average:66.10 Median:60.50 stddev:10.68 (17.7%) stddev-sans-first:9.88 08:21:32 INFO - PROCESS | 2226 | Values: 81.0 59.0 60.0 87.0 61.0 60.0 59.0 59.0 75.0 60.0 08:21:32 INFO - PROCESS | 2226 | 08:21:32 INFO - PROCESS | 2226 | [#4] audio-oscillator Cycles:10 Average:75.40 Median:77.00 stddev:8.82 (11.5%) stddev-sans-first:7.87 08:21:32 INFO - PROCESS | 2226 | Values: 89.0 70.0 85.0 68.0 68.0 69.0 84.0 69.0 68.0 84.0 08:21:32 INFO - PROCESS | 2226 | 08:21:32 INFO - PROCESS | 2226 | [#5] imaging-gaussian-blur Cycles:10 Average:112.50 Median:113.00 stddev:2.32 (2.1%) stddev-sans-first:2.40 08:21:32 INFO - PROCESS | 2226 | Values: 111.0 113.0 111.0 113.0 110.0 113.0 111.0 114.0 111.0 118.0 08:21:32 INFO - PROCESS | 2226 | 08:21:32 INFO - PROCESS | 2226 | [#6] imaging-darkroom Cycles:10 Average:100.80 Median:95.00 stddev:10.66 (11.2%) stddev-sans-first:11.31 08:21:32 INFO - PROCESS | 2226 | Values: 101.0 126.0 96.0 95.0 96.0 95.0 95.0 95.0 95.0 114.0 08:21:32 INFO - PROCESS | 2226 | 08:21:32 INFO - PROCESS | 2226 | [#7] imaging-desaturate Cycles:10 Average:86.90 Median:87.00 stddev:1.10 (1.3%) stddev-sans-first:0.93 08:21:32 INFO - PROCESS | 2226 | Values: 85.0 86.0 87.0 87.0 86.0 87.0 87.0 87.0 89.0 88.0 08:21:32 INFO - PROCESS | 2226 | 08:21:32 INFO - PROCESS | 2226 | [#8] json-parse-financial Cycles:10 Average:56.10 Median:57.00 stddev:1.10 (1.9%) stddev-sans-first:1.12 08:21:32 INFO - PROCESS | 2226 | Values: 57.0 57.0 57.0 56.0 54.0 57.0 55.0 55.0 57.0 56.0 08:21:32 INFO - PROCESS | 2226 | 08:21:32 INFO - PROCESS | 2226 | [#9] json-stringify-tinderbox Cycles:10 Average:72.60 Median:73.00 stddev:4.79 (6.6%) stddev-sans-first:4.22 08:21:32 INFO - PROCESS | 2226 | Values: 65.0 66.0 82.0 76.0 74.0 73.0 71.0 73.0 73.0 73.0 08:21:32 INFO - PROCESS | 2226 | 08:21:32 INFO - PROCESS | 2226 | [#10] stanford-crypto-aes Cycles:10 Average:91.30 Median:87.00 stddev:8.38 (9.6%) stddev-sans-first:8.74 08:21:32 INFO - PROCESS | 2226 | Values: 87.0 87.0 90.0 86.0 88.0 99.0 104.0 105.0 80.0 87.0 08:21:32 INFO - PROCESS | 2226 | 08:21:32 INFO - PROCESS | 2226 | [#11] stanford-crypto-ccm Cycles:10 Average:146.30 Median:141.00 stddev:14.94 (10.6%) stddev-sans-first:15.72 08:21:32 INFO - PROCESS | 2226 | Values: 141.0 140.0 141.0 138.0 142.0 140.0 137.0 140.0 185.0 159.0 08:21:32 INFO - PROCESS | 2226 | 08:21:32 INFO - PROCESS | 2226 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:183.20 Median:177.00 stddev:18.95 (10.7%) stddev-sans-first:19.67 08:21:32 INFO - PROCESS | 2226 | Values: 172.0 172.0 171.0 173.0 175.0 180.0 228.0 207.0 178.0 176.0 08:21:32 INFO - PROCESS | 2226 | 08:21:32 INFO - PROCESS | 2226 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.60 Median:67.00 stddev:1.07 (1.6%) stddev-sans-first:1.13 08:21:32 INFO - PROCESS | 2226 | Values: 67.0 67.0 66.0 67.0 68.0 67.0 67.0 64.0 67.0 66.0 08:21:32 INFO - PROCESS | 2226 | -------- Summary: end -------- 08:21:32 INFO - PROCESS | 2226 | 08:21:33 INFO - TEST-INFO | 2226: exit 0 08:21:33 INFO - TEST-OK | kraken | took 59656ms 08:21:33 INFO - SUITE-END | took 1180s 08:21:33 INFO - Completed test suite (00:19:40) 08:21:33 INFO - javascript benchmark 08:21:34 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3204.7436205103595, 3205.8557364918593, 3219.1308346746396, 3226.370857682752, 3254.0400581828358, 5122.871928201787, 5191.558717509016, 5292.259083728276, 5312.203169524573, 5343.492368225017, 5233.921491177626, 5282.418933917275, 5395.0558652235795, 5395.919061214076, 5419.620626556142, 4839.44346400165, 4847.12751704693, 4852.150873597124, 4925.285833554132, 4935.23503856901, 3972.0, 5018.774155163008, 5033.647644664875, 5040.7731652075745, 5100.234964755279, 4800.903981920377, 4991.351124353847, 5005.974970125162, 5011.298418221452, 5097.515736005093, 4824.49342819006, 4892.804287828518, 4895.681780684244, 4906.484819094015, 4914.04176185644, 4835.685680430761, 4851.296561998526, 4862.5623693867365, 4868.05073010763, 4877.926831097537, 5204.479552044765, 5269.578433725293, 5271.341082364705, 5293.550048245904, 5294.126469132589, 5661.405552416978, 5666.603337766358, 5668.97165514174, 5671.63134396267, 5676.687782171979, 5594.720263986785, 5610.66336019836, 5666.036773748431, 5667.773289068432, 5668.121441176624, 5246.265522826808, 5286.841394758163, 5304.973475132639, 5317.973410133002, 5320.600954928396, 5976.820695379146, 5984.7606095756555, 5993.130996005642, 6038.879222415615, 6069.575129740876, 5698.3162020556965, 5712.171735098387, 5714.7428365723645, 5730.484256416942, 5739.282589676291, 5619.690916999604, 5620.409856965041, 5642.153676948491, 5802.448767367094, 5879.970600146972, 4756.476787553366, 4768.213244814567, 5810.360860305363, 5826.038703613856, 5841.357450680422, 5833.066709326487, 5837.124431335334, 5838.211841401441, 5841.649501029951, 5858.238429004202, 4554.7039442436135, 4598.1033698429155, 4605.0, 4696.459907110726, 4705.176594096088, 4151.91696166075, 4153.356229784388, 4203.684723645678, 4234.957650423518, 4240.98216428055, 5530.723463826793, 5545.861353466115, 5548.72256387179, 5553.805616803393, 5591.888162236733, 5623.887522249532, 5669.951059054089, 5865.736041878125, 5871.295444546682, 5888.057910734347, 5399.70301633414, 5474.7262636868, 5528.695921724344, 5529.170624406372, 5601.215829783833, 5109.9744501277255, 5122.820701275437, 5135.794568217229, 5144.43411224765, 5144.562712169432, 6249.0626406039455, 6289.559730818982, 6298.1812364392335, 6313.40022697843, 6324.620522768557, 5631.521320687623, 5663.858403539944, 5674.205611214351, 5739.110437882135, 5795.681237531976, 6210.503159747119, 6281.497480201664, 6287.811365659038, 6290.056491526308, 6295.150154729053, 5711.685857277889, 5734.655920644775, 5744.511716504144, 5744.798932037359, 5761.164631128379, 5604.579656525695, 5743.540516758733, 5750.741216645178, 5782.392848750989, 5805.245318108618, 5510.8071217507195, 5604.439556044363, 5605.80379686709, 5637.0, 5712.200291959212, 5652.943470565407, 5657.179708942263, 5669.943300566942, 5675.0, 5688.459596338341, 5476.507114359727, 5535.557155427637, 5546.528545073714, 5550.195221692751, 5583.637063590853, 5441.455854414527, 5478.506934375925, 5617.662940223599, 5636.3799982002765, 5675.943240567542, 5535.059039963136, 5572.749226284745, 5588.608797384307, 5600.0, 5625.381208067028], "value": 5336.780298456083, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [425.1751601892329, 437.4641064695748, 447.4228245563224, 495.0989199656626, 508.84734579626127, 29847.55228671569, 31618.367632647332, 31670.049898503054, 37558.24883502328, 39313.41029884554, 40670.593294067054, 40955.0, 41126.17747645045, 41148.38277425834, 41223.79388103055, 9087.136722011399, 9312.44125352481, 9321.161095501404, 9323.673671421502, 9343.018983006788, 8404.705835295767, 8603.31173506118, 9203.493807840567, 9343.906560934405, 10910.5090270938, 11010.0, 11240.325580465198, 11261.66215013551, 11261.887381126166, 11273.267237629569, 11062.612808551663, 11137.276077054965, 11140.33158010522, 11142.665720028372, 11143.997040266333, 8314.70898518555, 8510.191531804468, 11002.889971100267, 11090.168237382148, 11106.944465277622, 39415.21169576621, 40143.0, 40212.59787402118, 40235.39646905299, 40321.59678403208, 3361.9159521011925, 3375.628680845105, 3386.6782655647676, 3437.845296961618, 3462.3248466549035, 29122.563161552593, 29464.968726094485, 30212.8489357554, 30336.089917302517, 30422.0, 3053.40458610571, 3176.9205769855707, 3179.5707579476707, 3180.6501284858646, 3198.296374797541, 427343.0, 448210.0, 449554.0, 457210.0, 459803.7009814963, 57576.71211643915, 57816.71091644515, 58028.83942321214, 58044.41955580474, 58151.546211345056, 60408.395916040274, 60411.0, 60495.69752151211, 60562.69718651378, 60572.697136514034, 15491.457798976982, 15778.526644200692, 15801.604959875865, 15813.920930395505, 15823.841761582236, 12284.1401101922, 12320.81518777219, 12321.753564928651, 12343.567975120828, 12351.0, 14041.297935103205, 14439.35022923971, 14453.205073721047, 15733.292001859943, 16039.03765774034, 6475.384838440341, 6704.357432429086, 6838.521303508806, 6963.1644202696, 7185.856282874313, 744.8361360500681, 844.0673056272852, 1016.9373005209574, 1041.4116024446316, 1074.1567869222622, 28500.0, 28633.427331453255, 28946.565801512996, 29293.707062929523, 29335.266618334284, 1013.3160116921049, 1033.2715435617872, 1095.0, 1126.4592995362273, 1184.680136363177, 11685.240459370114, 12833.807492887614, 12871.22772633645, 14925.0, 15342.539723808304, 515145.0, 519209.0, 519269.0, 521483.0, 522855.0, 44045.11909761787, 47910.08359665644, 49078.0, 54230.186547201825, 54669.1799623006, 1359.4766015084067, 1374.4639590559689, 1404.7471455137968, 1405.142862853638, 1408.845027047024, 24132.15537456251, 24343.89814102419, 24404.87797561001, 29460.410791784474, 30341.848290758404, 48225.0, 48621.0, 48695.26957095575, 48820.77948051327, 48900.0, 698857.0, 714974.0, 715640.0, 718210.0, 719003.0, 23716.762832372147, 23989.280321589682, 24035.399115022265, 24128.638070429308, 24139.0, 39498.0, 39696.801515992236, 40046.39930400988, 40477.79761101293, 40575.57985470494, 32440.83779581087, 33023.174420639676, 33656.83171584126, 34508.58439909182, 34649.48025779565, 33498.49752253767, 33608.0, 34260.82869585636, 34606.0, 34708.0, 28142.859285703442, 31881.8405907969, 32215.516767248042, 32501.0, 33742.49386259257, 28286.0, 29041.10407158778, 29995.850020749756, 30220.0, 30227.942022029125, 19254.61490770205, 21697.478069628392, 22218.44453888601, 22271.554568908854, 22870.885645571667], "value": 18866.7606771216, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [346.11740062839755, 363.96360363963606, 367.93561126802814, 375.59060623919925, 399.6263493633453, 14431.711365772691, 14605.196714180716, 15653.608659783496, 19862.20551177951, 20346.593068138667, 19480.902595487038, 19856.305029323976, 20448.386548403534, 20566.868822214772, 20765.480862978395, 5581.0512212923795, 5813.157092221625, 5818.505427038707, 5820.883582328351, 5829.504492118153, 4704.576588107069, 6330.715117819686, 6375.4580860626675, 6439.323870993549, 6439.388258115471, 6048.576599638027, 6227.159333489989, 6269.122322874801, 6277.748890044393, 6386.201724784402, 6293.0, 6299.559030867864, 6319.273283572402, 6329.525285603599, 6332.430081292706, 5282.102042652758, 5475.780968761244, 5515.889682206373, 5568.52667523261, 5570.721463926828, 24646.383840403952, 25294.98820047196, 25333.366665833317, 25462.98148074075, 25782.871085644638, 2204.6252137136726, 2379.702537182852, 2471.6910386201725, 2597.623344615039, 2830.985845070782, 14262.786058209134, 15176.46882359123, 15704.371825126982, 15739.370425182979, 15763.0, 1745.5985123421558, 1803.1885651456896, 1804.7924488683839, 1809.6380723855282, 1813.2656274208966, 109142.0, 110334.0, 111190.0, 114080.42959785232, 114163.0, 10455.68632941013, 10620.946895265473, 10702.678919632424, 10756.677299681021, 10897.073748731287, 13617.863821361858, 13631.0, 13635.250061246528, 13667.0, 13675.726485470235, 5907.852303692442, 8291.8341633167, 8349.206825351583, 8369.0, 8398.748037558884, 6972.372486476242, 8357.824026869872, 8367.205115514016, 8579.65681372738, 8614.396992210484, 6451.548391612542, 6561.770338038145, 6569.408753212234, 6569.57297775643, 6569.835754106186, 1544.328217225488, 1774.2193434888607, 1813.6191399805925, 1817.8909265444115, 1818.563544749277, 800.3237264511479, 923.4505469245788, 941.4680705401427, 943.2454036770556, 1002.7844013537125, 20049.298274560322, 20867.0, 21689.457763556038, 21760.891195544238, 21923.013464394142, 902.386377263454, 950.1543626172712, 972.2562239886493, 977.672479719302, 1010.4038617215878, 11261.493232804543, 11444.427778611036, 11505.07811720578, 11681.76636467266, 11694.239874408137, 488403.0, 493917.0, 496195.5326254327, 545556.0, 546103.0, 88929.0, 97492.51253743687, 104425.0, 110846.0, 111881.0, 974.8878878929014, 1023.1967905194387, 1044.9341671495033, 1053.3311347294523, 1055.2244100586063, 15415.768763468333, 15646.295916683548, 18696.906515467337, 19238.903805481445, 19342.8065719341, 40969.59030409658, 43039.784801075795, 44193.0, 44543.55456445394, 45564.088718226114, 48970.75514622546, 62476.68761656163, 63299.6835015822, 63742.3625763755, 64914.83309085629, 7449.776506704808, 7744.961275193588, 7950.4832185907735, 8025.558594277138, 8187.549684767157, 12746.68133296675, 12846.935765321488, 12905.935470322589, 12939.870601293867, 13224.206547607175, 10934.890651093705, 11141.331520108819, 11155.776884462428, 11237.71905702364, 11486.368249746343, 8660.826783464421, 10468.581256749645, 10669.199810014436, 10846.891531084588, 11310.377929213972, 9395.85906211421, 11044.282121662067, 11141.387223702774, 11201.97546662413, 11208.327500350006, 7791.805204869924, 7804.619591024565, 7947.0, 7953.721619743281, 7968.84062318762, 10910.399928004035, 11082.390468524309, 11150.219484636322, 11338.0, 11423.828642570534], "value": 9441.681894901407, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1267.2143271171872, 1352.1278775190008, 1497.3711041362624, 1653.4047742812586, 1900.7053906644467, 7546.283103105203, 7886.802829929255, 8208.343332533397, 8487.618057187427, 8491.363147763912, 8349.62426690799, 8426.410151289412, 8427.789305267372, 8442.324614030878, 8445.366597505197, 2053.1889903488186, 2305.5849947009488, 2335.929922102331, 2344.78896899279, 2346.249200255919, 1797.1643185918545, 1884.4723477426273, 2292.1175347491253, 2370.288913326004, 2382.868942208178, 2315.0855412112205, 2334.8832558372096, 2335.532893421314, 2341.906323747048, 2346.5541547105995, 2302.9769702303015, 2327.1273272522803, 2329.94175145621, 2332.3586013846157, 2332.9066837326486, 2321.9883900580558, 2342.730585982617, 2348.473492230047, 2360.1031607989025, 2362.11420717231, 8298.128696486843, 8323.334133269324, 8357.206065423776, 8454.196851299117, 8465.195806398444, 5102.693838369672, 5270.077736396115, 5270.130428479335, 5270.947290527122, 5288.788448462057, 3312.1554003729134, 3320.6181289151814, 3449.5688038995127, 3531.4879342495196, 3534.045807631925, 970.6604885258369, 1004.7638804880847, 1026.5329275179774, 1046.9581216751321, 1064.4252103863905, 10683.305585137019, 10940.945295273552, 11022.952819482136, 11025.558977640885, 11030.393328366936, 4136.9793151034055, 4533.410656614619, 4719.764011799396, 4797.376341075638, 4800.831970881002, 8520.70177543783, 8532.616032278562, 8787.736367908972, 8807.383483156118, 8857.64569417229, 5018.447970723218, 5171.534561889448, 5179.844604661791, 5180.740962951837, 5196.220566914917, 4325.697201195886, 4485.215087359764, 4672.95327046732, 4777.8327758528285, 4824.155772739757, 3110.315730539278, 3622.637736226409, 3694.9445758313645, 3703.8517659757276, 3725.2921944830396, 967.2358836519071, 1146.7534480086822, 1147.428023607663, 1161.7153797319543, 1161.73280145567, 791.8297566023217, 794.3446656508404, 889.8476472967523, 968.3173362779223, 972.1153750087386, 4800.711957282574, 5596.3284405871555, 5792.913106303409, 5950.434708702666, 6148.262208535004, 866.85142186603, 894.8478758611052, 902.9367944243971, 925.634374422113, 946.944157264645, 3595.5505561804775, 3778.886633401002, 3839.308924393636, 3974.18529201513, 3976.960230397659, 10027.247956403298, 10305.0, 10398.27212095146, 10405.115565177044, 10420.32267902584, 9539.14147726708, 9963.252756043326, 9979.301448898508, 10191.286609937233, 10375.481225938673, 7631.809204769926, 7745.8450830983065, 7864.567448790372, 7866.213378661973, 7887.408444366695, 5529.391766905556, 5565.471280228372, 5622.297212848394, 5947.375525569752, 5995.424937578896, 9324.813503730024, 9600.807983840425, 9615.807683846424, 9629.181519570915, 9643.807123857623, 7374.815629609088, 9531.90468095338, 9534.85697714521, 9645.0, 9665.855012174963, 6630.403263706289, 7143.642817858982, 7276.454265930182, 7315.0, 7316.304951029643, 7406.444516661164, 7566.394688425023, 7660.80847978805, 7780.88328675059, 7939.880901786362, 5872.354041055566, 6960.617166055916, 7016.964915175596, 7215.67529461165, 7284.927150728637, 7059.329363710439, 7077.7168913242895, 7104.928950710427, 7140.5358651687475, 7185.173705023989, 5609.27079479665, 6597.307282735435, 6654.4676425884845, 6668.3331666834865, 6727.058211850443, 4814.20565606671, 4825.118203900412, 4833.758312084452, 4894.290327902506, 5006.449290578106, 3580.373434648978, 4784.593309568726, 4927.1131196384995, 4934.0, 5050.368703912011], "value": 4371.06503929294, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [348.75587089037674, 354.13944115798614, 359.72121605755535, 368.8524590163934, 369.53254133521085, 4603.769811509428, 4967.602591792657, 4970.776315065827, 5013.3983921929375, 5077.0, 4707.388039554853, 4780.956091323652, 4790.640701947351, 4913.9189378336705, 4948.505149485059, 3925.9018524536827, 3951.308521008826, 3972.443857859902, 3988.2621714982674, 3997.580254073324, 3936.547297060846, 3954.5056867891512, 3964.484616999786, 3968.583298753633, 3983.5219773627205, 3273.903242413794, 3650.689691376236, 3720.627937206285, 3884.0872394987296, 3958.9904574333505, 3429.696715248215, 3496.702495718988, 3666.651668091527, 3905.9609403905883, 3983.6695533113166, 3001.9943318988167, 3323.7673362864607, 3516.384632689295, 3520.099146460908, 3531.5055892175114, 4120.907959390764, 4761.047970332182, 4797.592204662608, 4881.658283920127, 4928.236123400879, 3493.9126521837156, 3719.3119272934323, 4238.894027649302, 4488.304312831517, 4527.0, 4374.956250437519, 4492.303692927601, 4535.9773201133785, 4588.403507543998, 4919.048570857457, 3834.559025712051, 3886.434952931052, 3888.416737489399, 3897.688184945226, 3897.922041559153, 5145.871353216199, 5439.918401223985, 5520.751566179451, 5528.364238112628, 5550.750216240279, 3365.663433656615, 3388.966110338865, 3575.12409459684, 3641.487373712183, 3663.157473781045, 3120.4851199551817, 3677.2093999790172, 3713.4960341061915, 3715.6098609646137, 3718.8140592970785, 4281.272183728774, 4290.485141782943, 4300.2904520754355, 4302.698811083194, 4318.481782186158, 4916.3362946001835, 4929.827456039022, 5197.168453047494, 5310.575153987749, 5323.733813309319, 1155.8901904319075, 1168.8889555492215, 1199.0347770045198, 1272.9943344757537, 1306.6798634334648, 865.7272959017889, 891.028778631295, 892.0856122474515, 900.9773906616037, 926.0876290460178, 4039.6970227233073, 4192.748435093904, 4302.0, 4657.322039827113, 4766.998930224691, 4650.67445278834, 4762.9761851191215, 5117.462666419972, 5158.105630249138, 5198.376194856642, 4541.704789188692, 4705.976470117627, 4706.670533062721, 4757.500462451462, 4822.662413631082, 2325.453518423169, 2394.9642803616784, 2663.920082397531, 2682.9731702682725, 2702.8378297302224, 4817.662763606584, 4917.729524876167, 5168.095583272912, 5336.879255356341, 5354.598405119632, 4524.47968483622, 4877.609791216694, 5219.347581552306, 5236.816711415082, 5305.734713264322, 4873.636286401093, 5019.499747826646, 5287.9735601321745, 5357.8392648220615, 5477.534409575151, 4097.848629469552, 4521.706089104197, 5061.240813877947, 5073.492650734897, 5211.55701765339, 4311.762853043113, 4809.5430934061205, 4981.128302547112, 5036.773345199402, 5086.669366491166, 4911.705297682151, 5143.434222235476, 5181.005312954464, 5404.459554044564, 5406.162044883049, 3208.2620997170316, 3296.571445712042, 3667.1213097718164, 3743.73793834429, 3757.4363845423404, 4010.3382941814275, 4176.874693759192, 4564.0, 4598.321612611306, 5074.340335756328, 4125.555161440231, 4949.133901567283, 4981.402231732215, 4983.227599722049, 4997.8250761224635, 4380.540043295408, 4768.499307572655, 4921.8523444296725, 4951.687802732351, 4961.975190124026, 4548.135854187693, 4743.525647435229, 4803.0, 4855.514448555116, 5170.224466330081, 5084.771185296744, 5170.767315470737, 5238.7688893109325, 5239.4236633970995, 5307.99148161848, 5173.948260517347, 5175.094358487325, 5175.981367266693, 5212.739363031757, 5217.478252174752], "value": 3796.3142188062143, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [730.2989130434786, 732.3226015935259, 737.9667914943827, 773.0723132241312, 808.7695006923028, 15180.165090919994, 15815.60460988473, 15827.208639568033, 15827.366905323788, 15888.761668574965, 14141.292935353242, 14190.148591084542, 14258.001939864187, 14322.641933951656, 14343.282835858192, 542.8859939412728, 701.5790525684599, 707.3951771235596, 754.6076040458958, 844.8014716541608, 837.9916200837974, 857.0957639690124, 869.026690107081, 871.9084496127911, 875.1379890807549, 893.6246776353914, 898.1961144775422, 899.1952202778509, 915.5925613102172, 933.0156684697641, 721.783464960515, 746.8730315846265, 897.6768363389175, 929.2798081486834, 933.4212788071371, 678.0168755304778, 681.6353251010686, 681.9727210911558, 682.4233522673383, 685.5612408058846, 14439.989200755952, 14781.260936953217, 14840.257987100602, 14853.257337133207, 14888.255587220596, 12455.439505222286, 12622.495100195982, 12660.240385576803, 13049.673758156123, 13475.932620336933, 12613.621591352274, 12886.162399444007, 12946.31697879279, 13057.21656700601, 13234.602961911158, 4345.717528360647, 4381.9123617527475, 4387.3638322443385, 4523.95476045242, 4533.229351010336, 97936.0, 98510.50744746302, 98654.0, 100719.0, 101472.49263753709, 10383.53274102652, 10513.211509136845, 10564.10205132557, 10682.51928663212, 10749.89250107489, 20007.099680514413, 20393.286234981704, 20443.795562044488, 20506.179752810018, 20572.485687857923, 7547.245275472409, 7553.395728341719, 7642.961785191039, 7703.653335599912, 7718.961405192938, 4223.450951376301, 4233.184932020172, 4326.15639950213, 4392.868213953587, 4494.280915053576, 3391.0505058583635, 3480.973112931691, 3499.825008749603, 3503.159241781954, 3504.7021003215013, 507.6294305157182, 509.2946269416884, 519.4675457655858, 520.2378515474848, 520.3001962360695, 548.8380927626359, 553.3138907754355, 554.717094281911, 565.8245943757448, 617.9391728585218, 8549.316054715608, 8821.69124080667, 8947.821043579092, 9050.818983620291, 9051.321150913707, 596.1326270276737, 608.528390497368, 617.7745123030152, 632.4150161101055, 642.7177780328275, 4139.234241665302, 4323.913521729548, 4327.956720432819, 4346.913061738811, 4396.669765024542, 102121.48939255257, 107332.0, 107977.4601127005, 110256.4487177575, 110755.0, 82132.0, 85071.0, 86373.56813215894, 86602.56698716467, 88395.55802220947, 67060.32939670736, 69489.95765063528, 70440.0, 70946.64526677334, 77530.22469775342, 9634.7591310215, 9890.406575605486, 9900.455474948947, 9917.900820991697, 9954.751131221778, 47465.76267118642, 49254.33575138905, 50480.49519504905, 53027.93944121019, 53330.20004699855, 68739.3126068733, 72813.63593182, 73828.63085684537, 74190.62904685442, 75744.0, 12235.0, 12747.49010039588, 12921.224726516439, 13117.540886068942, 13390.129641573267, 14289.857101429268, 14431.567052988426, 14667.559973200821, 15089.849101508844, 15213.6196595086, 12614.810777838156, 13161.078724489194, 13561.660958476117, 13589.388477518338, 13636.250006249751, 13197.868021320048, 13218.537351192663, 13535.59393218205, 13781.242031688353, 13976.301184940916, 13146.60560183196, 13305.268210248529, 13305.66735831612, 13329.66675833112, 13337.0, 10801.729956751144, 10913.214862036137, 11402.600908968147, 11408.942955285502, 11522.539098436304, 9500.239980801382, 11261.380624065427, 11289.322640641587, 11290.94354528255, 11547.307161570332], "value": 7327.111474122841, "unit": "score"}], "name": "dromaeo_css", "value": 6979.533327007571, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 114.0, 113.0, 113.0, 113.0, 114.0, 112.0, 113.0, 114.0, 112.0], "value": 113.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 113.0, 110.0, 147.0, 107.0, 110.0, 111.0, 112.0, 128.0, 109.0], "value": 118.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [185.0, 184.0, 185.0, 186.0, 184.0, 184.0, 181.0, 183.0, 185.0, 228.0], "value": 188.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 59.0, 60.0, 87.0, 61.0, 60.0, 59.0, 59.0, 75.0, 60.0], "value": 66.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 70.0, 85.0, 68.0, 68.0, 69.0, 84.0, 69.0, 68.0, 84.0], "value": 75.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 113.0, 111.0, 113.0, 110.0, 113.0, 111.0, 114.0, 111.0, 118.0], "value": 112.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 126.0, 96.0, 95.0, 96.0, 95.0, 95.0, 95.0, 95.0, 114.0], "value": 100.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 86.0, 87.0, 87.0, 86.0, 87.0, 87.0, 87.0, 89.0, 88.0], "value": 86.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 57.0, 57.0, 56.0, 54.0, 57.0, 55.0, 55.0, 57.0, 56.0], "value": 56.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 66.0, 82.0, 76.0, 74.0, 73.0, 71.0, 73.0, 73.0, 73.0], "value": 72.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 87.0, 90.0, 86.0, 88.0, 99.0, 104.0, 105.0, 80.0, 87.0], "value": 91.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 140.0, 141.0, 138.0, 142.0, 140.0, 137.0, 140.0, 185.0, 159.0], "value": 146.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [172.0, 172.0, 171.0, 173.0, 175.0, 180.0, 228.0, 207.0, 178.0, 176.0], "value": 183.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 67.0, 66.0, 67.0, 68.0, 67.0, 67.0, 64.0, 67.0, 66.0], "value": 66.6, "unit": "score"}], "name": "kraken", "value": 1478.1999999999998, "alertThreshold": 2.0}]} 08:21:34 INFO - Return code: 0 08:21:34 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 08:21:34 INFO - # TBPL SUCCESS # 08:21:34 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 08:21:34 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 08:21:34 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 08:21:34 INFO - 2016-12-18 08:21:34.158 screenresolution[2230:31351] starting screenresolution argv=screenresolution get 08:21:34 INFO - 2016-12-18 08:21:34.161 screenresolution[2230:31351] Display 0: 1600x1200x32@60 08:21:34 INFO - 2016-12-18 08:21:34.167 screenresolution[2231:31354] starting screenresolution argv=screenresolution list 08:21:34 INFO - Available Modes on Display 0 08:21:34 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 08:21:34 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 08:21:34 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 08:21:34 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 08:21:34 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 08:21:34 INFO - Intel Iris: 08:21:34 INFO - Chipset Model: Intel Iris 08:21:34 INFO - Type: GPU 08:21:34 INFO - Bus: Built-In 08:21:34 INFO - VRAM (Dynamic, Max): 1536 MB 08:21:34 INFO - Vendor: Intel (0x8086) 08:21:34 INFO - Device ID: 0x0a2e 08:21:34 INFO - Revision ID: 0x0009 08:21:34 INFO - Displays: 08:21:34 INFO - Display: 08:21:34 INFO - Resolution: 1600 x 1200 @ 60 Hz 08:21:34 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 08:21:34 INFO - Display Serial Number: 1600x1200 60 08:21:34 INFO - Main Display: Yes 08:21:34 INFO - Mirror: Off 08:21:34 INFO - Online: Yes 08:21:34 INFO - Rotation: Supported 08:21:34 INFO - Return code: 0 08:21:34 INFO - Running post-action listener: _resource_record_post_action 08:21:34 INFO - [mozharness: 2016-12-18 16:21:34.406470Z] Finished run-tests step (success) 08:21:34 INFO - Running post-run listener: _resource_record_post_run 08:21:34 INFO - Total resource usage - Wall time: 1203s; CPU: 54.0%; Read bytes: 528384; Write bytes: 552466432; Read time: 5; Write time: 1750 08:21:34 INFO - TinderboxPrint: CPU usage
53.7% 08:21:34 INFO - TinderboxPrint: I/O read bytes / time
528,384 / 5 08:21:34 INFO - TinderboxPrint: I/O write bytes / time
552,466,432 / 1,750 08:21:34 INFO - TinderboxPrint: CPU idle
2,229.8 (46.3%) 08:21:34 INFO - TinderboxPrint: CPU system
963.8 (20.0%) 08:21:34 INFO - TinderboxPrint: CPU user
1,620.1 (33.7%) 08:21:34 INFO - TinderboxPrint: Swap in / out
249,376,768 / 0 08:21:34 INFO - install - Wall time: 22s; CPU: 54.0%; Read bytes: 247407104; Write bytes: 241381376; Read time: 18052; Write time: 494 08:21:34 INFO - run-tests - Wall time: 1182s; CPU: 54.0%; Read bytes: 458752; Write bytes: 299522048; Read time: 3; Write time: 1222 08:21:34 INFO - Running post-run listener: _upload_blobber_files 08:21:34 INFO - Blob upload gear active. 08:21:34 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:21:34 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 08:21:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 08:21:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 08:21:35 INFO - (blobuploader) - INFO - Open directory for files ... 08:21:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 08:21:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:21:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:21:36 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 08:21:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:21:36 INFO - (blobuploader) - INFO - Done attempting. 08:21:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 08:21:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:21:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:21:37 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 08:21:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:21:37 INFO - (blobuploader) - INFO - Done attempting. 08:21:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 08:21:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:21:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:21:38 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 08:21:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:21:38 INFO - (blobuploader) - INFO - Done attempting. 08:21:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 08:21:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:21:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:21:41 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 08:21:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:21:41 INFO - (blobuploader) - INFO - Done attempting. 08:21:41 INFO - (blobuploader) - INFO - Iteration through files over. 08:21:41 INFO - Return code: 0 08:21:41 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:21:41 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:21:41 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/74da016a0817f46caa3922f3c4594f300123f33f89496e7ea7df3a9135bccdbd344a0c913775396a5742c577cbd41c67a0559dc0597e541d158fdd4a5a09bd0b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/128910111c28a40da0eef9118411b6327b07188ebddfa15ea11eaf84e1cfbad346eecf8d840e25d6038319b6d95cea622b5264053f2d68f405c63be5d51b03ab", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7ac2a90b6346bd39f411181f57e3fa9b1dd51e3f71ea1d24b3ba0d19aead35efee1c54cc32c9c9225dbfa8ffd53ebff6125d6bc9607762ebfbcb68e9673afc09", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c7e7de934ef6c48e391f52db65d86cf49ad4d3f1cace22cf9e626a6583b76c5bea0b817b6e4aa0e0155826bdd0f4bc5fb01e653e6f64cc74bd8808b2d164cf23"} 08:21:41 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:21:41 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:21:41 INFO - Contents: 08:21:41 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/74da016a0817f46caa3922f3c4594f300123f33f89496e7ea7df3a9135bccdbd344a0c913775396a5742c577cbd41c67a0559dc0597e541d158fdd4a5a09bd0b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/128910111c28a40da0eef9118411b6327b07188ebddfa15ea11eaf84e1cfbad346eecf8d840e25d6038319b6d95cea622b5264053f2d68f405c63be5d51b03ab", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7ac2a90b6346bd39f411181f57e3fa9b1dd51e3f71ea1d24b3ba0d19aead35efee1c54cc32c9c9225dbfa8ffd53ebff6125d6bc9607762ebfbcb68e9673afc09", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c7e7de934ef6c48e391f52db65d86cf49ad4d3f1cace22cf9e626a6583b76c5bea0b817b6e4aa0e0155826bdd0f4bc5fb01e653e6f64cc74bd8808b2d164cf23"} 08:21:41 INFO - Running post-run listener: copy_logs_to_upload_dir 08:21:41 INFO - Copying logs to upload dir... 08:21:41 INFO - mkdir: /builds/slave/test/build/upload/logs 08:21:41 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1265.871602 ========= master_lag: 0.07 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 5 secs) (at 2016-12-18 08:21:41.109922) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-18 08:21:41.114509) ========= 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.9Ap333bYcz/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.4vSwSpYsC7/Listeners TMPDIR=/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/74da016a0817f46caa3922f3c4594f300123f33f89496e7ea7df3a9135bccdbd344a0c913775396a5742c577cbd41c67a0559dc0597e541d158fdd4a5a09bd0b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/128910111c28a40da0eef9118411b6327b07188ebddfa15ea11eaf84e1cfbad346eecf8d840e25d6038319b6d95cea622b5264053f2d68f405c63be5d51b03ab", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7ac2a90b6346bd39f411181f57e3fa9b1dd51e3f71ea1d24b3ba0d19aead35efee1c54cc32c9c9225dbfa8ffd53ebff6125d6bc9607762ebfbcb68e9673afc09", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c7e7de934ef6c48e391f52db65d86cf49ad4d3f1cace22cf9e626a6583b76c5bea0b817b6e4aa0e0155826bdd0f4bc5fb01e653e6f64cc74bd8808b2d164cf23"} build_url:https://queue.taskcluster.net/v1/task/LxqZjBktTqumWn3nkUrvRg/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011319 build_url: 'https://queue.taskcluster.net/v1/task/LxqZjBktTqumWn3nkUrvRg/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/74da016a0817f46caa3922f3c4594f300123f33f89496e7ea7df3a9135bccdbd344a0c913775396a5742c577cbd41c67a0559dc0597e541d158fdd4a5a09bd0b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/128910111c28a40da0eef9118411b6327b07188ebddfa15ea11eaf84e1cfbad346eecf8d840e25d6038319b6d95cea622b5264053f2d68f405c63be5d51b03ab", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7ac2a90b6346bd39f411181f57e3fa9b1dd51e3f71ea1d24b3ba0d19aead35efee1c54cc32c9c9225dbfa8ffd53ebff6125d6bc9607762ebfbcb68e9673afc09", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c7e7de934ef6c48e391f52db65d86cf49ad4d3f1cace22cf9e626a6583b76c5bea0b817b6e4aa0e0155826bdd0f4bc5fb01e653e6f64cc74bd8808b2d164cf23"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-18 08:21:41.152443) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-18 08:21:41.152846) ========= 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.9Ap333bYcz/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.4vSwSpYsC7/Listeners TMPDIR=/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/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.005320 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-18 08:21:41.201901) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-18 08:21:41.205227) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-18 08:21:41.205559) ========= ========= Total master_lag: 0.25 =========