builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0375 starttime: 1481689475.09 results: success (0) buildid: 20161213192101 builduid: fa426178699f4adcbd9ca49d2dbd9530 revision: 0c7a106074f7267cbd1c8bb9039625f00c38063b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-12-13 20:24:35.085784) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-12-13 20:24:35.086219) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-13 20:24:35.086520) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-13 20:24:35.220702) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 4 secs) (at 2016-12-13 20:24:35.220996) ========= 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.pG8HC6rqle/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.lly8clOXCA/Listeners TMPDIR=/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/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-13 20:24:35-- 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% 18.1M=0.001s 2016-12-13 20:24:35 (18.1 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.145409 ========= master_lag: 4.68 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 4 secs) (at 2016-12-13 20:24:40.048985) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 1 secs) (at 2016-12-13 20:24:40.049277) ========= 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.pG8HC6rqle/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.lly8clOXCA/Listeners TMPDIR=/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/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.025336 ========= master_lag: 1.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 1 secs) (at 2016-12-13 20:24:41.084914) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-12-13 20:24:41.085265) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 0c7a106074f7267cbd1c8bb9039625f00c38063b --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 0c7a106074f7267cbd1c8bb9039625f00c38063b --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.pG8HC6rqle/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.lly8clOXCA/Listeners TMPDIR=/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/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-13 20:24:41,908 truncating revision to first 12 chars 2016-12-13 20:24:41,908 Setting DEBUG logging. 2016-12-13 20:24:41,908 attempt 1/10 2016-12-13 20:24:41,908 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/0c7a106074f7?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-12-13 20:24:42,919 unpacking tar archive at: mozilla-central-0c7a106074f7/testing/mozharness/ program finished with exit code 0 elapsedTime=1.279131 ========= master_lag: 1.31 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-12-13 20:24:43.678286) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-13 20:24:43.678655) ========= script_repo_revision: 0c7a106074f7267cbd1c8bb9039625f00c38063b ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-13 20:24:43.679087) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-13 20:24:43.679370) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-13 20:24:43.702876) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 7 secs) (at 2016-12-13 20:24:43.703272) ========= /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.pG8HC6rqle/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.lly8clOXCA/Listeners TMPDIR=/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/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 20:24:43 INFO - MultiFileLogger online at 20161213 20:24:43 in /builds/slave/test 20:24:43 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 20:24:43 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 20:24:43 INFO - {'append_to_log': False, 20:24:43 INFO - 'base_work_dir': '/builds/slave/test', 20:24:43 INFO - 'blob_upload_branch': 'Firefox', 20:24:43 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 20:24:43 INFO - 'branch': 'Firefox', 20:24:43 INFO - 'buildbot_json_path': 'buildprops.json', 20:24:43 INFO - 'config_files': ('talos/mac_config.py',), 20:24:43 INFO - 'default_actions': ('clobber', 20:24:43 INFO - 'read-buildbot-config', 20:24:43 INFO - 'download-and-extract', 20:24:43 INFO - 'populate-webroot', 20:24:43 INFO - 'create-virtualenv', 20:24:43 INFO - 'install', 20:24:43 INFO - 'run-tests'), 20:24:43 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 20:24:43 INFO - 'download_minidump_stackwalk': True, 20:24:43 INFO - 'download_symbols': 'ondemand', 20:24:43 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 20:24:43 INFO - 'tooltool.py': '/tools/tooltool.py', 20:24:43 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 20:24:43 INFO - '/tools/misc-python/virtualenv.py')}, 20:24:43 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 20:24:43 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 20:24:43 INFO - 'installer_path': 'installer.exe', 20:24:43 INFO - 'log_level': 'info', 20:24:43 INFO - 'log_name': 'talos', 20:24:43 INFO - 'log_to_console': True, 20:24:43 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 20:24:43 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 20:24:43 INFO - 'opt_config_files': (), 20:24:43 INFO - 'pip_index': False, 20:24:43 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 20:24:43 INFO - 'cmd': ('bash', 20:24:43 INFO - '-c', 20:24:43 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 20:24:43 INFO - 'enabled': True, 20:24:43 INFO - 'halt_on_failure': False, 20:24:43 INFO - 'name': 'check_screen_resolution'},), 20:24:43 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 20:24:43 INFO - 'cmd': ('bash', 20:24:43 INFO - '-c', 20:24:43 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 20:24:43 INFO - 'enabled': True, 20:24:43 INFO - 'halt_on_failure': False, 20:24:43 INFO - 'name': 'check_screen_resolution'},), 20:24:43 INFO - 'run_cmd_checks_enabled': True, 20:24:43 INFO - 'sps_profile': False, 20:24:43 INFO - 'sps_profile_interval': 0, 20:24:43 INFO - 'suite': 'dromaeojs', 20:24:43 INFO - 'system_bits': '32', 20:24:43 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 20:24:43 INFO - 'title': 't-yosemite-r7-0375', 20:24:43 INFO - 'tooltool_cache': '/builds/tooltool_cache', 20:24:43 INFO - 'use_talos_json': True, 20:24:43 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 20:24:43 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 20:24:43 INFO - 'work_dir': 'build'} 20:24:43 INFO - [mozharness: 2016-12-14 04:24:43.917304Z] Running clobber step. 20:24:43 INFO - Running pre-action listener: _resource_record_pre_action 20:24:43 INFO - Running main action method: clobber 20:24:43 INFO - rmtree: /builds/slave/test/build 20:24:43 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 20:24:46 INFO - Running post-action listener: _resource_record_post_action 20:24:46 INFO - [mozharness: 2016-12-14 04:24:46.206890Z] Finished clobber step (success) 20:24:46 INFO - [mozharness: 2016-12-14 04:24:46.207039Z] Running read-buildbot-config step. 20:24:46 INFO - Running pre-action listener: _resource_record_pre_action 20:24:46 INFO - Running main action method: read_buildbot_config 20:24:46 INFO - Using buildbot properties: 20:24:46 INFO - { 20:24:46 INFO - "project": "", 20:24:46 INFO - "product": "firefox", 20:24:46 INFO - "script_repo_revision": "production", 20:24:46 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 20:24:46 INFO - "repository": "", 20:24:46 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 20:24:46 INFO - "buildid": "20161213192101", 20:24:46 INFO - "pgo_build": "False", 20:24:46 INFO - "basedir": "/builds/slave/test", 20:24:46 INFO - "buildnumber": 46, 20:24:46 INFO - "slavename": "t-yosemite-r7-0375", 20:24:46 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 20:24:46 INFO - "platform": "yosemite_r7", 20:24:46 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 20:24:46 INFO - "branch": "mozilla-central", 20:24:46 INFO - "repo_path": "mozilla-central", 20:24:46 INFO - "revision": "0c7a106074f7267cbd1c8bb9039625f00c38063b", 20:24:46 INFO - "stage_platform": "macosx64", 20:24:46 INFO - "builduid": "fa426178699f4adcbd9ca49d2dbd9530", 20:24:46 INFO - "slavebuilddir": "test" 20:24:46 INFO - } 20:24:46 INFO - Found installer url https://queue.taskcluster.net/v1/task/E0hfPTjcQJKALmqBhNwaRw/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg. 20:24:46 INFO - Running post-action listener: _resource_record_post_action 20:24:46 INFO - [mozharness: 2016-12-14 04:24:46.210405Z] Finished read-buildbot-config step (success) 20:24:46 INFO - [mozharness: 2016-12-14 04:24:46.210535Z] Running download-and-extract step. 20:24:46 INFO - Running pre-action listener: _resource_record_pre_action 20:24:46 INFO - Running main action method: download_and_extract 20:24:46 INFO - mkdir: /builds/slave/test/build/tests 20:24:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:24:46 INFO - trying https://queue.taskcluster.net/v1/task/E0hfPTjcQJKALmqBhNwaRw/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json 20:24:46 INFO - Downloading https://queue.taskcluster.net/v1/task/E0hfPTjcQJKALmqBhNwaRw/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 20:24:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/E0hfPTjcQJKALmqBhNwaRw/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 20:24:47 INFO - Downloaded 1199 bytes. 20:24:47 INFO - Reading from file /builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json 20:24:47 INFO - Using the following test package requirements: 20:24:47 INFO - {u'common': [u'firefox-53.0a1.en-US.mac.common.tests.zip'], 20:24:47 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 20:24:47 INFO - u'firefox-53.0a1.en-US.mac.cppunittest.tests.zip'], 20:24:47 INFO - u'gtest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 20:24:47 INFO - u'firefox-53.0a1.en-US.mac.gtest.tests.zip'], 20:24:47 INFO - u'jittest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 20:24:47 INFO - u'jsshell-mac.zip'], 20:24:47 INFO - u'mochitest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 20:24:47 INFO - u'firefox-53.0a1.en-US.mac.mochitest.tests.zip'], 20:24:47 INFO - u'mozbase': [u'firefox-53.0a1.en-US.mac.common.tests.zip'], 20:24:47 INFO - u'reftest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 20:24:47 INFO - u'firefox-53.0a1.en-US.mac.reftest.tests.zip'], 20:24:47 INFO - u'talos': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 20:24:47 INFO - u'firefox-53.0a1.en-US.mac.talos.tests.zip'], 20:24:47 INFO - u'web-platform': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 20:24:47 INFO - u'firefox-53.0a1.en-US.mac.web-platform.tests.zip'], 20:24:47 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 20:24:47 INFO - u'firefox-53.0a1.en-US.mac.xpcshell.tests.zip']} 20:24:47 INFO - Downloading packages: [u'firefox-53.0a1.en-US.mac.common.tests.zip'] for test suite category: common 20:24:47 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/E0hfPTjcQJKALmqBhNwaRw/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip 20:24:47 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/E0hfPTjcQJKALmqBhNwaRw/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip'}, attempt #1 20:24:47 INFO - Fetch https://queue.taskcluster.net/v1/task/E0hfPTjcQJKALmqBhNwaRw/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip into memory 20:24:48 INFO - Expected file size: 16276469 20:24:48 INFO - Obtained file size: 16276469 20:24:54 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 20:24:54 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/E0hfPTjcQJKALmqBhNwaRw/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip 20:24:54 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/E0hfPTjcQJKALmqBhNwaRw/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip'}, attempt #1 20:24:54 INFO - Fetch https://queue.taskcluster.net/v1/task/E0hfPTjcQJKALmqBhNwaRw/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip into memory 20:24:55 INFO - Expected file size: 16276469 20:24:55 INFO - Obtained file size: 16276469 20:25:02 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/E0hfPTjcQJKALmqBhNwaRw/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip 20:25:02 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/E0hfPTjcQJKALmqBhNwaRw/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip'}, attempt #1 20:25:02 INFO - Fetch https://queue.taskcluster.net/v1/task/E0hfPTjcQJKALmqBhNwaRw/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip into memory 20:25:03 INFO - Expected file size: 14409734 20:25:03 INFO - Obtained file size: 14409734 20:25: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')]} 20:25:03 INFO - trying https://queue.taskcluster.net/v1/task/E0hfPTjcQJKALmqBhNwaRw/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 20:25:03 INFO - Downloading https://queue.taskcluster.net/v1/task/E0hfPTjcQJKALmqBhNwaRw/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg 20:25:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/E0hfPTjcQJKALmqBhNwaRw/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 20:25:05 INFO - Downloaded 69690557 bytes. 20:25:05 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/E0hfPTjcQJKALmqBhNwaRw/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 20:25:05 INFO - mkdir: /builds/slave/test/properties 20:25:05 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 20:25:05 INFO - Writing to file /builds/slave/test/properties/build_url 20:25:05 INFO - Contents: 20:25:05 INFO - build_url:https://queue.taskcluster.net/v1/task/E0hfPTjcQJKALmqBhNwaRw/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 20:25:06 INFO - Running post-action listener: _resource_record_post_action 20:25:06 INFO - Running post-action listener: set_extra_try_arguments 20:25:06 INFO - [mozharness: 2016-12-14 04:25:06.238801Z] Finished download-and-extract step (success) 20:25:06 INFO - [mozharness: 2016-12-14 04:25:06.238901Z] Running populate-webroot step. 20:25:06 INFO - Running pre-action listener: _resource_record_pre_action 20:25:06 INFO - Running main action method: populate_webroot 20:25:06 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 20:25:06 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 20:25:06 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 20:25:06 INFO - '--tppagecycles', 20:25:06 INFO - '7'], 20:25:06 INFO - 'tests': ['tsvgm']}}, 20:25:06 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 20:25:06 INFO - 'tests': ['tresize', 'tcanvasmark']}, 20:25:06 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 20:25:06 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 20:25:06 INFO - 'tests': ['dromaeo_css', 'kraken']}, 20:25:06 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 20:25:06 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 20:25:06 INFO - 'talos_options': ['--disable-e10s'], 20:25:06 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:25:06 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 20:25:06 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:25:06 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 20:25:06 INFO - 'talos_options': ['--disable-e10s'], 20:25:06 INFO - 'tests': ['damp', 'tps']}, 20:25:06 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 20:25:06 INFO - 'tests': ['damp', 'tps']}, 20:25:06 INFO - 'g3': {'talos_options': ['--disable-e10s'], 20:25:06 INFO - 'tests': ['dromaeo_dom']}, 20:25:06 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 20:25:06 INFO - 'g4': {'talos_options': ['--disable-e10s'], 20:25:06 INFO - 'tests': ['basic_compositor_video']}, 20:25:06 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 20:25:06 INFO - 'other': {'talos_options': ['--disable-e10s'], 20:25:06 INFO - 'tests': ['a11yr', 20:25:06 INFO - 'ts_paint', 20:25:06 INFO - 'tpaint', 20:25:06 INFO - 'sessionrestore', 20:25:06 INFO - 'sessionrestore_no_auto_restore', 20:25:06 INFO - 'tabpaint']}, 20:25:06 INFO - 'other-e10s': {'tests': ['a11yr', 20:25:06 INFO - 'ts_paint', 20:25:06 INFO - 'tpaint', 20:25:06 INFO - 'sessionrestore', 20:25:06 INFO - 'sessionrestore_no_auto_restore', 20:25:06 INFO - 'tabpaint']}, 20:25:06 INFO - 'other-e10s_l64': {'tests': ['a11yr', 20:25:06 INFO - 'ts_paint', 20:25:06 INFO - 'tpaint', 20:25:06 INFO - 'sessionrestore', 20:25:06 INFO - 'sessionrestore_no_auto_restore', 20:25:06 INFO - 'tabpaint']}, 20:25:06 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 20:25:06 INFO - 'ts_paint', 20:25:06 INFO - 'tpaint', 20:25:06 INFO - 'sessionrestore', 20:25:06 INFO - 'sessionrestore_no_auto_restore', 20:25:06 INFO - 'tabpaint']}, 20:25:06 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 20:25:06 INFO - 'tests': ['a11yr', 20:25:06 INFO - 'ts_paint', 20:25:06 INFO - 'tpaint', 20:25:06 INFO - 'sessionrestore', 20:25:06 INFO - 'sessionrestore_no_auto_restore', 20:25:06 INFO - 'tabpaint']}, 20:25:06 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 20:25:06 INFO - 'tests': ['a11yr', 20:25:06 INFO - 'ts_paint', 20:25:06 INFO - 'tpaint', 20:25:06 INFO - 'sessionrestore', 20:25:06 INFO - 'sessionrestore_no_auto_restore', 20:25:06 INFO - 'tabpaint']}, 20:25:06 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 20:25:06 INFO - 'tests': ['tsvgx', 20:25:06 INFO - 'tsvgr_opacity', 20:25:06 INFO - 'tart', 20:25:06 INFO - 'tscrollx', 20:25:06 INFO - 'cart', 20:25:06 INFO - 'tsvg_static']}, 20:25:06 INFO - 'svgr-e10s': {'tests': ['tsvgx', 20:25:06 INFO - 'tsvgr_opacity', 20:25:06 INFO - 'tart', 20:25:06 INFO - 'tscrollx', 20:25:06 INFO - 'cart', 20:25:06 INFO - 'tsvg_static']}, 20:25:06 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 20:25:06 INFO - 'talos_options': ['--disable-e10s'], 20:25:06 INFO - 'tests': ['tp5o']}, 20:25:06 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 20:25:06 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 20:25:06 INFO - 'talos_options': ['--disable-e10s', 20:25:06 INFO - '--xperf_path', 20:25:06 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:25:06 INFO - 'tests': ['tp5n']}, 20:25:06 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 20:25:06 INFO - 'talos_options': ['--xperf_path', 20:25:06 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:25:06 INFO - 'tests': ['tp5n']}}, 20:25:06 INFO - 'talos.zip': {'path': '', 20:25:06 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 20:25:06 INFO - Running post-action listener: _resource_record_post_action 20:25:06 INFO - [mozharness: 2016-12-14 04:25:06.257545Z] Finished populate-webroot step (success) 20:25:06 INFO - [mozharness: 2016-12-14 04:25:06.257682Z] Running create-virtualenv step. 20:25:06 INFO - Running pre-action listener: _resource_record_pre_action 20:25:06 INFO - Running main action method: create_virtualenv 20:25:06 INFO - Creating virtualenv /builds/slave/test/build/venv 20:25:06 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 20:25:06 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 20:25:06 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 20:25:06 INFO - Using real prefix '/tools/python27' 20:25:06 INFO - New python executable in /builds/slave/test/build/venv/bin/python 20:25:07 INFO - Installing distribute.............................................................................................................................................................................................done. 20:25:09 INFO - Installing pip.................done. 20:25:09 INFO - Return code: 0 20:25:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 20:25:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 20:25:10 INFO - Reading from file tmpfile_stdout 20:25:10 INFO - Output received: 20:25:10 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) 20:25:10 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 20:25:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:25:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:25:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:25:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:25:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:25:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:25:10 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10af3c3f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10aeb2570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdc7a497550>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ad51d30>, '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 0x10abb8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ad49b20>, '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.pG8HC6rqle/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.lly8clOXCA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/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 20:25:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 20:25:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 20:25:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.pG8HC6rqle/Render', 20:25:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:25:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:25:10 INFO - 'HOME': '/Users/cltbld', 20:25:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:25:10 INFO - 'LOGNAME': 'cltbld', 20:25:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:25:10 INFO - 'MOZ_NO_REMOTE': '1', 20:25:10 INFO - 'NO_EM_RESTART': '1', 20:25:10 INFO - 'PAGER': '/bin/cat', 20:25:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:25:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:25:10 INFO - 'PWD': '/builds/slave/test', 20:25:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:25:10 INFO - 'SHELL': '/bin/bash', 20:25:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lly8clOXCA/Listeners', 20:25:10 INFO - 'TMPDIR': '/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/', 20:25:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:25:10 INFO - 'USER': 'cltbld', 20:25:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:25:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:25:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:25:10 INFO - 'XPC_FLAGS': '0x0', 20:25:10 INFO - 'XPC_SERVICE_NAME': '0', 20:25:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:25:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:25:11 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 20:25:11 INFO - Cleaning up... 20:25:11 INFO - Return code: 0 20:25:11 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 20:25: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')]} 20:25:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:25:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:25: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')]} 20:25:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:25:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:25: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', '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 0x10af3c3f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10aeb2570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdc7a497550>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ad51d30>, '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 0x10abb8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ad49b20>, '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.pG8HC6rqle/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.lly8clOXCA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/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 20:25: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', 'psutil>=3.1.1'] in /builds/slave/test/build 20:25: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 psutil>=3.1.1 20:25:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.pG8HC6rqle/Render', 20:25:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:25:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:25:11 INFO - 'HOME': '/Users/cltbld', 20:25:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:25:11 INFO - 'LOGNAME': 'cltbld', 20:25:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:25:11 INFO - 'MOZ_NO_REMOTE': '1', 20:25:11 INFO - 'NO_EM_RESTART': '1', 20:25:11 INFO - 'PAGER': '/bin/cat', 20:25:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:25:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:25:11 INFO - 'PWD': '/builds/slave/test', 20:25:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:25:11 INFO - 'SHELL': '/bin/bash', 20:25:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lly8clOXCA/Listeners', 20:25:11 INFO - 'TMPDIR': '/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/', 20:25:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:25:11 INFO - 'USER': 'cltbld', 20:25:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:25:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:25:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:25:11 INFO - 'XPC_FLAGS': '0x0', 20:25:11 INFO - 'XPC_SERVICE_NAME': '0', 20:25:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:25:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:25:11 INFO - Downloading/unpacking psutil>=3.1.1 20:25: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 20:25: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 20:25: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 20:25: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 20:25: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 20:25: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 20:25:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 20:25:15 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:25:15 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:25:15 INFO - Installing collected packages: psutil 20:25:15 INFO - Running setup.py install for psutil 20:25:15 INFO - building 'psutil._psutil_osx' extension 20:25:15 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 20:25:16 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 20:25:16 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 20:25:16 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 20:25:16 INFO - building 'psutil._psutil_posix' extension 20:25:16 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 20:25:16 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 20:25:16 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 20:25:16 INFO - ^ 20:25:16 INFO - 1 warning generated. 20:25:16 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 20:25:16 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:25:16 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:25:16 INFO - Successfully installed psutil 20:25:16 INFO - Cleaning up... 20:25:16 INFO - Return code: 0 20:25:16 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 20:25:16 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')]} 20:25:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:25:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:25:16 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')]} 20:25:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:25:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:25:16 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 0x10af3c3f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10aeb2570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdc7a497550>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ad51d30>, '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 0x10abb8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ad49b20>, '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.pG8HC6rqle/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.lly8clOXCA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/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 20:25:16 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 20:25:16 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 20:25:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.pG8HC6rqle/Render', 20:25:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:25:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:25:16 INFO - 'HOME': '/Users/cltbld', 20:25:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:25:16 INFO - 'LOGNAME': 'cltbld', 20:25:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:25:16 INFO - 'MOZ_NO_REMOTE': '1', 20:25:16 INFO - 'NO_EM_RESTART': '1', 20:25:16 INFO - 'PAGER': '/bin/cat', 20:25:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:25:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:25:16 INFO - 'PWD': '/builds/slave/test', 20:25:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:25:16 INFO - 'SHELL': '/bin/bash', 20:25:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lly8clOXCA/Listeners', 20:25:16 INFO - 'TMPDIR': '/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/', 20:25:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:25:16 INFO - 'USER': 'cltbld', 20:25:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:25:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:25:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:25:16 INFO - 'XPC_FLAGS': '0x0', 20:25:16 INFO - 'XPC_SERVICE_NAME': '0', 20:25:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:25:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:25:17 INFO - Downloading/unpacking mozsystemmonitor==0.3 20:25:17 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 20:25:17 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 20:25:17 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 20:25:17 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 20:25:17 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 20:25:17 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 20:25:19 INFO - Downloading mozsystemmonitor-0.3.tar.gz 20:25:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 20:25:19 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 20:25:19 INFO - Installing collected packages: mozsystemmonitor 20:25:19 INFO - Running setup.py install for mozsystemmonitor 20:25:19 INFO - Successfully installed mozsystemmonitor 20:25:19 INFO - Cleaning up... 20:25:19 INFO - Return code: 0 20:25:19 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 20:25:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:25:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:25:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:25:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:25:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:25:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:25:19 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 0x10af3c3f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10aeb2570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdc7a497550>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ad51d30>, '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 0x10abb8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ad49b20>, '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.pG8HC6rqle/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.lly8clOXCA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/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 20:25:19 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 20:25:19 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 20:25:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.pG8HC6rqle/Render', 20:25:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:25:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:25:19 INFO - 'HOME': '/Users/cltbld', 20:25:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:25:19 INFO - 'LOGNAME': 'cltbld', 20:25:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:25:19 INFO - 'MOZ_NO_REMOTE': '1', 20:25:19 INFO - 'NO_EM_RESTART': '1', 20:25:19 INFO - 'PAGER': '/bin/cat', 20:25:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:25:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:25:19 INFO - 'PWD': '/builds/slave/test', 20:25:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:25:19 INFO - 'SHELL': '/bin/bash', 20:25:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lly8clOXCA/Listeners', 20:25:19 INFO - 'TMPDIR': '/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/', 20:25:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:25:19 INFO - 'USER': 'cltbld', 20:25:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:25:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:25:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:25:19 INFO - 'XPC_FLAGS': '0x0', 20:25:19 INFO - 'XPC_SERVICE_NAME': '0', 20:25:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:25:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:25:20 INFO - Downloading/unpacking jsonschema==2.5.1 20:25:20 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 20:25:20 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 20:25:20 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 20:25:20 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 20:25:20 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 20:25:20 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 20:25:22 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 20:25:22 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 20:25:22 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 20:25:22 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 20:25:22 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 20:25:22 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 20:25:22 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 20:25:22 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 20:25:23 INFO - Downloading functools32-3.2.3-2.tar.gz 20:25:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 20:25:23 INFO - warning: no files found matching '*.txt' 20:25:23 INFO - no previously-included directories found matching 'build' 20:25:23 INFO - no previously-included directories found matching 'dist' 20:25:23 INFO - no previously-included directories found matching '.git*' 20:25:23 INFO - Installing collected packages: jsonschema, functools32 20:25:23 INFO - Running setup.py install for functools32 20:25:23 INFO - warning: no files found matching '*.txt' 20:25:23 INFO - no previously-included directories found matching 'build' 20:25:23 INFO - no previously-included directories found matching 'dist' 20:25:23 INFO - no previously-included directories found matching '.git*' 20:25:23 INFO - Successfully installed jsonschema functools32 20:25:23 INFO - Cleaning up... 20:25:23 INFO - Return code: 0 20:25:23 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 20:25:23 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')]} 20:25:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:25:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:25:23 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')]} 20:25:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:25:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:25:23 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 0x10af3c3f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10aeb2570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdc7a497550>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ad51d30>, '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 0x10abb8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ad49b20>, '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.pG8HC6rqle/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.lly8clOXCA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/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 20:25:23 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 20:25:23 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 20:25:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.pG8HC6rqle/Render', 20:25:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:25:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:25:23 INFO - 'HOME': '/Users/cltbld', 20:25:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:25:23 INFO - 'LOGNAME': 'cltbld', 20:25:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:25:23 INFO - 'MOZ_NO_REMOTE': '1', 20:25:23 INFO - 'NO_EM_RESTART': '1', 20:25:23 INFO - 'PAGER': '/bin/cat', 20:25:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:25:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:25:23 INFO - 'PWD': '/builds/slave/test', 20:25:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:25:23 INFO - 'SHELL': '/bin/bash', 20:25:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lly8clOXCA/Listeners', 20:25:23 INFO - 'TMPDIR': '/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/', 20:25:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:25:23 INFO - 'USER': 'cltbld', 20:25:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:25:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:25:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:25:23 INFO - 'XPC_FLAGS': '0x0', 20:25:23 INFO - 'XPC_SERVICE_NAME': '0', 20:25:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:25:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:25:23 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 20:25:23 INFO - Cleaning up... 20:25:23 INFO - Return code: 0 20:25:23 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 20:25:23 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')]} 20:25:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:25:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:25:23 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')]} 20:25:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:25:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:25:23 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 0x10af3c3f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10aeb2570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdc7a497550>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ad51d30>, '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 0x10abb8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ad49b20>, '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.pG8HC6rqle/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.lly8clOXCA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/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 20:25:23 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 20:25:23 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 20:25:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.pG8HC6rqle/Render', 20:25:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:25:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:25:23 INFO - 'HOME': '/Users/cltbld', 20:25:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:25:23 INFO - 'LOGNAME': 'cltbld', 20:25:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:25:23 INFO - 'MOZ_NO_REMOTE': '1', 20:25:23 INFO - 'NO_EM_RESTART': '1', 20:25:23 INFO - 'PAGER': '/bin/cat', 20:25:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:25:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:25:23 INFO - 'PWD': '/builds/slave/test', 20:25:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:25:23 INFO - 'SHELL': '/bin/bash', 20:25:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lly8clOXCA/Listeners', 20:25:23 INFO - 'TMPDIR': '/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/', 20:25:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:25:23 INFO - 'USER': 'cltbld', 20:25:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:25:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:25:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:25:23 INFO - 'XPC_FLAGS': '0x0', 20:25:23 INFO - 'XPC_SERVICE_NAME': '0', 20:25:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:25:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:25:24 INFO - Downloading/unpacking blobuploader==1.2.4 20:25:24 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 20:25:24 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 20:25:24 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 20:25:24 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 20:25:24 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 20:25:24 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 20:25:26 INFO - Downloading blobuploader-1.2.4.tar.gz 20:25:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 20:25:26 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 20:25: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 20:25: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 20:25: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 20:25: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 20:25: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 20:25: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 20:25:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 20:25:27 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 20:25:27 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 20:25:27 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 20:25:27 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 20:25:27 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 20:25:27 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 20:25:27 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 20:25:27 INFO - Downloading docopt-0.6.1.tar.gz 20:25:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 20:25:28 INFO - Installing collected packages: blobuploader, requests, docopt 20:25:28 INFO - Running setup.py install for blobuploader 20:25:28 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 20:25:28 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 20:25:28 INFO - Running setup.py install for requests 20:25:28 INFO - Running setup.py install for docopt 20:25:28 INFO - Successfully installed blobuploader requests docopt 20:25:28 INFO - Cleaning up... 20:25:28 INFO - Return code: 0 20:25:28 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:25:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:25:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:25:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:25:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:25:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:25:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:25:28 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 0x10af3c3f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10aeb2570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdc7a497550>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ad51d30>, '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 0x10abb8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ad49b20>, '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.pG8HC6rqle/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.lly8clOXCA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/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 20:25:28 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 20:25:28 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 20:25:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.pG8HC6rqle/Render', 20:25:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:25:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:25:28 INFO - 'HOME': '/Users/cltbld', 20:25:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:25:28 INFO - 'LOGNAME': 'cltbld', 20:25:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:25:28 INFO - 'MOZ_NO_REMOTE': '1', 20:25:28 INFO - 'NO_EM_RESTART': '1', 20:25:28 INFO - 'PAGER': '/bin/cat', 20:25:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:25:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:25:28 INFO - 'PWD': '/builds/slave/test', 20:25:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:25:28 INFO - 'SHELL': '/bin/bash', 20:25:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lly8clOXCA/Listeners', 20:25:28 INFO - 'TMPDIR': '/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/', 20:25:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:25:28 INFO - 'USER': 'cltbld', 20:25:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:25:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:25:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:25:28 INFO - 'XPC_FLAGS': '0x0', 20:25:28 INFO - 'XPC_SERVICE_NAME': '0', 20:25:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:25:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:25:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:25:29 INFO - Running setup.py (path:/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/pip-jBWvn6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:25:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:25:29 INFO - Running setup.py (path:/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/pip-2fzlK4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:25:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:25:29 INFO - Running setup.py (path:/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/pip-xM1CAX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:25:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:25:29 INFO - Running setup.py (path:/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/pip-erYZia-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:25:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:25:29 INFO - Running setup.py (path:/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/pip-dWHN2w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:25:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:25:29 INFO - Running setup.py (path:/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/pip-aJCrD7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:25:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:25:29 INFO - Running setup.py (path:/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/pip-OKZxQO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:25:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:25:29 INFO - Running setup.py (path:/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/pip-KtAvhS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:25:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:25:30 INFO - Running setup.py (path:/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/pip-4bh9p8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:25:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:25:30 INFO - Running setup.py (path:/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/pip-G62Zri-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:25:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:25:30 INFO - Running setup.py (path:/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/pip-gHNz2Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:25:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:25:30 INFO - Running setup.py (path:/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/pip-HPVDOl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:25:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:25:30 INFO - Running setup.py (path:/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/pip-wWS0FU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:25:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:25:30 INFO - Running setup.py (path:/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/pip-04deJT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:25:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:25:30 INFO - Running setup.py (path:/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/pip-g6S4EL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:25:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:25:30 INFO - Running setup.py (path:/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/pip-Bysar2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:25:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:25:30 INFO - Running setup.py (path:/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/pip-eTKjGX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:25:30 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 20:25:30 INFO - Running setup.py install for manifestparser 20:25:31 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 20:25:31 INFO - Running setup.py install for mozcrash 20:25:31 INFO - Running setup.py install for mozdebug 20:25:31 INFO - Running setup.py install for mozdevice 20:25:31 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 20:25:31 INFO - Installing dm script to /builds/slave/test/build/venv/bin 20:25:31 INFO - Running setup.py install for mozfile 20:25:31 INFO - Running setup.py install for mozhttpd 20:25:31 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 20:25:31 INFO - Running setup.py install for mozinfo 20:25:31 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 20:25:31 INFO - Running setup.py install for mozInstall 20:25:32 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 20:25:32 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 20:25:32 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 20:25:32 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 20:25:32 INFO - Running setup.py install for mozleak 20:25:32 INFO - Running setup.py install for mozlog 20:25:32 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 20:25:32 INFO - Running setup.py install for moznetwork 20:25:32 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 20:25:32 INFO - Running setup.py install for mozprocess 20:25:32 INFO - Running setup.py install for mozprofile 20:25:32 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 20:25:32 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 20:25:32 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 20:25:32 INFO - Running setup.py install for mozrunner 20:25:33 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 20:25:33 INFO - Running setup.py install for mozscreenshot 20:25:33 INFO - Running setup.py install for moztest 20:25:33 INFO - Running setup.py install for mozversion 20:25:33 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 20:25:33 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 20:25:33 INFO - Cleaning up... 20:25:33 INFO - Return code: 0 20:25:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:25:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:25:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:25:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:25:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:25:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:25:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:25:33 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 0x10af3c3f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10aeb2570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdc7a497550>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ad51d30>, '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 0x10abb8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ad49b20>, '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.pG8HC6rqle/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.lly8clOXCA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/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 20:25:33 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 20:25:33 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 20:25:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.pG8HC6rqle/Render', 20:25:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:25:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:25:33 INFO - 'HOME': '/Users/cltbld', 20:25:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:25:33 INFO - 'LOGNAME': 'cltbld', 20:25:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:25:33 INFO - 'MOZ_NO_REMOTE': '1', 20:25:33 INFO - 'NO_EM_RESTART': '1', 20:25:33 INFO - 'PAGER': '/bin/cat', 20:25:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:25:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:25:33 INFO - 'PWD': '/builds/slave/test', 20:25:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:25:33 INFO - 'SHELL': '/bin/bash', 20:25:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lly8clOXCA/Listeners', 20:25:33 INFO - 'TMPDIR': '/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/', 20:25:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:25:33 INFO - 'USER': 'cltbld', 20:25:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:25:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:25:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:25:33 INFO - 'XPC_FLAGS': '0x0', 20:25:33 INFO - 'XPC_SERVICE_NAME': '0', 20:25:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:25:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:25:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:25:33 INFO - Running setup.py (path:/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/pip-Rf4Mso-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:25:33 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)) 20:25:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:25:33 INFO - Running setup.py (path:/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/pip-9zFWBr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:25:34 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)) 20:25:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:25:34 INFO - Running setup.py (path:/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/pip-LNY6OZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:25:34 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)) 20:25:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:25:34 INFO - Running setup.py (path:/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/pip-XNouqZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:25:34 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)) 20:25:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:25:34 INFO - Running setup.py (path:/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/pip-tV8It1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:25:34 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)) 20:25:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:25:34 INFO - Running setup.py (path:/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/pip-9_1e2N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:25:34 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)) 20:25:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:25:34 INFO - Running setup.py (path:/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/pip-amqd5k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:25:34 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)) 20:25:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:25:34 INFO - Running setup.py (path:/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/pip-1hKzae-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:25:34 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)) 20:25:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:25:34 INFO - Running setup.py (path:/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/pip-KSsyhU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:25:34 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)) 20:25:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:25:34 INFO - Running setup.py (path:/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/pip-nArPzM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:25:34 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)) 20:25:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:25:34 INFO - Running setup.py (path:/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/pip-1G83eG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:25:34 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)) 20:25:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:25:34 INFO - Running setup.py (path:/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/pip-CobUDL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:25:35 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)) 20:25:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:25:35 INFO - Running setup.py (path:/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/pip-1pof_j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:25:35 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)) 20:25:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:25:35 INFO - Running setup.py (path:/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/pip-l__GAm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:25:35 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)) 20:25:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:25:35 INFO - Running setup.py (path:/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/pip-zdRhDa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:25:35 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)) 20:25:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:25:35 INFO - Running setup.py (path:/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/pip-8sMhL_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:25:35 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)) 20:25:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:25:35 INFO - Running setup.py (path:/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/pip-QGHjGL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:25:35 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)) 20:25:35 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)) 20:25:35 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)) 20:25:35 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)) 20:25:35 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)) 20:25:35 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)) 20:25:35 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 20:25:35 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 20:25:35 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 20:25:35 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 20:25:35 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 20:25:35 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 20:25:35 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 20:25:38 INFO - Downloading blessings-1.6.tar.gz 20:25:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 20:25:38 INFO - Installing collected packages: blessings 20:25:38 INFO - Running setup.py install for blessings 20:25:38 INFO - Successfully installed blessings 20:25:38 INFO - Cleaning up... 20:25:38 INFO - Return code: 0 20:25:38 INFO - Done creating virtualenv /builds/slave/test/build/venv. 20:25:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:25:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:25:38 INFO - Reading from file tmpfile_stdout 20:25:38 INFO - Current package versions: 20:25:38 INFO - blessings == 1.6 20:25:38 INFO - blobuploader == 1.2.4 20:25:38 INFO - docopt == 0.6.1 20:25:38 INFO - functools32 == 3.2.3-2 20:25:38 INFO - jsonschema == 2.5.1 20:25:38 INFO - manifestparser == 1.1 20:25:38 INFO - mozInstall == 1.12 20:25:38 INFO - mozcrash == 1.0 20:25:38 INFO - mozdebug == 0.1 20:25:38 INFO - mozdevice == 0.49 20:25:38 INFO - mozfile == 1.2 20:25:38 INFO - mozhttpd == 0.7 20:25:38 INFO - mozinfo == 0.9 20:25:38 INFO - mozleak == 0.1 20:25:38 INFO - mozlog == 3.4 20:25:38 INFO - moznetwork == 0.27 20:25:38 INFO - mozprocess == 0.23 20:25:38 INFO - mozprofile == 0.28 20:25:38 INFO - mozrunner == 6.13 20:25:38 INFO - mozscreenshot == 0.1 20:25:38 INFO - mozsystemmonitor == 0.3 20:25:38 INFO - moztest == 0.7 20:25:38 INFO - mozversion == 1.4 20:25:38 INFO - psutil == 3.1.1 20:25:38 INFO - requests == 1.2.3 20:25:38 INFO - wsgiref == 0.1.2 20:25:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:25:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:25:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:25:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:25:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:25:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:25:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:25:38 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 0x10af3c3f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10aeb2570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdc7a497550>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ad51d30>, '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 0x10abb8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ad49b20>, '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.pG8HC6rqle/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.lly8clOXCA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/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 20:25:38 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 20:25:38 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 20:25:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.pG8HC6rqle/Render', 20:25:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:25:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:25:38 INFO - 'HOME': '/Users/cltbld', 20:25:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:25:38 INFO - 'LOGNAME': 'cltbld', 20:25:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:25:38 INFO - 'MOZ_NO_REMOTE': '1', 20:25:38 INFO - 'NO_EM_RESTART': '1', 20:25:38 INFO - 'PAGER': '/bin/cat', 20:25:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:25:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:25:38 INFO - 'PWD': '/builds/slave/test', 20:25:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:25:38 INFO - 'SHELL': '/bin/bash', 20:25:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lly8clOXCA/Listeners', 20:25:38 INFO - 'TMPDIR': '/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/', 20:25:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:25:38 INFO - 'USER': 'cltbld', 20:25:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:25:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:25:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:25:38 INFO - 'XPC_FLAGS': '0x0', 20:25:38 INFO - 'XPC_SERVICE_NAME': '0', 20:25:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:25:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:25:39 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)) 20:25:39 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)) 20:25:39 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)) 20:25:39 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)) 20:25:39 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)) 20:25:39 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)) 20:25:39 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)) 20:25:39 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)) 20:25:39 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)) 20:25:39 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)) 20:25:39 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)) 20:25:39 INFO - Cleaning up... 20:25:39 INFO - Return code: 0 20:25:39 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 20:25:39 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')]} 20:25:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:25:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:25:39 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')]} 20:25:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:25:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:25:39 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 0x10af3c3f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10aeb2570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdc7a497550>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ad51d30>, '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 0x10abb8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ad49b20>, '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.pG8HC6rqle/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.lly8clOXCA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/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 20:25:39 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 20:25:39 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 20:25:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.pG8HC6rqle/Render', 20:25:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:25:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:25:39 INFO - 'HOME': '/Users/cltbld', 20:25:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:25:39 INFO - 'LOGNAME': 'cltbld', 20:25:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:25:39 INFO - 'MOZ_NO_REMOTE': '1', 20:25:39 INFO - 'NO_EM_RESTART': '1', 20:25:39 INFO - 'PAGER': '/bin/cat', 20:25:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:25:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:25:39 INFO - 'PWD': '/builds/slave/test', 20:25:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:25:39 INFO - 'SHELL': '/bin/bash', 20:25:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lly8clOXCA/Listeners', 20:25:39 INFO - 'TMPDIR': '/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/', 20:25:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:25:39 INFO - 'USER': 'cltbld', 20:25:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:25:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:25:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:25:39 INFO - 'XPC_FLAGS': '0x0', 20:25:39 INFO - 'XPC_SERVICE_NAME': '0', 20:25:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:25:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:25:39 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 20:25:39 INFO - Cleaning up... 20:25:39 INFO - Return code: 0 20:25:39 INFO - Running post-action listener: _resource_record_post_action 20:25:39 INFO - Running post-action listener: _start_resource_monitoring 20:25:39 INFO - Starting resource monitoring. 20:25:39 INFO - [mozharness: 2016-12-14 04:25:39.365689Z] Finished create-virtualenv step (success) 20:25:39 INFO - [mozharness: 2016-12-14 04:25:39.366746Z] Running install step. 20:25:39 INFO - Running pre-action listener: _resource_record_pre_action 20:25:39 INFO - Running main action method: install 20:25:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:25:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:25:39 INFO - Reading from file tmpfile_stdout 20:25:39 INFO - Detecting whether we're running mozinstall >=1.0... 20:25:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 20:25:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 20:25:39 INFO - Reading from file tmpfile_stdout 20:25:39 INFO - Output received: 20:25:39 INFO - Usage: mozinstall [options] installer 20:25:39 INFO - Options: 20:25:39 INFO - -h, --help show this help message and exit 20:25:39 INFO - -d DEST, --destination=DEST 20:25:39 INFO - Directory to install application into. [default: 20:25:39 INFO - "/builds/slave/test"] 20:25:39 INFO - --app=APP Application being installed. [default: firefox] 20:25:39 INFO - mkdir: /builds/slave/test/build/application 20:25:39 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'] 20:25:39 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 20:26:01 INFO - Reading from file tmpfile_stdout 20:26:01 INFO - Output received: 20:26:01 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 20:26:01 INFO - Running post-action listener: _resource_record_post_action 20:26:01 INFO - [mozharness: 2016-12-14 04:26:01.981076Z] Finished install step (success) 20:26:01 INFO - [mozharness: 2016-12-14 04:26:01.981224Z] Running run-tests step. 20:26:01 INFO - Running pre-action listener: _resource_record_pre_action 20:26:01 INFO - Running main action method: run_tests 20:26:01 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 20:26:01 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 20:26:01 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 20:26:01 INFO - 2016-12-13 20:26:01.995 screenresolution[1632:7396] starting screenresolution argv=screenresolution get 20:26:01 INFO - 2016-12-13 20:26:01.998 screenresolution[1632:7396] Display 0: 1600x1200x32@60 20:26:02 INFO - 2016-12-13 20:26:02.004 screenresolution[1633:7399] starting screenresolution argv=screenresolution list 20:26:02 INFO - Available Modes on Display 0 20:26:02 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 20:26:02 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 20:26:02 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 20:26:02 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 20:26:02 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 20:26:02 INFO - Intel Iris: 20:26:02 INFO - Chipset Model: Intel Iris 20:26:02 INFO - Type: GPU 20:26:02 INFO - Bus: Built-In 20:26:02 INFO - VRAM (Dynamic, Max): 1536 MB 20:26:02 INFO - Vendor: Intel (0x8086) 20:26:02 INFO - Device ID: 0x0a2e 20:26:02 INFO - Revision ID: 0x0009 20:26:02 INFO - Displays: 20:26:02 INFO - Display: 20:26:02 INFO - Resolution: 1600 x 1200 @ 60 Hz 20:26:02 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 20:26:02 INFO - Display Serial Number: 1600x1200 60 20:26:02 INFO - Main Display: Yes 20:26:02 INFO - Mirror: Off 20:26:02 INFO - Online: Yes 20:26:02 INFO - Rotation: Supported 20:26:02 INFO - Return code: 0 20:26:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 20:26:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 20:26:02 INFO - Python 2.7.3 20:26:02 INFO - Return code: 0 20:26:02 INFO - grabbing minidump binary from tooltool 20:26: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')]} 20:26:02 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 0x10ad51d30>, '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 0x10abb8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ad49b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 20:26:02 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 20:26:02 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 20:26:02 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 20:26:02 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 20:26:02 INFO - Return code: 0 20:26:02 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 20:26:02 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 20:26:02 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 20:26:02 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 20:26:02 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 20:26:02 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/E0hfPTjcQJKALmqBhNwaRw/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0375', '--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 20:26:02 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/E0hfPTjcQJKALmqBhNwaRw/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0375 --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 20:26:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.pG8HC6rqle/Render', 20:26:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:26:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:26:02 INFO - 'HOME': '/Users/cltbld', 20:26:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:26:02 INFO - 'LOGNAME': 'cltbld', 20:26:02 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 20:26:02 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 20:26:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:26:02 INFO - 'MOZ_NO_REMOTE': '1', 20:26:02 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 20:26:02 INFO - 'NO_EM_RESTART': '1', 20:26:02 INFO - 'PAGER': '/bin/cat', 20:26:02 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:26:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:26:02 INFO - 'PWD': '/builds/slave/test', 20:26:02 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 20:26:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:26:02 INFO - 'SHELL': '/bin/bash', 20:26:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lly8clOXCA/Listeners', 20:26:02 INFO - 'TMPDIR': '/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/', 20:26:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:26:02 INFO - 'USER': 'cltbld', 20:26:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:26:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:26:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:26:02 INFO - 'XPC_FLAGS': '0x0', 20:26:02 INFO - 'XPC_SERVICE_NAME': '0', 20:26:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:26:02 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/E0hfPTjcQJKALmqBhNwaRw/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0375', '--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 20:26:02 INFO - mozversion application_buildid: 20161213192101 20:26:02 INFO - mozversion application_changeset: 0c7a106074f7267cbd1c8bb9039625f00c38063b 20:26:02 INFO - mozversion application_display_name: Nightly 20:26:02 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 20:26:02 INFO - mozversion application_name: Firefox 20:26:02 INFO - mozversion application_remotingname: firefox 20:26:02 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 20:26:02 INFO - mozversion application_vendor: Mozilla 20:26:02 INFO - mozversion application_version: 53.0a1 20:26:02 INFO - mozversion platform_buildid: 20161213192101 20:26:02 INFO - mozversion platform_changeset: 0c7a106074f7267cbd1c8bb9039625f00c38063b 20:26:02 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 20:26:02 INFO - mozversion platform_version: 53.0a1 20:26:02 INFO - using testdate: 1481689562 20:26:02 INFO - actual date: 1481689562 20:26:02 INFO - starting webserver on 'localhost:49235' 20:26:02 INFO - SUITE-START | Running 2 tests 20:26:02 INFO - TEST-START | dromaeo_css 20:26:02 INFO - operating with platform_type : mac_ 20:26:02 INFO - Initialising browser for dromaeo_css test... 20:26:02 INFO - TEST-INFO | started process 1643 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/tmpb5egwG/profile http://localhost:49235/getInfo.html) 20:26:05 INFO - PROCESS | 1643 | __metrics Screen width/height:1600/1200 20:26:05 INFO - PROCESS | 1643 | colorDepth:24 20:26:05 INFO - PROCESS | 1643 | Browser inner width/height: 1024/689 20:26:05 INFO - PROCESS | 1643 | __metrics 20:26:05 INFO - PROCESS | 1643 | 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" 20:26:05 INFO - PROCESS | 1643 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 20:26:05 INFO - TEST-INFO | 1643: exit 0 20:26:05 INFO - Browser initialized. 20:26:05 INFO - Running cycle 1/1 for dromaeo_css test... 20:26:05 INFO - TEST-INFO | started process 1645 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/tmpb5egwG/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:26:17 INFO - PROCESS | 1645 | RSS: Main: 237031424 20:26:17 INFO - PROCESS | 1645 | 20:27:09 INFO - PROCESS | 1645 | 1481689629098 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] 20:29:21 INFO - PROCESS | 1645 | Cycle 1(1): loaded http://localhost:49235/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49235/tests/dromaeo/cssquery-ext.html) 20:29:23 INFO - PROCESS | 1645 | RSS: Main: 409346048 20:29:23 INFO - PROCESS | 1645 | 20:32:26 INFO - PROCESS | 1645 | Cycle 1(1): loaded http://localhost:49235/tests/dromaeo/cssquery-ext.html (next: http://localhost:49235/tests/dromaeo/cssquery-jquery.html) 20:32:27 INFO - PROCESS | 1645 | RSS: Main: 374833152 20:32:27 INFO - PROCESS | 1645 | 20:35:29 INFO - PROCESS | 1645 | Cycle 1(1): loaded http://localhost:49235/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49235/tests/dromaeo/cssquery-mootools.html) 20:35:30 INFO - PROCESS | 1645 | RSS: Main: 366784512 20:35:30 INFO - PROCESS | 1645 | 20:38:32 INFO - PROCESS | 1645 | Cycle 1(1): loaded http://localhost:49235/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49235/tests/dromaeo/cssquery-prototype.html) 20:38:33 INFO - PROCESS | 1645 | RSS: Main: 341192704 20:38:33 INFO - PROCESS | 1645 | 20:41:37 INFO - PROCESS | 1645 | Cycle 1(1): loaded http://localhost:49235/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49235/tests/dromaeo/cssquery-yui.html) 20:41:37 INFO - PROCESS | 1645 | RSS: Main: 331386880 20:41:37 INFO - PROCESS | 1645 | 20:44:40 INFO - PROCESS | 1645 | Cycle 1(1): loaded http://localhost:49235/tests/dromaeo/cssquery-yui.html (next: http://localhost:49235/tests/dromaeo/cssquery-dojo.html) 20:44:41 INFO - PROCESS | 1645 | RSS: Main: 384450560 20:44:41 INFO - PROCESS | 1645 | 20:44:41 INFO - PROCESS | 1645 | __start_tp_report 20:44:41 INFO - PROCESS | 1645 | _x_x_mozilla_page_load 20:44:41 INFO - PROCESS | 1645 | _x_x_mozilla_page_load_details 20:44:41 INFO - PROCESS | 1645 | |i|pagename|runs| 20:44:41 INFO - PROCESS | 1645 | |0;dojo.html;2775.7779377649786;3307.735381169506;3315.535824984504;3339.448990916499;3377.780444271122;5567.916481252784;5669.121286200645;5695.772169113236;5699.7150142492865;5721.370649228586;5675.035244008518;5722.227499287595;5746.770129194827;5757.971210143954;5764.971175144129;5107.923381149286;5148.716820574867;5153.3558305211845;5170.870728231786;5184.222366644995;5271.103912334893;5272.868178295555;5276.736163191825;5291.841244762663;5295.549878260334;5154.92267615986;5167.534921857032;5201;5207.6875387476875;5266.578673706094;5251.527362537352;5254.001739669488;5261.579073674096;5277.947220527784;5322.760475778599;4989.426215985136;5013.974930125362;5063.645544811865;5185.325907632021;5186.92219616706;5588.944110558924;5646.520045796112;5653.547716182696;5703.31560212773;5725.312962444492;6149.815505534841;6153.1077993691115;6153.969230153865;6156.815295541141;6167.845803854894;5191.2472691459525;6089.238845144357;6141.539384546177;6152.969235153795;6184.474319682832;5721.056025755745;5746.540276777848;5751.8562035949435;5762.2221000164445;5831.825045248649;6153.476954458921;6219.595726277777;6220.937790622036;6222.408871157233;6246.312905580383;5847.883042339129;6007.669578173242;6052.788152414644;6064.818055458343;6066.059760737093;6037.577369584087;6085.66528840918;6098.237720284965;6135.5398345124295;6160.568760186744;4550.931736023962;6115.675336760245;6117.27606578316;6140.350877192993;6141.785037523665;6120.210952376251;6125.642968220491;6134.4978165938865;6143.017117261216;6151.415615516519;4749.62003039756;4833.661643684979;4834.854954351375;4853.95146048542;4856.125897338513;4355.80398882051;4367.497737760198;4369.2572262714775;4411.470623525198;4412.955870441318;5639.154126881001;5693.971530142323;5706.514946229534;5713.400092990176;5718.542516598662;6065.181200537871;6083.482903953213;6109.313572000111;6197.659128747872;6202.844928876814;5415.323084614423;5624;5674.2339784129435;5719.542436605062;5766.4233576642;5349.358077030781;5352.91970620441;5353.625246232804;5357.303550538483;5358.062339090644;6172.506199503939;6210.7515699372425;6212.844678882973;6219.782307619212;6239.656818875005;6074.088886667036;6112.077967281481;6126.8230438726505;6157.815265542041;6162;6178.474829639351;6218.5647004709235;6220.377962203744;6227.221597300338;6244.906326405198;6086.178365920721;6098.664573448503;6114.113453549122;6116.5718399711595;6116.816495505142;6073.514118870568;6128.417800308964;6134.018557030854;6134.110553969738;6185.072239164161;5750.338711048115;6024.156618073385;6042.637441753509;6064.909026364519;6092.543059270661;5920.2895652521975;5992.910106348496;6000.849978750566;6008.128821320796;6011.308699499438;5732.885342293214;5765.990951583372;5782.508486778503;5787.623804452697;5835.533157347317;5485.628592851787;5975.760969561169;5983.820485385445;6027.60820546663;6044.758209671564;5675.4040825714355;5725.7137143141845;5892.616979896293;5900.527957763283;5971.462568368694 20:44:41 INFO - PROCESS | 1645 | |1;ext.html;430.9073549186925;458.17528448792166;495.49707047346925;508.5677174401759;520.2274622186053;29631.40737185255;38430.807845960764;40125.799371003144;40255.59744402555;40420.98947526313;40550;40905.56830510933;40941;40975;41166.794166029125;8170.591470426484;8302.252797248246;9465.148136667698;9472.905270947305;9534.380265282753;8389.32885369169;10946.781064378707;11215.102791776639;11260.268082574607;11406.828897566502;11049.558017679323;11121.55513779448;11164.776704465905;11201.831972520418;11280.379579123144;11138.610148644799;11179.66461006167;11212.887871121347;11219.38293393863;11227;9141.542922853898;10037.949810250975;10955.233133680646;11003.394813285266;11007.394593297366;38426;38806;38828.61171388278;38840.61159388426;38898.833035009;3296.8351582421024;3320.25294308781;3400.336934297813;3431.330890476358;3507.088157079152;27364.31589210266;27861.721382786116;28313.054258605716;28581.857090714413;28607.85696071527;3000.144958686764;3033.347830216514;3038.969610303891;3096.055703010581;3117.563541104247;486243;487486;490872.5456372731;490936.09063909616;491157;52663.736681316346;52955.735221323645;53070.469295307325;53097;53119.73440132775;54357.91284174373;54505.45494545004;54518.727406363505;54571.45428545664;54594.72702636461;14527.927360363343;14988.925055374653;15001.024933379296;15007.099574025593;15073.924630376778;10531.210159238088;10837.729056773644;10867.45662716861;11564.190506664452;11627.302361858316;14650.560483185522;16660;16963.4554816776;17077.573060673334;17089.914550427417;6824.283450237753;7224.602646854473;7408.629568521553;7429.9257007430315;7439.55362678241;733.5232099135604;951.6574033347989;972.2756546372856;1000.2792404659315;1008.0927165551062;28732.712672873004;29448.969286074884;29541;30043.549346759817;30134.69865301319;1048.8112139814907;1065.1053115383115;1090.2477290669572;1098.5825386353135;1146.6903935937416;15065.322060507304;15107.4712385066;15302.770458443132;15310.387584496495;15381.615459613598;535308;620772;627203;627714;628144;56013.43986560082;56768;56853.71573142108;56925.99999999917;57216.71391643015;1366.2485632901864;1408.5844675820658;1421.6872288096602;1422.5803388000359;1426.12293439536;28756.993505227216;28806.279843004093;28887.422251555272;29445.558316625695;29538.704612953596;47762.76118619524;48160.75919620379;48269.75865120652;48314.27528587004;48369.75815120902;528453;534129;534276;534931;536283;24265.636015460135;25335.36661583475;25626.693597576308;25752.484950300513;25868.611970820075;37515.81242093881;37789.43315850209;38200.2359952805;43568;44757;37110.886673399844;37257;37410.064748381505;38206.61793382031;38670;36305.27389452144;36452.63547364598;37259.44110838285;37668.62331376651;37693.434598481595;29848.701512984593;29902.70097298999;30102.946396876003;30417.543736843523;30643;31659;33093;33104.1723956903;33133.33733325368;33407.83296083504;22589.43526411853;22908.541829163656;23411.414714632272;23788;24516.6322505159 20:44:41 INFO - PROCESS | 1645 | |2;jquery.html;359.5326076101069;361.81728227245236;371.5856819646095;379.7645459814915;391.44805823788465;19074;19779.604407911833;20048.899755501203;20551.972401379946;20732.274370397;16552;20440.591188176266;20443.897780511114;20979.685304720442;21749.782502174974;6559.836004099911;6620.801375958729;6755.088063111491;6822.28366021568;6949.131358580177;4618.330342100394;4866.367372241603;6625.370589793986;6769.966150169243;6772.153480814898;4785.21044027735;4795.496472870351;4852.8544143675745;7747.496412733182;7777.300042996129;7488.101427828641;7726.266004729542;7745.651445684902;7763.417743669247;7817.765467035998;7571.24287571244;7587.696492140363;7592.924070759277;7611.695532178706;7614.581198034106;27251.318717032034;27680.446391072066;27858.442831143468;27963.720362796314;28274.858625706944;2289.290320000805;2488.701355837293;2570.717221105677;2701.810873238874;2759.213624117117;15056;15815.288312025872;15947.681046379008;16039;17085.48743537696;1804.9819501804946;1940.9805901941081;1946.834519065881;1979.0903510682438;1979.356709069558;108589.94165379225;111537;135639;139786.4192222705;140554.99999999898;16946.576335591708;20526.768393896415;21251.574968500543;21369.46576335573;21499.46251343729;28116.71883281141;33087.83456082704;33167.17082072919;33890.661093389244;34123.4881476778;10271.691849244535;10558.894411055944;10688.793361991371;10707.286834106506;10935.83596246057;8724.651013959498;8731.51976641278;8776.16626420489;8931.240844528158;8956.776080597907;8289.875651865226;9136.6802161924;9347.485888276211;9367.143021378408;9564.95217523908;3602.171500554887;3721.6650501455;3722.758020728644;3726.869559565402;3728.8508459661853;835.7618078847499;897.264243320484;899.4962820820361;993.6472552243994;1039.1530902314742;19826.70259946102;20249.08879100444;20508.487287817625;20573.279935202198;20679.27622533204;920.8848893888264;958.1328897347911;958.242988039441;971.8736564246602;979.7599588100818;9922.660440840538;10865.076468500109;10936.906309369;10947.4526273686;10995.560177592806;549165;553934;562249.7750224945;565506;570016;98231.01768982218;116443.41778291055;119208.40395798138;120639;130170;947.1191791633709;960.2030314838668;999.8050380175941;1023.0485648347109;1024.800163968034;17897.731534026738;18901.07916361063;18930;19277.90361048186;19584.8041519583;52685.7365713169;53732.194017088994;53772.46227537675;54412;54953;71895;76315.47369052477;76855;77246;78545;5516.255305533701;6875.759348422781;6885.242623311532;7757.185495522889;7990;10189.694309170736;12276.754464910831;12497;12793.040521960704;12817.87182128204;10816.816637270447;11077.944610276896;11233.438328083399;11279.154063445438;11468.655940321803;10504.527296271533;10702.73243168927;10807.973242541946;10884.45577721095;11207.775844483227;11159.553617855196;11210.831837522606;11327.490262938352;11371.204015719151;11546.884531154918;7791.298783109547;7948.125706172432;8023.518588884685;8070.394720395876;8223.383246256675;8213.712520061768;9389.953050234704;9994.700158995242;10856.891431085589;10951.890481095086 20:44:41 INFO - PROCESS | 1645 | |3;mootools.html;1323.9338033098345;1505.631120375508;1660.1367289009715;1829.2500074969266;1893.8484921206305;7960.1243863175005;8355.37334699897;8364.874526882102;8365.12166222547;8371.790705232372;7358.852822943538;7599.0881094268625;7946.960265198666;8169.183081691828;8204.425690201688;2289.679444877714;2326.697529321186;2329.7670232976734;2335.2177020698;2337.439014636492;2325.3256555598855;2331.6735657008035;2371.8576885386933;2375.5367703297866;2382.821288403368;2315.710536182977;2320.512692334612;2332.3352844439337;2340.543593999162;2345.6129738593113;2241.8991145398495;2299.7470278269375;2320.280712978965;2322.512272422793;2324.9070037198494;2272.8863556822257;2343.1564636730764;2345.0854166874933;2348.953020939589;2349.7767712067325;8364.247217750431;8381.49711017341;8396.202360775778;8411.369147313975;8432.873506897402;5024.371953505812;5175;5185.948140518584;5189.714565698885;5208.192730126836;2839.9148025559266;3146.181992681896;3292.3499269723598;3429.6741809528053;3443.2941247044546;877.5129802959354;963.8650588917557;987.7579992901785;1005.0552480668149;1010.9797804043951;10289.485525723683;10600.257981941268;10754.300970436896;10756.892431075667;10802.945985270102;3783.5459744830246;4430.712003719748;4446.42196514451;4474;4476.440444944382;8603.397762156588;8623.655053797778;8633.654653813903;8633.870491942625;8657.826843463095;5069.721165335868;5087.771050302746;5112.233165025276;5118.334616499831;5144.588432925357;3571.339302229096;4151.813168407369;4681.765911704401;4697.765111744399;4771.974025584446;3559.94660080099;3604.2611264690677;3608.9458658120147;3679.300932822755;3696.075981004749;1040.8334666453331;1107.1087774341731;1144.5765066925292;1159.0727418065514;1161.2335858333458;840.6049156896249;855.8830725902757;891.5675897189858;898.883145191121;936.9859452108224;4972.72650004246;5172.7155006475;5579.079451890474;5619.690916999522;5665.830025099253;855.5294587976713;870.3776799588325;903.1284810158229;923.930705197113;953.2612225525273;3105.5962724845626;3402.9149271268416;3741.4013757799166;3746.668991109019;3854.8650797221962;9690.51547422626;9949.005099489994;10077.244206684381;10084.949575252076;10101;9812.754681132887;10011.949940250252;10022.348547344545;10051.497425128715;10052.597896084075;7721.420893433015;7871.291583757489;7884.5663488507535;7899.881501777363;7929.722459713882;5079.898402032012;5202.843914682566;5475.972620137033;5513.558915286848;5570.3315602128005;9120.315976301672;9153.954230229072;9210.95394523023;9300.11648893354;9365.812683746422;9165.908340916772;9261.073892610684;9264.212541934012;9382.437053776795;9412.717618471457;6169.753209871555;6422.967885160544;6459.741610335534;6562;6751.831204219934;7226.602536860523;7415.147258065392;7849.60751962411;7861.685532578862;7969.203079691984;6942.583444993316;7045.330693584101;7073.540219885691;7124.3944264738075;7213.242609525924;6913.446924246149;6918.481113916577;6951.339622735832;6982.441404687511;6997.440204783707;6586.37429444202;6586.5389422739945;6591.934080659132;6603.933960660332;6683.565568238049;4719.339292499121;4772.236442169236;4790.664653474363;4832.565069143794;4920.975395123001;4653.302004699322;4734.100520901018;4800.95199048019;4837.830675926326;4981.775820088177 20:44:41 INFO - PROCESS | 1645 | |4;prototype.html;346.19855035592605;353.37629084665554;358.5768792824468;366.99449508257396;370.51092557823665;4707.693999890009;5371.731413429327;5382.300300960879;5498.917516237259;5524.281843360358;4315.525292217853;5139.563137133338;5181.404138524071;5281.524662780349;5294.558536950984;3522.6653467920632;3530.823458827061;3625.23869987303;3658.920618417573;4005.1188738477563;4120.381942708603;4132.710710250284;4139;4151.83392664293;4183.288840897055;3535.3106144301873;3724.8137593120373;3810.3331916914567;4138.482689663792;4168.187203495319;3255.3326568053494;3336.2493438976157;4006.699497537667;4056.8377264909514;4091.672666186728;3092.8556434119296;3380.8140552269615;3475.600305964821;3476.721862251039;3488.773229740059;5217.50433708797;5237.633365664405;5238.5023422774775;5253.238280449352;5262.92110117425;3970.2456533258587;4312.956870431318;4419.801108950105;4423.358613001129;4598.126355992351;4571.794269257892;5573.6098473106895;5580.665160090408;5594.552435805126;5630.493255607015;3367.797932124056;3821.541415030214;3825.483559719458;3829.253295607358;3843.538775346948;5328.6269961102735;5469.398366179717;5818.6941663168955;5825.533957283449;5890.528757699374;3862.3240932836643;3900.083480382108;3900.551436584772;3900.8439662413753;3919.9216015679526;3493.0219538529254;3697.7411581189594;3899.883003509899;3901.785401802928;3914.37370020801;4081.3673880547967;4170.873864056688;4401.735895846259;4595.701279416827;4597.390913180427;5114.48855114493;5351.464853514617;5624.71876406178;5647.830565083054;5654.491095801315;1071.8338657508098;1118.4463690473267;1266.651016667265;1270.9809352859716;1271.6058022013206;818.2717381530442;820.5938060660012;820.9055958564842;845.9915400846036;855.2302927365421;4614.146382919103;4614.546417878358;4743.57307842289;4924.72913989734;5019.247112933089;4884.267359896044;4896.314515967767;5390.708948696788;5426.972865135728;5490.203920431515;4821.119763292319;4864.878378040577;4949.653524253267;5270.8945821084135;5272.785430119359;2621.5281249375294;2689.4889970905465;2743.917682469529;2775.931930711633;2882.3514709190263;5226.869328266824;5635.126085696243;5667.4615911488345;5692.715364231854;5696.601237913389;4853.563179313879;5289.9471005290225;5579.1867643016185;5652.491275785199;5658.490735833712;5166.121759300928;5553.750081246354;5682.374938756816;5682.499700131929;5794.85512862165;4853.6602437829015;4915.7542122893;4955.82654607087;5250.947490525045;5509.752061157337;4954.801807927643;5667.773289068556;5670.886582268249;5703.058995265735;5755.913661295001;5495.972520137374;5547.972260138674;5974.566104135063;6027.619090459331;6067.574120081866;3390.4575267957007;3788.223414200027;3834.94247586292;3843.9807800961935;3917.1785119919373;4724.338592597108;5272.024675435056;5620.578456615688;5696.291112666101;5763.250777398911;4865.9756701216265;5327.706976116351;5464.93433780409;5626.971865140812;5702.7718891243885;4504.414426124583;4734.881627959328;5463.803674850257;5556.472135147154;5611.6352437091455;4856.417229932431;5342.465753424626;5479;5540.252065971204;5561.777528898961;4691.976540117277;5120.462351453044;5422.996745602076;5551.833444996657;5616.66300022;4692.554207350297;4769.618430525619;5506.201600767786;5507.284053073075;5514.862128446821 20:44:41 INFO - PROCESS | 1645 | |5;yui.html;729.2051663686581;730.7004128307395;769.1846642558888;772.9690812367505;818.6643476174768;14568.417263309468;15568.922155389235;15576.221188940564;15627.374905003815;15630.29663665135;14042.859571404282;14122.152670839756;14156.858431415683;14157.07978981368;14218.360173792178;682.5904457325614;702.1959855964917;852.5481494807761;864.987025194621;887.6360692116234;872.6073267029861;877.7103555826562;878.6968495868947;878.9208971192592;882.9823403531925;942.2132519346354;944.8818897637796;945.7399215215802;946.1815529566909;947.4646824544145;938.2822141062024;939.2204470289644;939.2908354192575;940.6989763275755;940.7318914109514;533.4478814427088;552.5662355051265;671.597041774936;691.2879733874117;699.6851416862432;15155.469558565508;15336.769948450783;15361.615959600987;15362.846371536254;15369.077855328716;13837.100588461819;13875.791863122062;13955.302234888215;13968.161910285315;14002.159870407808;12832.486700531968;12949.223046617233;13010;13190.208587484782;13352.33238338089;4345.50026746925;4467.932981005288;4470.977645111753;4627.3521706961055;4706.623470122382;101123;102523;104265;106234.93765062328;108907.82184356348;10861;10884;10970.396628185526;11113.888861111447;11425.97166255041;21511.13955441765;21672.674909876365;21908.561828763337;22053.669194962087;22217;7365.079365079365;7590.734324298734;7712.190220026929;7783.688652453951;7863.174366691529;4172.72877262983;4242.130363275521;4263.893402664959;4271.743695378287;4298.8280468780895;3429.639887811794;3493.615702272799;3498.965010349915;3516.40221162403;3535.52270443492;517.4592550784439;518.5618152660995;524.4021815130754;529.5181384939686;533.218834407587;591.5563327504372;594.5745076179859;609.4514936557046;627.5920651576421;637.0985056145502;8960.596773145224;8992.8651070234;9048.547572621474;9122.407043542149;9244.90755092454;531.7075608415356;572.7737543670311;583.5098517245449;610.2219669920886;618.6937465954381;4174.624283814411;4341.934870976938;4418.124362387693;4418.138462999685;4482.932756008662;73392;74958.62520687362;87465.12534874697;89217;107064.46467767766;83588;84064;84074.15925840786;84147.15852841515;87856.12143878607;78097;78180;78294.21705782869;79362.80955785667;81449;9660.75848103803;9820.459874706674;9824.607015719292;9871.605135794487;9888.85166722514;48444.03111937812;49388;49829;50144.74927625484;50196;53498;66179;71604.5679086405;71711;73861;12491.37543122822;12745.362731863555;12754.367728780797;12938.935305323414;13350.532731354357;14126.081804682663;14189.219592922489;14386.640333991734;14556.781648275073;14623.19572423527;13242.271675057964;13382.464701411835;13462.596122116352;13557;14172.220527871066;13330.800037999245;13400.664983375493;13601.931990339985;13639;13692.3838427273;13131.080824342205;13311;13421;13484.46062157542;13581.932090339486;11070.944645276722;11178.329300241687;11374.431278435879;11686;11721.355325456841;11024.393658348868;11315.943420283174;11343.659690209306;11344.716382090513;11409.771804563696 20:44:41 INFO - PROCESS | 1645 | __end_tp_report 20:44:41 INFO - PROCESS | 1645 | __start_cc_report 20:44:41 INFO - PROCESS | 1645 | _x_x_mozilla_cycle_collect,2015 20:44:41 INFO - PROCESS | 1645 | __end_cc_report 20:44:41 INFO - PROCESS | 1645 | __startTimestamp1481690681210__endTimestamp 20:44:41 INFO - PROCESS | 1645 | 20:44:41 INFO - PROCESS | 1645 | ------- Summary: start ------- 20:44:41 INFO - PROCESS | 1645 | Number of tests: 6 20:44:41 INFO - PROCESS | 1645 | 20:44:41 INFO - PROCESS | 1645 | [#0] dojo.html Cycles:165 Average:5659.12 Median:5782.51 stddev:634.09 (11.0%) stddev-sans-first:594.32 20:44:41 INFO - PROCESS | 1645 | Values: 2775.8 3307.7 3315.5 3339.4 3377.8 5567.9 5669.1 5695.8 5699.7 5721.4 5675.0 5722.2 5746.8 5758.0 5765.0 5107.9 5148.7 5153.4 5170.9 5184.2 5271.1 5272.9 5276.7 5291.8 5295.5 5154.9 5167.5 5201.0 5207.7 5266.6 5251.5 5254.0 5261.6 5277.9 5322.8 4989.4 5014.0 5063.6 5185.3 5186.9 5588.9 5646.5 5653.5 5703.3 5725.3 6149.8 6153.1 6154.0 6156.8 6167.8 5191.2 6089.2 6141.5 6153.0 6184.5 5721.1 5746.5 5751.9 5762.2 5831.8 6153.5 6219.6 6220.9 6222.4 6246.3 5847.9 6007.7 6052.8 6064.8 6066.1 6037.6 6085.7 6098.2 6135.5 6160.6 4550.9 6115.7 6117.3 6140.4 6141.8 6120.2 6125.6 6134.5 6143.0 6151.4 4749.6 4833.7 4834.9 4854.0 4856.1 4355.8 4367.5 4369.3 4411.5 4413.0 5639.2 5694.0 5706.5 5713.4 5718.5 6065.2 6083.5 6109.3 6197.7 6202.8 5415.3 5624.0 5674.2 5719.5 5766.4 5349.4 5352.9 5353.6 5357.3 5358.1 6172.5 6210.8 6212.8 6219.8 6239.7 6074.1 6112.1 6126.8 6157.8 6162.0 6178.5 6218.6 6220.4 6227.2 6244.9 6086.2 6098.7 6114.1 6116.6 6116.8 6073.5 6128.4 6134.0 6134.1 6185.1 5750.3 6024.2 6042.6 6064.9 6092.5 5920.3 5992.9 6000.8 6008.1 6011.3 5732.9 5766.0 5782.5 5787.6 5835.5 5485.6 5975.8 5983.8 6027.6 6044.8 5675.4 5725.7 5892.6 5900.5 5971.5 20:44:41 INFO - PROCESS | 1645 | 20:44:41 INFO - PROCESS | 1645 | [#1] ext.html Cycles:180 Average:66730.05 Median:18226.80 stddev:145916.83 (800.6%) stddev-sans-first:146241.26 20:44:41 INFO - PROCESS | 1645 | Values: 430.9 458.2 495.5 508.6 520.2 29631.4 38430.8 40125.8 40255.6 40421.0 40550.0 40905.6 40941.0 40975.0 41166.8 8170.6 8302.3 9465.1 9472.9 9534.4 8389.3 10946.8 11215.1 11260.3 11406.8 11049.6 11121.6 11164.8 11201.8 11280.4 11138.6 11179.7 11212.9 11219.4 11227.0 9141.5 10037.9 10955.2 11003.4 11007.4 38426.0 38806.0 38828.6 38840.6 38898.8 3296.8 3320.3 3400.3 3431.3 3507.1 27364.3 27861.7 28313.1 28581.9 28607.9 3000.1 3033.3 3039.0 3096.1 3117.6 486243.0 487486.0 490872.5 490936.1 491157.0 52663.7 52955.7 53070.5 53097.0 53119.7 54357.9 54505.5 54518.7 54571.5 54594.7 14527.9 14988.9 15001.0 15007.1 15073.9 10531.2 10837.7 10867.5 11564.2 11627.3 14650.6 16660.0 16963.5 17077.6 17089.9 6824.3 7224.6 7408.6 7429.9 7439.6 733.5 951.7 972.3 1000.3 1008.1 28732.7 29449.0 29541.0 30043.5 30134.7 1048.8 1065.1 1090.2 1098.6 1146.7 15065.3 15107.5 15302.8 15310.4 15381.6 535308.0 620772.0 627203.0 627714.0 628144.0 56013.4 56768.0 56853.7 56926.0 57216.7 1366.2 1408.6 1421.7 1422.6 1426.1 28757.0 28806.3 28887.4 29445.6 29538.7 47762.8 48160.8 48269.8 48314.3 48369.8 528453.0 534129.0 534276.0 534931.0 536283.0 24265.6 25335.4 25626.7 25752.5 25868.6 37515.8 37789.4 38200.2 43568.0 44757.0 37110.9 37257.0 37410.1 38206.6 38670.0 36305.3 36452.6 37259.4 37668.6 37693.4 29848.7 29902.7 30102.9 30417.5 30643.0 31659.0 33093.0 33104.2 33133.3 33407.8 22589.4 22908.5 23411.4 23788.0 24516.6 20:44:41 INFO - PROCESS | 1645 | 20:44:41 INFO - PROCESS | 1645 | [#2] jquery.html Cycles:180 Average:35151.15 Median:33528.92 stddev:93612.03 (279.2%) stddev-sans-first:93838.19 20:44:41 INFO - PROCESS | 1645 | Values: 359.5 361.8 371.6 379.8 391.4 19074.0 19779.6 20048.9 20552.0 20732.3 16552.0 20440.6 20443.9 20979.7 21749.8 6559.8 6620.8 6755.1 6822.3 6949.1 4618.3 4866.4 6625.4 6770.0 6772.2 4785.2 4795.5 4852.9 7747.5 7777.3 7488.1 7726.3 7745.7 7763.4 7817.8 7571.2 7587.7 7592.9 7611.7 7614.6 27251.3 27680.4 27858.4 27963.7 28274.9 2289.3 2488.7 2570.7 2701.8 2759.2 15056.0 15815.3 15947.7 16039.0 17085.5 1805.0 1941.0 1946.8 1979.1 1979.4 108589.9 111537.0 135639.0 139786.4 140555.0 16946.6 20526.8 21251.6 21369.5 21499.5 28116.7 33087.8 33167.2 33890.7 34123.5 10271.7 10558.9 10688.8 10707.3 10935.8 8724.7 8731.5 8776.2 8931.2 8956.8 8289.9 9136.7 9347.5 9367.1 9565.0 3602.2 3721.7 3722.8 3726.9 3728.9 835.8 897.3 899.5 993.6 1039.2 19826.7 20249.1 20508.5 20573.3 20679.3 920.9 958.1 958.2 971.9 979.8 9922.7 10865.1 10936.9 10947.5 10995.6 549165.0 553934.0 562249.8 565506.0 570016.0 98231.0 116443.4 119208.4 120639.0 130170.0 947.1 960.2 999.8 1023.0 1024.8 17897.7 18901.1 18930.0 19277.9 19584.8 52685.7 53732.2 53772.5 54412.0 54953.0 71895.0 76315.5 76855.0 77246.0 78545.0 5516.3 6875.8 6885.2 7757.2 7990.0 10189.7 12276.8 12497.0 12793.0 12817.9 10816.8 11077.9 11233.4 11279.2 11468.7 10504.5 10702.7 10808.0 10884.5 11207.8 11159.6 11210.8 11327.5 11371.2 11546.9 7791.3 7948.1 8023.5 8070.4 8223.4 8213.7 9390.0 9994.7 10856.9 10951.9 20:44:41 INFO - PROCESS | 1645 | 20:44:41 INFO - PROCESS | 1645 | [#3] mootools.html Cycles:180 Average:5330.11 Median:5131.46 stddev:2928.57 (57.1%) stddev-sans-first:2921.31 20:44:41 INFO - PROCESS | 1645 | Values: 1323.9 1505.6 1660.1 1829.3 1893.8 7960.1 8355.4 8364.9 8365.1 8371.8 7358.9 7599.1 7947.0 8169.2 8204.4 2289.7 2326.7 2329.8 2335.2 2337.4 2325.3 2331.7 2371.9 2375.5 2382.8 2315.7 2320.5 2332.3 2340.5 2345.6 2241.9 2299.7 2320.3 2322.5 2324.9 2272.9 2343.2 2345.1 2349.0 2349.8 8364.2 8381.5 8396.2 8411.4 8432.9 5024.4 5175.0 5185.9 5189.7 5208.2 2839.9 3146.2 3292.3 3429.7 3443.3 877.5 963.9 987.8 1005.1 1011.0 10289.5 10600.3 10754.3 10756.9 10802.9 3783.5 4430.7 4446.4 4474.0 4476.4 8603.4 8623.7 8633.7 8633.9 8657.8 5069.7 5087.8 5112.2 5118.3 5144.6 3571.3 4151.8 4681.8 4697.8 4772.0 3559.9 3604.3 3608.9 3679.3 3696.1 1040.8 1107.1 1144.6 1159.1 1161.2 840.6 855.9 891.6 898.9 937.0 4972.7 5172.7 5579.1 5619.7 5665.8 855.5 870.4 903.1 923.9 953.3 3105.6 3402.9 3741.4 3746.7 3854.9 9690.5 9949.0 10077.2 10084.9 10101.0 9812.8 10011.9 10022.3 10051.5 10052.6 7721.4 7871.3 7884.6 7899.9 7929.7 5079.9 5202.8 5476.0 5513.6 5570.3 9120.3 9154.0 9211.0 9300.1 9365.8 9165.9 9261.1 9264.2 9382.4 9412.7 6169.8 6423.0 6459.7 6562.0 6751.8 7226.6 7415.1 7849.6 7861.7 7969.2 6942.6 7045.3 7073.5 7124.4 7213.2 6913.4 6918.5 6951.3 6982.4 6997.4 6586.4 6586.5 6591.9 6603.9 6683.6 4719.3 4772.2 4790.7 4832.6 4921.0 4653.3 4734.1 4801.0 4837.8 4981.8 20:44:41 INFO - PROCESS | 1645 | 20:44:41 INFO - PROCESS | 1645 | [#4] prototype.html Cycles:180 Average:4440.36 Median:4920.24 stddev:1373.53 (27.9%) stddev-sans-first:1342.56 20:44:41 INFO - PROCESS | 1645 | Values: 346.2 353.4 358.6 367.0 370.5 4707.7 5371.7 5382.3 5498.9 5524.3 4315.5 5139.6 5181.4 5281.5 5294.6 3522.7 3530.8 3625.2 3658.9 4005.1 4120.4 4132.7 4139.0 4151.8 4183.3 3535.3 3724.8 3810.3 4138.5 4168.2 3255.3 3336.2 4006.7 4056.8 4091.7 3092.9 3380.8 3475.6 3476.7 3488.8 5217.5 5237.6 5238.5 5253.2 5262.9 3970.2 4313.0 4419.8 4423.4 4598.1 4571.8 5573.6 5580.7 5594.6 5630.5 3367.8 3821.5 3825.5 3829.3 3843.5 5328.6 5469.4 5818.7 5825.5 5890.5 3862.3 3900.1 3900.6 3900.8 3919.9 3493.0 3697.7 3899.9 3901.8 3914.4 4081.4 4170.9 4401.7 4595.7 4597.4 5114.5 5351.5 5624.7 5647.8 5654.5 1071.8 1118.4 1266.7 1271.0 1271.6 818.3 820.6 820.9 846.0 855.2 4614.1 4614.5 4743.6 4924.7 5019.2 4884.3 4896.3 5390.7 5427.0 5490.2 4821.1 4864.9 4949.7 5270.9 5272.8 2621.5 2689.5 2743.9 2775.9 2882.4 5226.9 5635.1 5667.5 5692.7 5696.6 4853.6 5289.9 5579.2 5652.5 5658.5 5166.1 5553.8 5682.4 5682.5 5794.9 4853.7 4915.8 4955.8 5250.9 5509.8 4954.8 5667.8 5670.9 5703.1 5755.9 5496.0 5548.0 5974.6 6027.6 6067.6 3390.5 3788.2 3834.9 3844.0 3917.2 4724.3 5272.0 5620.6 5696.3 5763.3 4866.0 5327.7 5464.9 5627.0 5702.8 4504.4 4734.9 5463.8 5556.5 5611.6 4856.4 5342.5 5479.0 5540.3 5561.8 4692.0 5120.5 5423.0 5551.8 5616.7 4692.6 4769.6 5506.2 5507.3 5514.9 20:44:41 INFO - PROCESS | 1645 | 20:44:41 INFO - PROCESS | 1645 | [#5] yui.html Cycles:180 Average:19912.84 Median:4443.04 stddev:27921.69 (628.4%) stddev-sans-first:27962.86 20:44:41 INFO - PROCESS | 1645 | Values: 729.2 730.7 769.2 773.0 818.7 14568.4 15568.9 15576.2 15627.4 15630.3 14042.9 14122.2 14156.9 14157.1 14218.4 682.6 702.2 852.5 865.0 887.6 872.6 877.7 878.7 878.9 883.0 942.2 944.9 945.7 946.2 947.5 938.3 939.2 939.3 940.7 940.7 533.4 552.6 671.6 691.3 699.7 15155.5 15336.8 15361.6 15362.8 15369.1 13837.1 13875.8 13955.3 13968.2 14002.2 12832.5 12949.2 13010.0 13190.2 13352.3 4345.5 4467.9 4471.0 4627.4 4706.6 101123.0 102523.0 104265.0 106234.9 108907.8 10861.0 10884.0 10970.4 11113.9 11426.0 21511.1 21672.7 21908.6 22053.7 22217.0 7365.1 7590.7 7712.2 7783.7 7863.2 4172.7 4242.1 4263.9 4271.7 4298.8 3429.6 3493.6 3499.0 3516.4 3535.5 517.5 518.6 524.4 529.5 533.2 591.6 594.6 609.5 627.6 637.1 8960.6 8992.9 9048.5 9122.4 9244.9 531.7 572.8 583.5 610.2 618.7 4174.6 4341.9 4418.1 4418.1 4482.9 73392.0 74958.6 87465.1 89217.0 107064.5 83588.0 84064.0 84074.2 84147.2 87856.1 78097.0 78180.0 78294.2 79362.8 81449.0 9660.8 9820.5 9824.6 9871.6 9888.9 48444.0 49388.0 49829.0 50144.7 50196.0 53498.0 66179.0 71604.6 71711.0 73861.0 12491.4 12745.4 12754.4 12938.9 13350.5 14126.1 14189.2 14386.6 14556.8 14623.2 13242.3 13382.5 13462.6 13557.0 14172.2 13330.8 13400.7 13601.9 13639.0 13692.4 13131.1 13311.0 13421.0 13484.5 13581.9 11070.9 11178.3 11374.4 11686.0 11721.4 11024.4 11315.9 11343.7 11344.7 11409.8 20:44:41 INFO - PROCESS | 1645 | -------- Summary: end -------- 20:44:41 INFO - PROCESS | 1645 | 20:44:41 INFO - TEST-INFO | 1645: exit 0 20:44:41 INFO - TEST-OK | dromaeo_css | took 1119335ms 20:44:41 INFO - TEST-START | kraken 20:44:41 INFO - operating with platform_type : mac_ 20:44:41 INFO - Initialising browser for kraken test... 20:44:41 INFO - TEST-INFO | started process 1652 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/tmpOHJ3xM/profile http://localhost:49235/getInfo.html) 20:44:44 INFO - PROCESS | 1652 | __metrics Screen width/height:1600/1200 20:44:44 INFO - PROCESS | 1652 | colorDepth:24 20:44:44 INFO - PROCESS | 1652 | Browser inner width/height: 1024/689 20:44:44 INFO - PROCESS | 1652 | __metrics 20:44:44 INFO - PROCESS | 1652 | 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" 20:44:44 INFO - PROCESS | 1652 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 20:44:45 INFO - TEST-INFO | 1652: exit 0 20:44:45 INFO - Browser initialized. 20:44:45 INFO - Running cycle 1/1 for kraken test... 20:44:45 INFO - TEST-INFO | started process 1653 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/tmpOHJ3xM/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:44:57 INFO - PROCESS | 1653 | RSS: Main: 237346816 20:44:57 INFO - PROCESS | 1653 | 20:44:59 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49235/tests/kraken/driver.html?testName=audio-beat-detection) 20:45:00 INFO - PROCESS | 1653 | RSS: Main: 288837632 20:45:00 INFO - PROCESS | 1653 | 20:45:03 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49235/tests/kraken/driver.html?testName=audio-dft) 20:45:04 INFO - PROCESS | 1653 | RSS: Main: 290086912 20:45:04 INFO - PROCESS | 1653 | 20:45:07 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49235/tests/kraken/driver.html?testName=audio-fft) 20:45:07 INFO - PROCESS | 1653 | RSS: Main: 379842560 20:45:07 INFO - PROCESS | 1653 | 20:45:09 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49235/tests/kraken/driver.html?testName=audio-oscillator) 20:45:10 INFO - PROCESS | 1653 | RSS: Main: 283435008 20:45:10 INFO - PROCESS | 1653 | 20:45:12 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49235/tests/kraken/driver.html?testName=imaging-gaussian-blur) 20:45:13 INFO - PROCESS | 1653 | RSS: Main: 287428608 20:45:13 INFO - PROCESS | 1653 | 20:45:16 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49235/tests/kraken/driver.html?testName=imaging-darkroom) 20:45:16 INFO - PROCESS | 1653 | RSS: Main: 330211328 20:45:16 INFO - PROCESS | 1653 | 20:45:19 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49235/tests/kraken/driver.html?testName=imaging-desaturate) 20:45:20 INFO - PROCESS | 1653 | RSS: Main: 331698176 20:45:20 INFO - PROCESS | 1653 | 20:45:23 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49235/tests/kraken/driver.html?testName=json-parse-financial) 20:45:24 INFO - PROCESS | 1653 | RSS: Main: 327634944 20:45:24 INFO - PROCESS | 1653 | 20:45:25 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49235/tests/kraken/driver.html?testName=json-stringify-tinderbox) 20:45:26 INFO - PROCESS | 1653 | RSS: Main: 303751168 20:45:26 INFO - PROCESS | 1653 | 20:45:28 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49235/tests/kraken/driver.html?testName=stanford-crypto-aes) 20:45:28 INFO - PROCESS | 1653 | RSS: Main: 307036160 20:45:28 INFO - PROCESS | 1653 | 20:45:31 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49235/tests/kraken/driver.html?testName=stanford-crypto-ccm) 20:45:31 INFO - PROCESS | 1653 | RSS: Main: 311967744 20:45:31 INFO - PROCESS | 1653 | 20:45:34 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49235/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 20:45:35 INFO - PROCESS | 1653 | RSS: Main: 329695232 20:45:35 INFO - PROCESS | 1653 | 20:45:38 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49235/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 20:45:39 INFO - PROCESS | 1653 | RSS: Main: 324055040 20:45:39 INFO - PROCESS | 1653 | 20:45:41 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49235/tests/kraken/driver.html?testName=ai-astar) 20:45:41 INFO - PROCESS | 1653 | RSS: Main: 369152000 20:45:41 INFO - PROCESS | 1653 | 20:45:41 INFO - PROCESS | 1653 | __start_tp_report 20:45:41 INFO - PROCESS | 1653 | _x_x_mozilla_page_load 20:45:41 INFO - PROCESS | 1653 | _x_x_mozilla_page_load_details 20:45:41 INFO - PROCESS | 1653 | |i|pagename|runs| 20:45:41 INFO - PROCESS | 1653 | |0;ai-astar;115;114;115;114;115;115;113;113;115;114 20:45:41 INFO - PROCESS | 1653 | |1;audio-beat-detection;145;117;115;175;141;141;114;111;134;115 20:45:41 INFO - PROCESS | 1653 | |2;audio-dft;180;183;177;188;184;184;180;183;184;184 20:45:41 INFO - PROCESS | 1653 | |3;audio-fft;81;58;59;86;62;58;60;56;73;57 20:45:41 INFO - PROCESS | 1653 | |4;audio-oscillator;85;69;80;68;68;69;83;67;70;84 20:45:41 INFO - PROCESS | 1653 | |5;imaging-gaussian-blur;111;114;112;113;112;115;111;115;111;113 20:45:41 INFO - PROCESS | 1653 | |6;imaging-darkroom;100;98;99;99;98;98;98;97;97;98 20:45:41 INFO - PROCESS | 1653 | |7;imaging-desaturate;132;103;84;85;87;86;86;87;71;122 20:45:41 INFO - PROCESS | 1653 | |8;json-parse-financial;56;55;55;55;57;56;55;53;55;75 20:45:41 INFO - PROCESS | 1653 | |9;json-stringify-tinderbox;64;73;64;76;71;69;69;69;75;71 20:45:41 INFO - PROCESS | 1653 | |10;stanford-crypto-aes;89;89;96;107;112;92;90;88;88;90 20:45:41 INFO - PROCESS | 1653 | |11;stanford-crypto-ccm;150;147;147;149;155;164;154;152;208;176 20:45:41 INFO - PROCESS | 1653 | |12;stanford-crypto-pbkdf2;179;174;178;178;179;177;174;176;175;176 20:45:41 INFO - PROCESS | 1653 | |13;stanford-crypto-sha256-iterative;68;68;67;68;67;68;68;65;65;68 20:45:41 INFO - PROCESS | 1653 | __end_tp_report 20:45:41 INFO - PROCESS | 1653 | __start_cc_report 20:45:41 INFO - PROCESS | 1653 | _x_x_mozilla_cycle_collect,2171 20:45:41 INFO - PROCESS | 1653 | __end_cc_report 20:45:41 INFO - PROCESS | 1653 | __startTimestamp1481690741297__endTimestamp 20:45:41 INFO - PROCESS | 1653 | 20:45:41 INFO - PROCESS | 1653 | ------- Summary: start ------- 20:45:41 INFO - PROCESS | 1653 | Number of tests: 14 20:45:41 INFO - PROCESS | 1653 | 20:45:41 INFO - PROCESS | 1653 | [#0] ai-astar Cycles:10 Average:114.30 Median:115.00 stddev:0.82 (0.7%) stddev-sans-first:0.83 20:45:41 INFO - PROCESS | 1653 | Values: 115.0 114.0 115.0 114.0 115.0 115.0 113.0 113.0 115.0 114.0 20:45:41 INFO - PROCESS | 1653 | 20:45:41 INFO - PROCESS | 1653 | [#1] audio-beat-detection Cycles:10 Average:130.80 Median:137.50 stddev:20.38 (14.8%) stddev-sans-first:20.96 20:45:41 INFO - PROCESS | 1653 | Values: 145.0 117.0 115.0 175.0 141.0 141.0 114.0 111.0 134.0 115.0 20:45:41 INFO - PROCESS | 1653 | 20:45:41 INFO - PROCESS | 1653 | [#2] audio-dft Cycles:10 Average:182.70 Median:184.00 stddev:3.02 (1.6%) stddev-sans-first:3.04 20:45:41 INFO - PROCESS | 1653 | Values: 180.0 183.0 177.0 188.0 184.0 184.0 180.0 183.0 184.0 184.0 20:45:41 INFO - PROCESS | 1653 | 20:45:41 INFO - PROCESS | 1653 | [#3] audio-fft Cycles:10 Average:65.00 Median:61.00 stddev:10.92 (17.9%) stddev-sans-first:9.93 20:45:41 INFO - PROCESS | 1653 | Values: 81.0 58.0 59.0 86.0 62.0 58.0 60.0 56.0 73.0 57.0 20:45:41 INFO - PROCESS | 1653 | 20:45:41 INFO - PROCESS | 1653 | [#4] audio-oscillator Cycles:10 Average:74.30 Median:75.00 stddev:7.63 (10.2%) stddev-sans-first:7.04 20:45:41 INFO - PROCESS | 1653 | Values: 85.0 69.0 80.0 68.0 68.0 69.0 83.0 67.0 70.0 84.0 20:45:41 INFO - PROCESS | 1653 | 20:45:41 INFO - PROCESS | 1653 | [#5] imaging-gaussian-blur Cycles:10 Average:112.70 Median:113.00 stddev:1.57 (1.4%) stddev-sans-first:1.54 20:45:41 INFO - PROCESS | 1653 | Values: 111.0 114.0 112.0 113.0 112.0 115.0 111.0 115.0 111.0 113.0 20:45:41 INFO - PROCESS | 1653 | 20:45:41 INFO - PROCESS | 1653 | [#6] imaging-darkroom Cycles:10 Average:98.20 Median:98.00 stddev:0.92 (0.9%) stddev-sans-first:0.71 20:45:41 INFO - PROCESS | 1653 | Values: 100.0 98.0 99.0 99.0 98.0 98.0 98.0 97.0 97.0 98.0 20:45:41 INFO - PROCESS | 1653 | 20:45:41 INFO - PROCESS | 1653 | [#7] imaging-desaturate Cycles:10 Average:94.30 Median:85.50 stddev:18.99 (22.2%) stddev-sans-first:14.43 20:45:41 INFO - PROCESS | 1653 | Values: 132.0 103.0 84.0 85.0 87.0 86.0 86.0 87.0 71.0 122.0 20:45:41 INFO - PROCESS | 1653 | 20:45:41 INFO - PROCESS | 1653 | [#8] json-parse-financial Cycles:10 Average:57.20 Median:55.50 stddev:6.34 (11.4%) stddev-sans-first:6.71 20:45:41 INFO - PROCESS | 1653 | Values: 56.0 55.0 55.0 55.0 57.0 56.0 55.0 53.0 55.0 75.0 20:45:41 INFO - PROCESS | 1653 | 20:45:41 INFO - PROCESS | 1653 | [#9] json-stringify-tinderbox Cycles:10 Average:70.10 Median:71.00 stddev:4.04 (5.7%) stddev-sans-first:3.63 20:45:41 INFO - PROCESS | 1653 | Values: 64.0 73.0 64.0 76.0 71.0 69.0 69.0 69.0 75.0 71.0 20:45:41 INFO - PROCESS | 1653 | 20:45:41 INFO - PROCESS | 1653 | [#10] stanford-crypto-aes Cycles:10 Average:94.10 Median:89.50 stddev:8.53 (9.5%) stddev-sans-first:8.85 20:45:41 INFO - PROCESS | 1653 | Values: 89.0 89.0 96.0 107.0 112.0 92.0 90.0 88.0 88.0 90.0 20:45:41 INFO - PROCESS | 1653 | 20:45:41 INFO - PROCESS | 1653 | [#11] stanford-crypto-ccm Cycles:10 Average:160.20 Median:154.50 stddev:19.03 (12.3%) stddev-sans-first:19.82 20:45:41 INFO - PROCESS | 1653 | Values: 150.0 147.0 147.0 149.0 155.0 164.0 154.0 152.0 208.0 176.0 20:45:41 INFO - PROCESS | 1653 | 20:45:41 INFO - PROCESS | 1653 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:176.60 Median:177.50 stddev:1.90 (1.1%) stddev-sans-first:1.80 20:45:41 INFO - PROCESS | 1653 | Values: 179.0 174.0 178.0 178.0 179.0 177.0 174.0 176.0 175.0 176.0 20:45:41 INFO - PROCESS | 1653 | 20:45:41 INFO - PROCESS | 1653 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.20 Median:68.00 stddev:1.23 (1.8%) stddev-sans-first:1.27 20:45:41 INFO - PROCESS | 1653 | Values: 68.0 68.0 67.0 68.0 67.0 68.0 68.0 65.0 65.0 68.0 20:45:41 INFO - PROCESS | 1653 | -------- Summary: end -------- 20:45:41 INFO - PROCESS | 1653 | 20:45:42 INFO - TEST-INFO | 1653: exit 0 20:45:42 INFO - TEST-OK | kraken | took 60264ms 20:45:42 INFO - SUITE-END | took 1179s 20:45:42 INFO - Completed test suite (00:19:39) 20:45:42 INFO - javascript benchmark 20:45:42 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2775.7779377649786, 3307.735381169506, 3315.535824984504, 3339.448990916499, 3377.780444271122, 5567.916481252784, 5669.121286200645, 5695.772169113236, 5699.7150142492865, 5721.370649228586, 5675.035244008518, 5722.227499287595, 5746.770129194827, 5757.971210143954, 5764.971175144129, 5107.923381149286, 5148.716820574867, 5153.3558305211845, 5170.870728231786, 5184.222366644995, 5271.103912334893, 5272.868178295555, 5276.736163191825, 5291.841244762663, 5295.549878260334, 5154.92267615986, 5167.534921857032, 5201.0, 5207.6875387476875, 5266.578673706094, 5251.527362537352, 5254.001739669488, 5261.579073674096, 5277.947220527784, 5322.760475778599, 4989.426215985136, 5013.974930125362, 5063.645544811865, 5185.325907632021, 5186.92219616706, 5588.944110558924, 5646.520045796112, 5653.547716182696, 5703.31560212773, 5725.312962444492, 6149.815505534841, 6153.1077993691115, 6153.969230153865, 6156.815295541141, 6167.845803854894, 5191.2472691459525, 6089.238845144357, 6141.539384546177, 6152.969235153795, 6184.474319682832, 5721.056025755745, 5746.540276777848, 5751.8562035949435, 5762.2221000164445, 5831.825045248649, 6153.476954458921, 6219.595726277777, 6220.937790622036, 6222.408871157233, 6246.312905580383, 5847.883042339129, 6007.669578173242, 6052.788152414644, 6064.818055458343, 6066.059760737093, 6037.577369584087, 6085.66528840918, 6098.237720284965, 6135.5398345124295, 6160.568760186744, 4550.931736023962, 6115.675336760245, 6117.27606578316, 6140.350877192993, 6141.785037523665, 6120.210952376251, 6125.642968220491, 6134.4978165938865, 6143.017117261216, 6151.415615516519, 4749.62003039756, 4833.661643684979, 4834.854954351375, 4853.95146048542, 4856.125897338513, 4355.80398882051, 4367.497737760198, 4369.2572262714775, 4411.470623525198, 4412.955870441318, 5639.154126881001, 5693.971530142323, 5706.514946229534, 5713.400092990176, 5718.542516598662, 6065.181200537871, 6083.482903953213, 6109.313572000111, 6197.659128747872, 6202.844928876814, 5415.323084614423, 5624.0, 5674.2339784129435, 5719.542436605062, 5766.4233576642, 5349.358077030781, 5352.91970620441, 5353.625246232804, 5357.303550538483, 5358.062339090644, 6172.506199503939, 6210.7515699372425, 6212.844678882973, 6219.782307619212, 6239.656818875005, 6074.088886667036, 6112.077967281481, 6126.8230438726505, 6157.815265542041, 6162.0, 6178.474829639351, 6218.5647004709235, 6220.377962203744, 6227.221597300338, 6244.906326405198, 6086.178365920721, 6098.664573448503, 6114.113453549122, 6116.5718399711595, 6116.816495505142, 6073.514118870568, 6128.417800308964, 6134.018557030854, 6134.110553969738, 6185.072239164161, 5750.338711048115, 6024.156618073385, 6042.637441753509, 6064.909026364519, 6092.543059270661, 5920.2895652521975, 5992.910106348496, 6000.849978750566, 6008.128821320796, 6011.308699499438, 5732.885342293214, 5765.990951583372, 5782.508486778503, 5787.623804452697, 5835.533157347317, 5485.628592851787, 5975.760969561169, 5983.820485385445, 6027.60820546663, 6044.758209671564, 5675.4040825714355, 5725.7137143141845, 5892.616979896293, 5900.527957763283, 5971.462568368694], "value": 5618.307992491155, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [430.9073549186925, 458.17528448792166, 495.49707047346925, 508.5677174401759, 520.2274622186053, 29631.40737185255, 38430.807845960764, 40125.799371003144, 40255.59744402555, 40420.98947526313, 40550.0, 40905.56830510933, 40941.0, 40975.0, 41166.794166029125, 8170.591470426484, 8302.252797248246, 9465.148136667698, 9472.905270947305, 9534.380265282753, 8389.32885369169, 10946.781064378707, 11215.102791776639, 11260.268082574607, 11406.828897566502, 11049.558017679323, 11121.55513779448, 11164.776704465905, 11201.831972520418, 11280.379579123144, 11138.610148644799, 11179.66461006167, 11212.887871121347, 11219.38293393863, 11227.0, 9141.542922853898, 10037.949810250975, 10955.233133680646, 11003.394813285266, 11007.394593297366, 38426.0, 38806.0, 38828.61171388278, 38840.61159388426, 38898.833035009, 3296.8351582421024, 3320.25294308781, 3400.336934297813, 3431.330890476358, 3507.088157079152, 27364.31589210266, 27861.721382786116, 28313.054258605716, 28581.857090714413, 28607.85696071527, 3000.144958686764, 3033.347830216514, 3038.969610303891, 3096.055703010581, 3117.563541104247, 486243.0, 487486.0, 490872.5456372731, 490936.09063909616, 491157.0, 52663.736681316346, 52955.735221323645, 53070.469295307325, 53097.0, 53119.73440132775, 54357.91284174373, 54505.45494545004, 54518.727406363505, 54571.45428545664, 54594.72702636461, 14527.927360363343, 14988.925055374653, 15001.024933379296, 15007.099574025593, 15073.924630376778, 10531.210159238088, 10837.729056773644, 10867.45662716861, 11564.190506664452, 11627.302361858316, 14650.560483185522, 16660.0, 16963.4554816776, 17077.573060673334, 17089.914550427417, 6824.283450237753, 7224.602646854473, 7408.629568521553, 7429.9257007430315, 7439.55362678241, 733.5232099135604, 951.6574033347989, 972.2756546372856, 1000.2792404659315, 1008.0927165551062, 28732.712672873004, 29448.969286074884, 29541.0, 30043.549346759817, 30134.69865301319, 1048.8112139814907, 1065.1053115383115, 1090.2477290669572, 1098.5825386353135, 1146.6903935937416, 15065.322060507304, 15107.4712385066, 15302.770458443132, 15310.387584496495, 15381.615459613598, 535308.0, 620772.0, 627203.0, 627714.0, 628144.0, 56013.43986560082, 56768.0, 56853.71573142108, 56925.99999999917, 57216.71391643015, 1366.2485632901864, 1408.5844675820658, 1421.6872288096602, 1422.5803388000359, 1426.12293439536, 28756.993505227216, 28806.279843004093, 28887.422251555272, 29445.558316625695, 29538.704612953596, 47762.76118619524, 48160.75919620379, 48269.75865120652, 48314.27528587004, 48369.75815120902, 528453.0, 534129.0, 534276.0, 534931.0, 536283.0, 24265.636015460135, 25335.36661583475, 25626.693597576308, 25752.484950300513, 25868.611970820075, 37515.81242093881, 37789.43315850209, 38200.2359952805, 43568.0, 44757.0, 37110.886673399844, 37257.0, 37410.064748381505, 38206.61793382031, 38670.0, 36305.27389452144, 36452.63547364598, 37259.44110838285, 37668.62331376651, 37693.434598481595, 29848.701512984593, 29902.70097298999, 30102.946396876003, 30417.543736843523, 30643.0, 31659.0, 33093.0, 33104.1723956903, 33133.33733325368, 33407.83296083504, 22589.43526411853, 22908.541829163656, 23411.414714632272, 23788.0, 24516.6322505159], "value": 19220.7491172677, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [359.5326076101069, 361.81728227245236, 371.5856819646095, 379.7645459814915, 391.44805823788465, 19074.0, 19779.604407911833, 20048.899755501203, 20551.972401379946, 20732.274370397, 16552.0, 20440.591188176266, 20443.897780511114, 20979.685304720442, 21749.782502174974, 6559.836004099911, 6620.801375958729, 6755.088063111491, 6822.28366021568, 6949.131358580177, 4618.330342100394, 4866.367372241603, 6625.370589793986, 6769.966150169243, 6772.153480814898, 4785.21044027735, 4795.496472870351, 4852.8544143675745, 7747.496412733182, 7777.300042996129, 7488.101427828641, 7726.266004729542, 7745.651445684902, 7763.417743669247, 7817.765467035998, 7571.24287571244, 7587.696492140363, 7592.924070759277, 7611.695532178706, 7614.581198034106, 27251.318717032034, 27680.446391072066, 27858.442831143468, 27963.720362796314, 28274.858625706944, 2289.290320000805, 2488.701355837293, 2570.717221105677, 2701.810873238874, 2759.213624117117, 15056.0, 15815.288312025872, 15947.681046379008, 16039.0, 17085.48743537696, 1804.9819501804946, 1940.9805901941081, 1946.834519065881, 1979.0903510682438, 1979.356709069558, 108589.94165379225, 111537.0, 135639.0, 139786.4192222705, 140554.99999999898, 16946.576335591708, 20526.768393896415, 21251.574968500543, 21369.46576335573, 21499.46251343729, 28116.71883281141, 33087.83456082704, 33167.17082072919, 33890.661093389244, 34123.4881476778, 10271.691849244535, 10558.894411055944, 10688.793361991371, 10707.286834106506, 10935.83596246057, 8724.651013959498, 8731.51976641278, 8776.16626420489, 8931.240844528158, 8956.776080597907, 8289.875651865226, 9136.6802161924, 9347.485888276211, 9367.143021378408, 9564.95217523908, 3602.171500554887, 3721.6650501455, 3722.758020728644, 3726.869559565402, 3728.8508459661853, 835.7618078847499, 897.264243320484, 899.4962820820361, 993.6472552243994, 1039.1530902314742, 19826.70259946102, 20249.08879100444, 20508.487287817625, 20573.279935202198, 20679.27622533204, 920.8848893888264, 958.1328897347911, 958.242988039441, 971.8736564246602, 979.7599588100818, 9922.660440840538, 10865.076468500109, 10936.906309369, 10947.4526273686, 10995.560177592806, 549165.0, 553934.0, 562249.7750224945, 565506.0, 570016.0, 98231.01768982218, 116443.41778291055, 119208.40395798138, 120639.0, 130170.0, 947.1191791633709, 960.2030314838668, 999.8050380175941, 1023.0485648347109, 1024.800163968034, 17897.731534026738, 18901.07916361063, 18930.0, 19277.90361048186, 19584.8041519583, 52685.7365713169, 53732.194017088994, 53772.46227537675, 54412.0, 54953.0, 71895.0, 76315.47369052477, 76855.0, 77246.0, 78545.0, 5516.255305533701, 6875.759348422781, 6885.242623311532, 7757.185495522889, 7990.0, 10189.694309170736, 12276.754464910831, 12497.0, 12793.040521960704, 12817.87182128204, 10816.816637270447, 11077.944610276896, 11233.438328083399, 11279.154063445438, 11468.655940321803, 10504.527296271533, 10702.73243168927, 10807.973242541946, 10884.45577721095, 11207.775844483227, 11159.553617855196, 11210.831837522606, 11327.490262938352, 11371.204015719151, 11546.884531154918, 7791.298783109547, 7948.125706172432, 8023.518588884685, 8070.394720395876, 8223.383246256675, 8213.712520061768, 9389.953050234704, 9994.700158995242, 10856.891431085589, 10951.890481095086], "value": 10694.395224384813, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1323.9338033098345, 1505.631120375508, 1660.1367289009715, 1829.2500074969266, 1893.8484921206305, 7960.1243863175005, 8355.37334699897, 8364.874526882102, 8365.12166222547, 8371.790705232372, 7358.852822943538, 7599.0881094268625, 7946.960265198666, 8169.183081691828, 8204.425690201688, 2289.679444877714, 2326.697529321186, 2329.7670232976734, 2335.2177020698, 2337.439014636492, 2325.3256555598855, 2331.6735657008035, 2371.8576885386933, 2375.5367703297866, 2382.821288403368, 2315.710536182977, 2320.512692334612, 2332.3352844439337, 2340.543593999162, 2345.6129738593113, 2241.8991145398495, 2299.7470278269375, 2320.280712978965, 2322.512272422793, 2324.9070037198494, 2272.8863556822257, 2343.1564636730764, 2345.0854166874933, 2348.953020939589, 2349.7767712067325, 8364.247217750431, 8381.49711017341, 8396.202360775778, 8411.369147313975, 8432.873506897402, 5024.371953505812, 5175.0, 5185.948140518584, 5189.714565698885, 5208.192730126836, 2839.9148025559266, 3146.181992681896, 3292.3499269723598, 3429.6741809528053, 3443.2941247044546, 877.5129802959354, 963.8650588917557, 987.7579992901785, 1005.0552480668149, 1010.9797804043951, 10289.485525723683, 10600.257981941268, 10754.300970436896, 10756.892431075667, 10802.945985270102, 3783.5459744830246, 4430.712003719748, 4446.42196514451, 4474.0, 4476.440444944382, 8603.397762156588, 8623.655053797778, 8633.654653813903, 8633.870491942625, 8657.826843463095, 5069.721165335868, 5087.771050302746, 5112.233165025276, 5118.334616499831, 5144.588432925357, 3571.339302229096, 4151.813168407369, 4681.765911704401, 4697.765111744399, 4771.974025584446, 3559.94660080099, 3604.2611264690677, 3608.9458658120147, 3679.300932822755, 3696.075981004749, 1040.8334666453331, 1107.1087774341731, 1144.5765066925292, 1159.0727418065514, 1161.2335858333458, 840.6049156896249, 855.8830725902757, 891.5675897189858, 898.883145191121, 936.9859452108224, 4972.72650004246, 5172.7155006475, 5579.079451890474, 5619.690916999522, 5665.830025099253, 855.5294587976713, 870.3776799588325, 903.1284810158229, 923.930705197113, 953.2612225525273, 3105.5962724845626, 3402.9149271268416, 3741.4013757799166, 3746.668991109019, 3854.8650797221962, 9690.51547422626, 9949.005099489994, 10077.244206684381, 10084.949575252076, 10101.0, 9812.754681132887, 10011.949940250252, 10022.348547344545, 10051.497425128715, 10052.597896084075, 7721.420893433015, 7871.291583757489, 7884.5663488507535, 7899.881501777363, 7929.722459713882, 5079.898402032012, 5202.843914682566, 5475.972620137033, 5513.558915286848, 5570.3315602128005, 9120.315976301672, 9153.954230229072, 9210.95394523023, 9300.11648893354, 9365.812683746422, 9165.908340916772, 9261.073892610684, 9264.212541934012, 9382.437053776795, 9412.717618471457, 6169.753209871555, 6422.967885160544, 6459.741610335534, 6562.0, 6751.831204219934, 7226.602536860523, 7415.147258065392, 7849.60751962411, 7861.685532578862, 7969.203079691984, 6942.583444993316, 7045.330693584101, 7073.540219885691, 7124.3944264738075, 7213.242609525924, 6913.446924246149, 6918.481113916577, 6951.339622735832, 6982.441404687511, 6997.440204783707, 6586.37429444202, 6586.5389422739945, 6591.934080659132, 6603.933960660332, 6683.565568238049, 4719.339292499121, 4772.236442169236, 4790.664653474363, 4832.565069143794, 4920.975395123001, 4653.302004699322, 4734.100520901018, 4800.95199048019, 4837.830675926326, 4981.775820088177], "value": 4318.505777641435, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [346.19855035592605, 353.37629084665554, 358.5768792824468, 366.99449508257396, 370.51092557823665, 4707.693999890009, 5371.731413429327, 5382.300300960879, 5498.917516237259, 5524.281843360358, 4315.525292217853, 5139.563137133338, 5181.404138524071, 5281.524662780349, 5294.558536950984, 3522.6653467920632, 3530.823458827061, 3625.23869987303, 3658.920618417573, 4005.1188738477563, 4120.381942708603, 4132.710710250284, 4139.0, 4151.83392664293, 4183.288840897055, 3535.3106144301873, 3724.8137593120373, 3810.3331916914567, 4138.482689663792, 4168.187203495319, 3255.3326568053494, 3336.2493438976157, 4006.699497537667, 4056.8377264909514, 4091.672666186728, 3092.8556434119296, 3380.8140552269615, 3475.600305964821, 3476.721862251039, 3488.773229740059, 5217.50433708797, 5237.633365664405, 5238.5023422774775, 5253.238280449352, 5262.92110117425, 3970.2456533258587, 4312.956870431318, 4419.801108950105, 4423.358613001129, 4598.126355992351, 4571.794269257892, 5573.6098473106895, 5580.665160090408, 5594.552435805126, 5630.493255607015, 3367.797932124056, 3821.541415030214, 3825.483559719458, 3829.253295607358, 3843.538775346948, 5328.6269961102735, 5469.398366179717, 5818.6941663168955, 5825.533957283449, 5890.528757699374, 3862.3240932836643, 3900.083480382108, 3900.551436584772, 3900.8439662413753, 3919.9216015679526, 3493.0219538529254, 3697.7411581189594, 3899.883003509899, 3901.785401802928, 3914.37370020801, 4081.3673880547967, 4170.873864056688, 4401.735895846259, 4595.701279416827, 4597.390913180427, 5114.48855114493, 5351.464853514617, 5624.71876406178, 5647.830565083054, 5654.491095801315, 1071.8338657508098, 1118.4463690473267, 1266.651016667265, 1270.9809352859716, 1271.6058022013206, 818.2717381530442, 820.5938060660012, 820.9055958564842, 845.9915400846036, 855.2302927365421, 4614.146382919103, 4614.546417878358, 4743.57307842289, 4924.72913989734, 5019.247112933089, 4884.267359896044, 4896.314515967767, 5390.708948696788, 5426.972865135728, 5490.203920431515, 4821.119763292319, 4864.878378040577, 4949.653524253267, 5270.8945821084135, 5272.785430119359, 2621.5281249375294, 2689.4889970905465, 2743.917682469529, 2775.931930711633, 2882.3514709190263, 5226.869328266824, 5635.126085696243, 5667.4615911488345, 5692.715364231854, 5696.601237913389, 4853.563179313879, 5289.9471005290225, 5579.1867643016185, 5652.491275785199, 5658.490735833712, 5166.121759300928, 5553.750081246354, 5682.374938756816, 5682.499700131929, 5794.85512862165, 4853.6602437829015, 4915.7542122893, 4955.82654607087, 5250.947490525045, 5509.752061157337, 4954.801807927643, 5667.773289068556, 5670.886582268249, 5703.058995265735, 5755.913661295001, 5495.972520137374, 5547.972260138674, 5974.566104135063, 6027.619090459331, 6067.574120081866, 3390.4575267957007, 3788.223414200027, 3834.94247586292, 3843.9807800961935, 3917.1785119919373, 4724.338592597108, 5272.024675435056, 5620.578456615688, 5696.291112666101, 5763.250777398911, 4865.9756701216265, 5327.706976116351, 5464.93433780409, 5626.971865140812, 5702.7718891243885, 4504.414426124583, 4734.881627959328, 5463.803674850257, 5556.472135147154, 5611.6352437091455, 4856.417229932431, 5342.465753424626, 5479.0, 5540.252065971204, 5561.777528898961, 4691.976540117277, 5120.462351453044, 5422.996745602076, 5551.833444996657, 5616.66300022, 4692.554207350297, 4769.618430525619, 5506.201600767786, 5507.284053073075, 5514.862128446821], "value": 4011.9362013717787, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [729.2051663686581, 730.7004128307395, 769.1846642558888, 772.9690812367505, 818.6643476174768, 14568.417263309468, 15568.922155389235, 15576.221188940564, 15627.374905003815, 15630.29663665135, 14042.859571404282, 14122.152670839756, 14156.858431415683, 14157.07978981368, 14218.360173792178, 682.5904457325614, 702.1959855964917, 852.5481494807761, 864.987025194621, 887.6360692116234, 872.6073267029861, 877.7103555826562, 878.6968495868947, 878.9208971192592, 882.9823403531925, 942.2132519346354, 944.8818897637796, 945.7399215215802, 946.1815529566909, 947.4646824544145, 938.2822141062024, 939.2204470289644, 939.2908354192575, 940.6989763275755, 940.7318914109514, 533.4478814427088, 552.5662355051265, 671.597041774936, 691.2879733874117, 699.6851416862432, 15155.469558565508, 15336.769948450783, 15361.615959600987, 15362.846371536254, 15369.077855328716, 13837.100588461819, 13875.791863122062, 13955.302234888215, 13968.161910285315, 14002.159870407808, 12832.486700531968, 12949.223046617233, 13010.0, 13190.208587484782, 13352.33238338089, 4345.50026746925, 4467.932981005288, 4470.977645111753, 4627.3521706961055, 4706.623470122382, 101123.0, 102523.0, 104265.0, 106234.93765062328, 108907.82184356348, 10861.0, 10884.0, 10970.396628185526, 11113.888861111447, 11425.97166255041, 21511.13955441765, 21672.674909876365, 21908.561828763337, 22053.669194962087, 22217.0, 7365.079365079365, 7590.734324298734, 7712.190220026929, 7783.688652453951, 7863.174366691529, 4172.72877262983, 4242.130363275521, 4263.893402664959, 4271.743695378287, 4298.8280468780895, 3429.639887811794, 3493.615702272799, 3498.965010349915, 3516.40221162403, 3535.52270443492, 517.4592550784439, 518.5618152660995, 524.4021815130754, 529.5181384939686, 533.218834407587, 591.5563327504372, 594.5745076179859, 609.4514936557046, 627.5920651576421, 637.0985056145502, 8960.596773145224, 8992.8651070234, 9048.547572621474, 9122.407043542149, 9244.90755092454, 531.7075608415356, 572.7737543670311, 583.5098517245449, 610.2219669920886, 618.6937465954381, 4174.624283814411, 4341.934870976938, 4418.124362387693, 4418.138462999685, 4482.932756008662, 73392.0, 74958.62520687362, 87465.12534874697, 89217.0, 107064.46467767766, 83588.0, 84064.0, 84074.15925840786, 84147.15852841515, 87856.12143878607, 78097.0, 78180.0, 78294.21705782869, 79362.80955785667, 81449.0, 9660.75848103803, 9820.459874706674, 9824.607015719292, 9871.605135794487, 9888.85166722514, 48444.03111937812, 49388.0, 49829.0, 50144.74927625484, 50196.0, 53498.0, 66179.0, 71604.5679086405, 71711.0, 73861.0, 12491.37543122822, 12745.362731863555, 12754.367728780797, 12938.935305323414, 13350.532731354357, 14126.081804682663, 14189.219592922489, 14386.640333991734, 14556.781648275073, 14623.19572423527, 13242.271675057964, 13382.464701411835, 13462.596122116352, 13557.0, 14172.220527871066, 13330.800037999245, 13400.664983375493, 13601.931990339985, 13639.0, 13692.3838427273, 13131.080824342205, 13311.0, 13421.0, 13484.46062157542, 13581.932090339486, 11070.944645276722, 11178.329300241687, 11374.431278435879, 11686.0, 11721.355325456841, 11024.393658348868, 11315.943420283174, 11343.659690209306, 11344.716382090513, 11409.771804563696], "value": 7401.026823262699, "unit": "score"}], "name": "dromaeo_css", "value": 7273.7810121084285, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 114.0, 115.0, 114.0, 115.0, 115.0, 113.0, 113.0, 115.0, 114.0], "value": 114.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 117.0, 115.0, 175.0, 141.0, 141.0, 114.0, 111.0, 134.0, 115.0], "value": 130.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [180.0, 183.0, 177.0, 188.0, 184.0, 184.0, 180.0, 183.0, 184.0, 184.0], "value": 182.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 58.0, 59.0, 86.0, 62.0, 58.0, 60.0, 56.0, 73.0, 57.0], "value": 65.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 69.0, 80.0, 68.0, 68.0, 69.0, 83.0, 67.0, 70.0, 84.0], "value": 74.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 114.0, 112.0, 113.0, 112.0, 115.0, 111.0, 115.0, 111.0, 113.0], "value": 112.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [100.0, 98.0, 99.0, 99.0, 98.0, 98.0, 98.0, 97.0, 97.0, 98.0], "value": 98.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [132.0, 103.0, 84.0, 85.0, 87.0, 86.0, 86.0, 87.0, 71.0, 122.0], "value": 94.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 55.0, 55.0, 55.0, 57.0, 56.0, 55.0, 53.0, 55.0, 75.0], "value": 57.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 73.0, 64.0, 76.0, 71.0, 69.0, 69.0, 69.0, 75.0, 71.0], "value": 70.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 89.0, 96.0, 107.0, 112.0, 92.0, 90.0, 88.0, 88.0, 90.0], "value": 94.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 147.0, 147.0, 149.0, 155.0, 164.0, 154.0, 152.0, 208.0, 176.0], "value": 160.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [179.0, 174.0, 178.0, 178.0, 179.0, 177.0, 174.0, 176.0, 175.0, 176.0], "value": 176.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 68.0, 67.0, 68.0, 67.0, 68.0, 68.0, 65.0, 65.0, 68.0], "value": 67.2, "unit": "score"}], "name": "kraken", "value": 1497.7, "alertThreshold": 2.0}]} 20:45:42 INFO - Return code: 0 20:45:42 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 20:45:42 INFO - # TBPL SUCCESS # 20:45:42 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 20:45:42 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 20:45:42 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 20:45:42 INFO - 2016-12-13 20:45:42.614 screenresolution[1657:9892] starting screenresolution argv=screenresolution get 20:45:42 INFO - 2016-12-13 20:45:42.617 screenresolution[1657:9892] Display 0: 1600x1200x32@60 20:45:42 INFO - 2016-12-13 20:45:42.623 screenresolution[1658:9896] starting screenresolution argv=screenresolution list 20:45:42 INFO - Available Modes on Display 0 20:45:42 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 20:45:42 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 20:45:42 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 20:45:42 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 20:45:42 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 20:45:42 INFO - Intel Iris: 20:45:42 INFO - Chipset Model: Intel Iris 20:45:42 INFO - Type: GPU 20:45:42 INFO - Bus: Built-In 20:45:42 INFO - VRAM (Dynamic, Max): 1536 MB 20:45:42 INFO - Vendor: Intel (0x8086) 20:45:42 INFO - Device ID: 0x0a2e 20:45:42 INFO - Revision ID: 0x0009 20:45:42 INFO - Displays: 20:45:42 INFO - Display: 20:45:42 INFO - Resolution: 1600 x 1200 @ 60 Hz 20:45:42 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 20:45:42 INFO - Display Serial Number: 1600x1200 60 20:45:42 INFO - Main Display: Yes 20:45:42 INFO - Mirror: Off 20:45:42 INFO - Online: Yes 20:45:42 INFO - Rotation: Supported 20:45:42 INFO - Return code: 0 20:45:42 INFO - Running post-action listener: _resource_record_post_action 20:45:42 INFO - [mozharness: 2016-12-14 04:45:42.859750Z] Finished run-tests step (success) 20:45:42 INFO - Running post-run listener: _resource_record_post_run 20:45:42 INFO - Total resource usage - Wall time: 1202s; CPU: 54.0%; Read bytes: 37573632; Write bytes: 550745088; Read time: 244; Write time: 1674 20:45:42 INFO - TinderboxPrint: CPU usage
54.0% 20:45:42 INFO - TinderboxPrint: I/O read bytes / time
37,573,632 / 244 20:45:42 INFO - TinderboxPrint: I/O write bytes / time
550,745,088 / 1,674 20:45:42 INFO - TinderboxPrint: CPU idle
2,212.4 (46.0%) 20:45:42 INFO - TinderboxPrint: CPU system
967.1 (20.1%) 20:45:42 INFO - TinderboxPrint: CPU user
1,630.2 (33.9%) 20:45:42 INFO - TinderboxPrint: Swap in / out
286,720,000 / 0 20:45:42 INFO - install - Wall time: 23s; CPU: 55.0%; Read bytes: 244425216; Write bytes: 233015296; Read time: 17558; Write time: 503 20:45:42 INFO - run-tests - Wall time: 1181s; CPU: 54.0%; Read bytes: 30444544; Write bytes: 295959552; Read time: 185; Write time: 1117 20:45:43 INFO - Running post-run listener: _upload_blobber_files 20:45:43 INFO - Blob upload gear active. 20:45:43 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 20:45:43 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 20:45:43 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'] 20:45:43 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 20:45:43 INFO - (blobuploader) - INFO - Open directory for files ... 20:45:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 20:45:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:45:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:45:44 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 20:45:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:45:44 INFO - (blobuploader) - INFO - Done attempting. 20:45:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 20:45:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:45:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:45:45 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 20:45:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:45:45 INFO - (blobuploader) - INFO - Done attempting. 20:45:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 20:45:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:45:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:45:48 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 20:45:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:45:48 INFO - (blobuploader) - INFO - Done attempting. 20:45:48 INFO - (blobuploader) - INFO - Iteration through files over. 20:45:48 INFO - Return code: 0 20:45:48 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 20:45:48 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 20:45:48 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ecc4ebada2066a3339c0ef72917121828de2da769c527f4cdbaead9eb626b2b04d66b4deacf9081ba8fe425aad44562177ff51589e9b26091cdafbb25326b70d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3bd6b9a2d0af3e64ac193a3d89c11befe626d1896d4ba13f1a9a209d59b7a4b0306bb001e79c39afacf3fa0874cb17995d392523a7b4732f81ffe38c1a0934d4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ea3a542fe201f6f92126b3b0981abc70e5afed9cbef958c5d138a6562f34ddc13fe7d89b4a7493e5b1e8fd7b915f6cb70c2c6aa15d396d36d80fca702e9d9ca2"} 20:45:48 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 20:45:48 INFO - Writing to file /builds/slave/test/properties/blobber_files 20:45:48 INFO - Contents: 20:45:48 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ecc4ebada2066a3339c0ef72917121828de2da769c527f4cdbaead9eb626b2b04d66b4deacf9081ba8fe425aad44562177ff51589e9b26091cdafbb25326b70d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3bd6b9a2d0af3e64ac193a3d89c11befe626d1896d4ba13f1a9a209d59b7a4b0306bb001e79c39afacf3fa0874cb17995d392523a7b4732f81ffe38c1a0934d4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ea3a542fe201f6f92126b3b0981abc70e5afed9cbef958c5d138a6562f34ddc13fe7d89b4a7493e5b1e8fd7b915f6cb70c2c6aa15d396d36d80fca702e9d9ca2"} 20:45:48 INFO - Running post-run listener: copy_logs_to_upload_dir 20:45:48 INFO - Copying logs to upload dir... 20:45:48 INFO - mkdir: /builds/slave/test/build/upload/logs 20:45:48 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1264.389537 ========= master_lag: 3.36 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 7 secs) (at 2016-12-13 20:45:51.448392) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-13 20:45:51.452044) ========= 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.pG8HC6rqle/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.lly8clOXCA/Listeners TMPDIR=/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/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/ecc4ebada2066a3339c0ef72917121828de2da769c527f4cdbaead9eb626b2b04d66b4deacf9081ba8fe425aad44562177ff51589e9b26091cdafbb25326b70d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3bd6b9a2d0af3e64ac193a3d89c11befe626d1896d4ba13f1a9a209d59b7a4b0306bb001e79c39afacf3fa0874cb17995d392523a7b4732f81ffe38c1a0934d4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ea3a542fe201f6f92126b3b0981abc70e5afed9cbef958c5d138a6562f34ddc13fe7d89b4a7493e5b1e8fd7b915f6cb70c2c6aa15d396d36d80fca702e9d9ca2"} build_url:https://queue.taskcluster.net/v1/task/E0hfPTjcQJKALmqBhNwaRw/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011006 build_url: 'https://queue.taskcluster.net/v1/task/E0hfPTjcQJKALmqBhNwaRw/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/ecc4ebada2066a3339c0ef72917121828de2da769c527f4cdbaead9eb626b2b04d66b4deacf9081ba8fe425aad44562177ff51589e9b26091cdafbb25326b70d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3bd6b9a2d0af3e64ac193a3d89c11befe626d1896d4ba13f1a9a209d59b7a4b0306bb001e79c39afacf3fa0874cb17995d392523a7b4732f81ffe38c1a0934d4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ea3a542fe201f6f92126b3b0981abc70e5afed9cbef958c5d138a6562f34ddc13fe7d89b4a7493e5b1e8fd7b915f6cb70c2c6aa15d396d36d80fca702e9d9ca2"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-13 20:45:51.493001) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-13 20:45:51.493357) ========= 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.pG8HC6rqle/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.lly8clOXCA/Listeners TMPDIR=/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/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.005154 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-13 20:45:51.542771) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-13 20:45:51.543117) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-13 20:45:51.543550) ========= ========= Total master_lag: 10.44 =========