builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0181 starttime: 1481646765.34 results: success (0) buildid: 20161213070501 builduid: 7a20da3144c84b2c9f265245b2a97d7f revision: cb369201f52f7f4c9cb35c3e7dca9262b13f006b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-12-13 08:32:45.339954) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-12-13 08:32:45.340408) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-13 08:32:45.340703) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-13 08:32:45.367930) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-13 08:32:45.368314) ========= 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.tj4MCtkVGK/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.mgEdqSmSxd/Listeners TMPDIR=/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/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 08:32:45-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 14.4M=0.001s 2016-12-13 08:32:45 (14.4 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.118355 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-13 08:32:45.513144) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-13 08:32:45.513710) ========= 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.tj4MCtkVGK/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.mgEdqSmSxd/Listeners TMPDIR=/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/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.029188 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-13 08:32:45.566654) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-12-13 08:32:45.567003) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev cb369201f52f7f4c9cb35c3e7dca9262b13f006b --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 cb369201f52f7f4c9cb35c3e7dca9262b13f006b --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.tj4MCtkVGK/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.mgEdqSmSxd/Listeners TMPDIR=/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/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 08:32:45,659 truncating revision to first 12 chars 2016-12-13 08:32:45,659 Setting DEBUG logging. 2016-12-13 08:32:45,659 attempt 1/10 2016-12-13 08:32:45,659 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/cb369201f52f?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-12-13 08:32:47,157 unpacking tar archive at: mozilla-central-cb369201f52f/testing/mozharness/ program finished with exit code 0 elapsedTime=1.781363 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-12-13 08:32:47.371555) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-13 08:32:47.371877) ========= script_repo_revision: cb369201f52f7f4c9cb35c3e7dca9262b13f006b ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-13 08:32:47.372272) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-13 08:32:47.374582) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-13 08:32:47.395944) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 4 secs) (at 2016-12-13 08:32:47.396319) ========= /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.tj4MCtkVGK/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.mgEdqSmSxd/Listeners TMPDIR=/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 08:32:47 INFO - MultiFileLogger online at 20161213 08:32:47 in /builds/slave/test 08:32:47 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 08:32:47 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:32:47 INFO - {'append_to_log': False, 08:32:47 INFO - 'base_work_dir': '/builds/slave/test', 08:32:47 INFO - 'blob_upload_branch': 'Firefox', 08:32:47 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:32:47 INFO - 'branch': 'Firefox', 08:32:47 INFO - 'buildbot_json_path': 'buildprops.json', 08:32:47 INFO - 'config_files': ('talos/mac_config.py',), 08:32:47 INFO - 'default_actions': ('clobber', 08:32:47 INFO - 'read-buildbot-config', 08:32:47 INFO - 'download-and-extract', 08:32:47 INFO - 'populate-webroot', 08:32:47 INFO - 'create-virtualenv', 08:32:47 INFO - 'install', 08:32:47 INFO - 'run-tests'), 08:32:47 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:32:47 INFO - 'download_minidump_stackwalk': True, 08:32:47 INFO - 'download_symbols': 'ondemand', 08:32:47 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:32:47 INFO - 'tooltool.py': '/tools/tooltool.py', 08:32:47 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:32:47 INFO - '/tools/misc-python/virtualenv.py')}, 08:32:47 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:32:47 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:32:47 INFO - 'installer_path': 'installer.exe', 08:32:47 INFO - 'log_level': 'info', 08:32:47 INFO - 'log_name': 'talos', 08:32:47 INFO - 'log_to_console': True, 08:32:47 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 08:32:47 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 08:32:47 INFO - 'opt_config_files': (), 08:32:47 INFO - 'pip_index': False, 08:32:47 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 08:32:47 INFO - 'cmd': ('bash', 08:32:47 INFO - '-c', 08:32:47 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 08:32:47 INFO - 'enabled': True, 08:32:47 INFO - 'halt_on_failure': False, 08:32:47 INFO - 'name': 'check_screen_resolution'},), 08:32:47 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 08:32:47 INFO - 'cmd': ('bash', 08:32:47 INFO - '-c', 08:32:47 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 08:32:47 INFO - 'enabled': True, 08:32:47 INFO - 'halt_on_failure': False, 08:32:47 INFO - 'name': 'check_screen_resolution'},), 08:32:47 INFO - 'run_cmd_checks_enabled': True, 08:32:47 INFO - 'sps_profile': False, 08:32:47 INFO - 'sps_profile_interval': 0, 08:32:47 INFO - 'suite': 'dromaeojs', 08:32:47 INFO - 'system_bits': '32', 08:32:47 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:32:47 INFO - 'title': 't-yosemite-r7-0181', 08:32:47 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:32:47 INFO - 'use_talos_json': True, 08:32:47 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:32:47 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:32:47 INFO - 'work_dir': 'build'} 08:32:47 INFO - [mozharness: 2016-12-13 16:32:47.601619Z] Running clobber step. 08:32:47 INFO - Running pre-action listener: _resource_record_pre_action 08:32:47 INFO - Running main action method: clobber 08:32:47 INFO - rmtree: /builds/slave/test/build 08:32:47 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:32:50 INFO - Running post-action listener: _resource_record_post_action 08:32:50 INFO - [mozharness: 2016-12-13 16:32:50.590920Z] Finished clobber step (success) 08:32:50 INFO - [mozharness: 2016-12-13 16:32:50.591069Z] Running read-buildbot-config step. 08:32:50 INFO - Running pre-action listener: _resource_record_pre_action 08:32:50 INFO - Running main action method: read_buildbot_config 08:32:50 INFO - Using buildbot properties: 08:32:50 INFO - { 08:32:50 INFO - "project": "", 08:32:50 INFO - "product": "firefox", 08:32:50 INFO - "script_repo_revision": "production", 08:32:50 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 08:32:50 INFO - "repository": "", 08:32:50 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 08:32:50 INFO - "buildid": "20161213070501", 08:32:50 INFO - "pgo_build": "False", 08:32:50 INFO - "basedir": "/builds/slave/test", 08:32:50 INFO - "buildnumber": 44, 08:32:50 INFO - "slavename": "t-yosemite-r7-0181", 08:32:50 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 08:32:50 INFO - "platform": "yosemite_r7", 08:32:50 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 08:32:50 INFO - "branch": "mozilla-central", 08:32:50 INFO - "repo_path": "mozilla-central", 08:32:50 INFO - "revision": "cb369201f52f7f4c9cb35c3e7dca9262b13f006b", 08:32:50 INFO - "stage_platform": "macosx64", 08:32:50 INFO - "builduid": "7a20da3144c84b2c9f265245b2a97d7f", 08:32:50 INFO - "slavebuilddir": "test" 08:32:50 INFO - } 08:32:50 INFO - Found installer url https://queue.taskcluster.net/v1/task/BmhrU5ufT7yOHH9Ugz2EyA/artifacts/public/build/firefox-53.0a1.en-US.mac64.dmg. 08:32:50 INFO - Running post-action listener: _resource_record_post_action 08:32:50 INFO - [mozharness: 2016-12-13 16:32:50.594442Z] Finished read-buildbot-config step (success) 08:32:50 INFO - [mozharness: 2016-12-13 16:32:50.594544Z] Running download-and-extract step. 08:32:50 INFO - Running pre-action listener: _resource_record_pre_action 08:32:50 INFO - Running main action method: download_and_extract 08:32:50 INFO - mkdir: /builds/slave/test/build/tests 08:32:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:32:50 INFO - trying https://queue.taskcluster.net/v1/task/BmhrU5ufT7yOHH9Ugz2EyA/artifacts/public/build/firefox-53.0a1.en-US.mac64.test_packages.json 08:32:50 INFO - Downloading https://queue.taskcluster.net/v1/task/BmhrU5ufT7yOHH9Ugz2EyA/artifacts/public/build/firefox-53.0a1.en-US.mac64.test_packages.json to /builds/slave/test/build/firefox-53.0a1.en-US.mac64.test_packages.json 08:32:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/BmhrU5ufT7yOHH9Ugz2EyA/artifacts/public/build/firefox-53.0a1.en-US.mac64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.mac64.test_packages.json'}, attempt #1 08:32:51 INFO - Downloaded 1235 bytes. 08:32:51 INFO - Reading from file /builds/slave/test/build/firefox-53.0a1.en-US.mac64.test_packages.json 08:32:51 INFO - Using the following test package requirements: 08:32:51 INFO - {u'common': [u'firefox-53.0a1.en-US.mac64.common.tests.zip'], 08:32:51 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.mac64.common.tests.zip', 08:32:51 INFO - u'firefox-53.0a1.en-US.mac64.cppunittest.tests.zip'], 08:32:51 INFO - u'gtest': [u'firefox-53.0a1.en-US.mac64.common.tests.zip', 08:32:51 INFO - u'firefox-53.0a1.en-US.mac64.gtest.tests.zip'], 08:32:51 INFO - u'jittest': [u'firefox-53.0a1.en-US.mac64.common.tests.zip', 08:32:51 INFO - u'jsshell-mac64.zip'], 08:32:51 INFO - u'mochitest': [u'firefox-53.0a1.en-US.mac64.common.tests.zip', 08:32:51 INFO - u'firefox-53.0a1.en-US.mac64.mochitest.tests.zip'], 08:32:51 INFO - u'mozbase': [u'firefox-53.0a1.en-US.mac64.common.tests.zip'], 08:32:51 INFO - u'reftest': [u'firefox-53.0a1.en-US.mac64.common.tests.zip', 08:32:51 INFO - u'firefox-53.0a1.en-US.mac64.reftest.tests.zip'], 08:32:51 INFO - u'talos': [u'firefox-53.0a1.en-US.mac64.common.tests.zip', 08:32:51 INFO - u'firefox-53.0a1.en-US.mac64.talos.tests.zip'], 08:32:51 INFO - u'web-platform': [u'firefox-53.0a1.en-US.mac64.common.tests.zip', 08:32:51 INFO - u'firefox-53.0a1.en-US.mac64.web-platform.tests.zip'], 08:32:51 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.mac64.common.tests.zip', 08:32:51 INFO - u'firefox-53.0a1.en-US.mac64.xpcshell.tests.zip']} 08:32:51 INFO - Downloading packages: [u'firefox-53.0a1.en-US.mac64.common.tests.zip'] for test suite category: common 08:32:51 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/BmhrU5ufT7yOHH9Ugz2EyA/artifacts/public/build/firefox-53.0a1.en-US.mac64.common.tests.zip 08:32:51 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/BmhrU5ufT7yOHH9Ugz2EyA/artifacts/public/build/firefox-53.0a1.en-US.mac64.common.tests.zip'}, attempt #1 08:32:51 INFO - Fetch https://queue.taskcluster.net/v1/task/BmhrU5ufT7yOHH9Ugz2EyA/artifacts/public/build/firefox-53.0a1.en-US.mac64.common.tests.zip into memory 08:32:52 INFO - Expected file size: 16276451 08:32:52 INFO - Obtained file size: 16276451 08:32:59 INFO - Downloading packages: [u'firefox-53.0a1.en-US.mac64.common.tests.zip', u'firefox-53.0a1.en-US.mac64.talos.tests.zip'] for test suite category: talos 08:32:59 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/BmhrU5ufT7yOHH9Ugz2EyA/artifacts/public/build/firefox-53.0a1.en-US.mac64.common.tests.zip 08:32:59 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/BmhrU5ufT7yOHH9Ugz2EyA/artifacts/public/build/firefox-53.0a1.en-US.mac64.common.tests.zip'}, attempt #1 08:32:59 INFO - Fetch https://queue.taskcluster.net/v1/task/BmhrU5ufT7yOHH9Ugz2EyA/artifacts/public/build/firefox-53.0a1.en-US.mac64.common.tests.zip into memory 08:33:00 INFO - Expected file size: 16276451 08:33:00 INFO - Obtained file size: 16276451 08:33:06 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/BmhrU5ufT7yOHH9Ugz2EyA/artifacts/public/build/firefox-53.0a1.en-US.mac64.talos.tests.zip 08:33:06 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/BmhrU5ufT7yOHH9Ugz2EyA/artifacts/public/build/firefox-53.0a1.en-US.mac64.talos.tests.zip'}, attempt #1 08:33:06 INFO - Fetch https://queue.taskcluster.net/v1/task/BmhrU5ufT7yOHH9Ugz2EyA/artifacts/public/build/firefox-53.0a1.en-US.mac64.talos.tests.zip into memory 08:33:07 INFO - Expected file size: 14409734 08:33:07 INFO - Obtained file size: 14409734 08:33:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:33:07 INFO - trying https://queue.taskcluster.net/v1/task/BmhrU5ufT7yOHH9Ugz2EyA/artifacts/public/build/firefox-53.0a1.en-US.mac64.dmg 08:33:07 INFO - Downloading https://queue.taskcluster.net/v1/task/BmhrU5ufT7yOHH9Ugz2EyA/artifacts/public/build/firefox-53.0a1.en-US.mac64.dmg to /builds/slave/test/build/firefox-53.0a1.en-US.mac64.dmg 08:33:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/BmhrU5ufT7yOHH9Ugz2EyA/artifacts/public/build/firefox-53.0a1.en-US.mac64.dmg', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.mac64.dmg'}, attempt #1 08:33:09 INFO - Downloaded 69716203 bytes. 08:33:09 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/BmhrU5ufT7yOHH9Ugz2EyA/artifacts/public/build/firefox-53.0a1.en-US.mac64.dmg 08:33:09 INFO - mkdir: /builds/slave/test/properties 08:33:09 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:33:09 INFO - Writing to file /builds/slave/test/properties/build_url 08:33:09 INFO - Contents: 08:33:09 INFO - build_url:https://queue.taskcluster.net/v1/task/BmhrU5ufT7yOHH9Ugz2EyA/artifacts/public/build/firefox-53.0a1.en-US.mac64.dmg 08:33:10 INFO - Running post-action listener: _resource_record_post_action 08:33:10 INFO - Running post-action listener: set_extra_try_arguments 08:33:10 INFO - [mozharness: 2016-12-13 16:33:10.545852Z] Finished download-and-extract step (success) 08:33:10 INFO - [mozharness: 2016-12-13 16:33:10.545993Z] Running populate-webroot step. 08:33:10 INFO - Running pre-action listener: _resource_record_pre_action 08:33:10 INFO - Running main action method: populate_webroot 08:33:10 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:33:10 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:33:10 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:33:10 INFO - '--tppagecycles', 08:33:10 INFO - '7'], 08:33:10 INFO - 'tests': ['tsvgm']}}, 08:33:10 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:33:10 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:33:10 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:33:10 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:33:10 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:33:10 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:33:10 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 08:33:10 INFO - 'talos_options': ['--disable-e10s'], 08:33:10 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:33:10 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 08:33:10 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:33:10 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 08:33:10 INFO - 'talos_options': ['--disable-e10s'], 08:33:10 INFO - 'tests': ['damp', 'tps']}, 08:33:10 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 08:33:10 INFO - 'tests': ['damp', 'tps']}, 08:33:10 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:33:10 INFO - 'tests': ['dromaeo_dom']}, 08:33:10 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:33:10 INFO - 'g4': {'talos_options': ['--disable-e10s'], 08:33:10 INFO - 'tests': ['basic_compositor_video']}, 08:33:10 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 08:33:10 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:33:10 INFO - 'tests': ['a11yr', 08:33:10 INFO - 'ts_paint', 08:33:10 INFO - 'tpaint', 08:33:10 INFO - 'sessionrestore', 08:33:10 INFO - 'sessionrestore_no_auto_restore', 08:33:10 INFO - 'tabpaint']}, 08:33:10 INFO - 'other-e10s': {'tests': ['a11yr', 08:33:10 INFO - 'ts_paint', 08:33:10 INFO - 'tpaint', 08:33:10 INFO - 'sessionrestore', 08:33:10 INFO - 'sessionrestore_no_auto_restore', 08:33:10 INFO - 'tabpaint']}, 08:33:10 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:33:10 INFO - 'ts_paint', 08:33:10 INFO - 'tpaint', 08:33:10 INFO - 'sessionrestore', 08:33:10 INFO - 'sessionrestore_no_auto_restore', 08:33:10 INFO - 'tabpaint']}, 08:33:10 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:33:10 INFO - 'ts_paint', 08:33:10 INFO - 'tpaint', 08:33:10 INFO - 'sessionrestore', 08:33:10 INFO - 'sessionrestore_no_auto_restore', 08:33:10 INFO - 'tabpaint']}, 08:33:10 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:33:10 INFO - 'tests': ['a11yr', 08:33:10 INFO - 'ts_paint', 08:33:10 INFO - 'tpaint', 08:33:10 INFO - 'sessionrestore', 08:33:10 INFO - 'sessionrestore_no_auto_restore', 08:33:10 INFO - 'tabpaint']}, 08:33:10 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:33:10 INFO - 'tests': ['a11yr', 08:33:10 INFO - 'ts_paint', 08:33:10 INFO - 'tpaint', 08:33:10 INFO - 'sessionrestore', 08:33:10 INFO - 'sessionrestore_no_auto_restore', 08:33:10 INFO - 'tabpaint']}, 08:33:10 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:33:10 INFO - 'tests': ['tsvgx', 08:33:10 INFO - 'tsvgr_opacity', 08:33:10 INFO - 'tart', 08:33:10 INFO - 'tscrollx', 08:33:10 INFO - 'cart', 08:33:10 INFO - 'tsvg_static']}, 08:33:10 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:33:10 INFO - 'tsvgr_opacity', 08:33:10 INFO - 'tart', 08:33:10 INFO - 'tscrollx', 08:33:10 INFO - 'cart', 08:33:10 INFO - 'tsvg_static']}, 08:33:10 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 08:33:10 INFO - 'talos_options': ['--disable-e10s'], 08:33:10 INFO - 'tests': ['tp5o']}, 08:33:10 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 08:33:10 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 08:33:10 INFO - 'talos_options': ['--disable-e10s', 08:33:10 INFO - '--xperf_path', 08:33:10 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:33:10 INFO - 'tests': ['tp5n']}, 08:33:10 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 08:33:10 INFO - 'talos_options': ['--xperf_path', 08:33:10 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:33:10 INFO - 'tests': ['tp5n']}}, 08:33:10 INFO - 'talos.zip': {'path': '', 08:33:10 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:33:10 INFO - Running post-action listener: _resource_record_post_action 08:33:10 INFO - [mozharness: 2016-12-13 16:33:10.564356Z] Finished populate-webroot step (success) 08:33:10 INFO - [mozharness: 2016-12-13 16:33:10.564466Z] Running create-virtualenv step. 08:33:10 INFO - Running pre-action listener: _resource_record_pre_action 08:33:10 INFO - Running main action method: create_virtualenv 08:33:10 INFO - Creating virtualenv /builds/slave/test/build/venv 08:33:10 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 08:33:10 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:33:10 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:33:10 INFO - Using real prefix '/tools/python27' 08:33:10 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:33:11 INFO - Installing distribute.............................................................................................................................................................................................done. 08:33:14 INFO - Installing pip.................done. 08:33:14 INFO - Return code: 0 08:33:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 08:33:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 08:33:14 INFO - Reading from file tmpfile_stdout 08:33:14 INFO - Output received: 08:33:14 INFO - pip 1.5.5 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 08:33:14 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:33:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:33:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:33:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:33:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:33:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:33:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:33:14 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1056b43f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10562a570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8acbd86e50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1054c9d30>, '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 0x105330db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1054c1b20>, '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.tj4MCtkVGK/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.mgEdqSmSxd/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:33:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 08:33:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 08:33:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tj4MCtkVGK/Render', 08:33:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:33:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:33:14 INFO - 'HOME': '/Users/cltbld', 08:33:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:33:14 INFO - 'LOGNAME': 'cltbld', 08:33:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:33:14 INFO - 'MOZ_NO_REMOTE': '1', 08:33:14 INFO - 'NO_EM_RESTART': '1', 08:33:14 INFO - 'PAGER': '/bin/cat', 08:33:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:33:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:33:14 INFO - 'PWD': '/builds/slave/test', 08:33:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:33:14 INFO - 'SHELL': '/bin/bash', 08:33:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.mgEdqSmSxd/Listeners', 08:33:14 INFO - 'TMPDIR': '/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/', 08:33:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:33:14 INFO - 'USER': 'cltbld', 08:33:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:33:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:33:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:33:14 INFO - 'XPC_FLAGS': '0x0', 08:33:14 INFO - 'XPC_SERVICE_NAME': '0', 08:33:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:33:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:33:14 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 08:33:14 INFO - Cleaning up... 08:33:14 INFO - Return code: 0 08:33:14 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:33:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:33:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:33:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:33:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:33:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:33:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:33:14 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1056b43f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10562a570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8acbd86e50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1054c9d30>, '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 0x105330db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1054c1b20>, '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.tj4MCtkVGK/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.mgEdqSmSxd/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:33:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 08:33:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 08:33:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tj4MCtkVGK/Render', 08:33:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:33:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:33:14 INFO - 'HOME': '/Users/cltbld', 08:33:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:33:14 INFO - 'LOGNAME': 'cltbld', 08:33:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:33:14 INFO - 'MOZ_NO_REMOTE': '1', 08:33:14 INFO - 'NO_EM_RESTART': '1', 08:33:14 INFO - 'PAGER': '/bin/cat', 08:33:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:33:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:33:14 INFO - 'PWD': '/builds/slave/test', 08:33:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:33:14 INFO - 'SHELL': '/bin/bash', 08:33:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.mgEdqSmSxd/Listeners', 08:33:14 INFO - 'TMPDIR': '/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/', 08:33:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:33:14 INFO - 'USER': 'cltbld', 08:33:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:33:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:33:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:33:14 INFO - 'XPC_FLAGS': '0x0', 08:33:14 INFO - 'XPC_SERVICE_NAME': '0', 08:33:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:33:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:33:15 INFO - Downloading/unpacking psutil>=3.1.1 08:33:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:33:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:33:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:33:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:33:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:33:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:33:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:33:18 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:33:18 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:33:18 INFO - Installing collected packages: psutil 08:33:18 INFO - Running setup.py install for psutil 08:33:18 INFO - building 'psutil._psutil_osx' extension 08:33:18 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 08:33:19 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 08:33:19 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 08:33:19 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 08:33:19 INFO - building 'psutil._psutil_posix' extension 08:33:19 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 08:33:19 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 08:33:19 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 08:33:19 INFO - ^ 08:33:19 INFO - 1 warning generated. 08:33:19 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 08:33:19 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:33:19 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:33:19 INFO - Successfully installed psutil 08:33:19 INFO - Cleaning up... 08:33:19 INFO - Return code: 0 08:33:19 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:33: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')]} 08:33:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:33:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:33: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')]} 08:33:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:33:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:33: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1056b43f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10562a570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8acbd86e50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1054c9d30>, '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 0x105330db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1054c1b20>, '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.tj4MCtkVGK/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.mgEdqSmSxd/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:33: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 08:33: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 mozsystemmonitor==0.3 08:33:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tj4MCtkVGK/Render', 08:33:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:33:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:33:19 INFO - 'HOME': '/Users/cltbld', 08:33:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:33:19 INFO - 'LOGNAME': 'cltbld', 08:33:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:33:19 INFO - 'MOZ_NO_REMOTE': '1', 08:33:19 INFO - 'NO_EM_RESTART': '1', 08:33:19 INFO - 'PAGER': '/bin/cat', 08:33:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:33:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:33:19 INFO - 'PWD': '/builds/slave/test', 08:33:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:33:19 INFO - 'SHELL': '/bin/bash', 08:33:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.mgEdqSmSxd/Listeners', 08:33:19 INFO - 'TMPDIR': '/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/', 08:33:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:33:19 INFO - 'USER': 'cltbld', 08:33:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:33:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:33:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:33:19 INFO - 'XPC_FLAGS': '0x0', 08:33:19 INFO - 'XPC_SERVICE_NAME': '0', 08:33:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:33:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:33:20 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:33: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 08:33: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 08:33: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 08:33: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 08:33: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 08:33: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 08:33:22 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:33:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:33:22 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:33:22 INFO - Installing collected packages: mozsystemmonitor 08:33:22 INFO - Running setup.py install for mozsystemmonitor 08:33:22 INFO - Successfully installed mozsystemmonitor 08:33:22 INFO - Cleaning up... 08:33:23 INFO - Return code: 0 08:33:23 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:33: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')]} 08:33:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:33:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:33: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')]} 08:33:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:33:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:33: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', '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 0x1056b43f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10562a570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8acbd86e50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1054c9d30>, '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 0x105330db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1054c1b20>, '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.tj4MCtkVGK/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.mgEdqSmSxd/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:33: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', 'jsonschema==2.5.1'] in /builds/slave/test/build 08:33: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 jsonschema==2.5.1 08:33:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tj4MCtkVGK/Render', 08:33:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:33:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:33:23 INFO - 'HOME': '/Users/cltbld', 08:33:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:33:23 INFO - 'LOGNAME': 'cltbld', 08:33:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:33:23 INFO - 'MOZ_NO_REMOTE': '1', 08:33:23 INFO - 'NO_EM_RESTART': '1', 08:33:23 INFO - 'PAGER': '/bin/cat', 08:33:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:33:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:33:23 INFO - 'PWD': '/builds/slave/test', 08:33:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:33:23 INFO - 'SHELL': '/bin/bash', 08:33:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.mgEdqSmSxd/Listeners', 08:33:23 INFO - 'TMPDIR': '/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/', 08:33:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:33:23 INFO - 'USER': 'cltbld', 08:33:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:33:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:33:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:33:23 INFO - 'XPC_FLAGS': '0x0', 08:33:23 INFO - 'XPC_SERVICE_NAME': '0', 08:33:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:33:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:33:23 INFO - Downloading/unpacking jsonschema==2.5.1 08:33:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:33:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:33:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:33:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:33:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:33:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:33:25 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:33:25 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:33:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:33:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:33:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:33:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:33:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:33:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:33:26 INFO - Downloading functools32-3.2.3-2.tar.gz 08:33:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:33:26 INFO - warning: no files found matching '*.txt' 08:33:26 INFO - no previously-included directories found matching 'build' 08:33:26 INFO - no previously-included directories found matching 'dist' 08:33:26 INFO - no previously-included directories found matching '.git*' 08:33:26 INFO - Installing collected packages: jsonschema, functools32 08:33:26 INFO - Running setup.py install for functools32 08:33:26 INFO - warning: no files found matching '*.txt' 08:33:26 INFO - no previously-included directories found matching 'build' 08:33:26 INFO - no previously-included directories found matching 'dist' 08:33:26 INFO - no previously-included directories found matching '.git*' 08:33:26 INFO - Successfully installed jsonschema functools32 08:33:26 INFO - Cleaning up... 08:33:26 INFO - Return code: 0 08:33:26 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 08:33:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:33:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:33:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:33:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:33:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:33:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:33:26 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 0x1056b43f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10562a570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8acbd86e50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1054c9d30>, '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 0x105330db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1054c1b20>, '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.tj4MCtkVGK/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.mgEdqSmSxd/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:33:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 08:33:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 08:33:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tj4MCtkVGK/Render', 08:33:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:33:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:33:26 INFO - 'HOME': '/Users/cltbld', 08:33:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:33:26 INFO - 'LOGNAME': 'cltbld', 08:33:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:33:26 INFO - 'MOZ_NO_REMOTE': '1', 08:33:26 INFO - 'NO_EM_RESTART': '1', 08:33:26 INFO - 'PAGER': '/bin/cat', 08:33:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:33:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:33:26 INFO - 'PWD': '/builds/slave/test', 08:33:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:33:26 INFO - 'SHELL': '/bin/bash', 08:33:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.mgEdqSmSxd/Listeners', 08:33:26 INFO - 'TMPDIR': '/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/', 08:33:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:33:26 INFO - 'USER': 'cltbld', 08:33:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:33:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:33:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:33:26 INFO - 'XPC_FLAGS': '0x0', 08:33:26 INFO - 'XPC_SERVICE_NAME': '0', 08:33:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:33:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:33:26 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 08:33:26 INFO - Cleaning up... 08:33:26 INFO - Return code: 0 08:33:26 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:33:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:33:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:33:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:33:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:33:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:33:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:33:26 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 0x1056b43f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10562a570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8acbd86e50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1054c9d30>, '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 0x105330db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1054c1b20>, '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.tj4MCtkVGK/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.mgEdqSmSxd/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:33:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 08:33:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 08:33:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tj4MCtkVGK/Render', 08:33:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:33:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:33:26 INFO - 'HOME': '/Users/cltbld', 08:33:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:33:26 INFO - 'LOGNAME': 'cltbld', 08:33:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:33:26 INFO - 'MOZ_NO_REMOTE': '1', 08:33:26 INFO - 'NO_EM_RESTART': '1', 08:33:26 INFO - 'PAGER': '/bin/cat', 08:33:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:33:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:33:26 INFO - 'PWD': '/builds/slave/test', 08:33:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:33:26 INFO - 'SHELL': '/bin/bash', 08:33:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.mgEdqSmSxd/Listeners', 08:33:26 INFO - 'TMPDIR': '/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/', 08:33:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:33:26 INFO - 'USER': 'cltbld', 08:33:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:33:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:33:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:33:26 INFO - 'XPC_FLAGS': '0x0', 08:33:26 INFO - 'XPC_SERVICE_NAME': '0', 08:33:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:33:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:33:27 INFO - Downloading/unpacking blobuploader==1.2.4 08:33: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 08:33: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 08:33: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 08:33: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 08:33: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 08:33: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 08:33:29 INFO - Downloading blobuploader-1.2.4.tar.gz 08:33:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:33:29 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:33:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:33:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:33:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:33:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:33:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:33:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:33:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:33:30 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:33:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:33:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:33:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:33:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:33:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:33:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:33:31 INFO - Downloading docopt-0.6.1.tar.gz 08:33:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:33:31 INFO - Installing collected packages: blobuploader, requests, docopt 08:33:31 INFO - Running setup.py install for blobuploader 08:33:31 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:33:31 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:33:31 INFO - Running setup.py install for requests 08:33:31 INFO - Running setup.py install for docopt 08:33:31 INFO - Successfully installed blobuploader requests docopt 08:33:31 INFO - Cleaning up... 08:33:32 INFO - Return code: 0 08:33:32 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:33:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:33:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:33:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:33:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:33:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:33:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:33:32 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 0x1056b43f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10562a570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8acbd86e50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1054c9d30>, '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 0x105330db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1054c1b20>, '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.tj4MCtkVGK/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.mgEdqSmSxd/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:33:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 08:33:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:33:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tj4MCtkVGK/Render', 08:33:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:33:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:33:32 INFO - 'HOME': '/Users/cltbld', 08:33:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:33:32 INFO - 'LOGNAME': 'cltbld', 08:33:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:33:32 INFO - 'MOZ_NO_REMOTE': '1', 08:33:32 INFO - 'NO_EM_RESTART': '1', 08:33:32 INFO - 'PAGER': '/bin/cat', 08:33:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:33:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:33:32 INFO - 'PWD': '/builds/slave/test', 08:33:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:33:32 INFO - 'SHELL': '/bin/bash', 08:33:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.mgEdqSmSxd/Listeners', 08:33:32 INFO - 'TMPDIR': '/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/', 08:33:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:33:32 INFO - 'USER': 'cltbld', 08:33:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:33:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:33:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:33:32 INFO - 'XPC_FLAGS': '0x0', 08:33:32 INFO - 'XPC_SERVICE_NAME': '0', 08:33:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:33:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:33:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:33:32 INFO - Running setup.py (path:/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/pip-KSqDOs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:33:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:33:32 INFO - Running setup.py (path:/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/pip-_0TWFW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:33:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:33:32 INFO - Running setup.py (path:/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/pip-uifJgb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:33:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:33:32 INFO - Running setup.py (path:/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/pip-VzYk76-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:33:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:33:32 INFO - Running setup.py (path:/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/pip-5blO84-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:33:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:33:32 INFO - Running setup.py (path:/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/pip-zMa_qp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:33:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:33:32 INFO - Running setup.py (path:/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/pip-WQonnE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:33:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:33:32 INFO - Running setup.py (path:/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/pip-aR51I5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:33:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:33:33 INFO - Running setup.py (path:/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/pip-fubXlF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:33:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:33:33 INFO - Running setup.py (path:/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/pip-NFxiSf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:33:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:33:33 INFO - Running setup.py (path:/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/pip-g26kOm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:33:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:33:33 INFO - Running setup.py (path:/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/pip-1plMP_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:33:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:33:33 INFO - Running setup.py (path:/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/pip-hd3YVy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:33:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:33:33 INFO - Running setup.py (path:/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/pip-mseaXw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:33:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:33:33 INFO - Running setup.py (path:/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/pip-GCITxI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:33:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:33:33 INFO - Running setup.py (path:/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/pip-TuRMs2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:33:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:33:33 INFO - Running setup.py (path:/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/pip-5B4do5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:33:34 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:33:34 INFO - Running setup.py install for manifestparser 08:33:34 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:33:34 INFO - Running setup.py install for mozcrash 08:33:34 INFO - Running setup.py install for mozdebug 08:33:34 INFO - Running setup.py install for mozdevice 08:33:34 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:33:34 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:33:34 INFO - Running setup.py install for mozfile 08:33:34 INFO - Running setup.py install for mozhttpd 08:33:34 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:33:34 INFO - Running setup.py install for mozinfo 08:33:35 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:33:35 INFO - Running setup.py install for mozInstall 08:33:35 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:33:35 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:33:35 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:33:35 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:33:35 INFO - Running setup.py install for mozleak 08:33:35 INFO - Running setup.py install for mozlog 08:33:35 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:33:35 INFO - Running setup.py install for moznetwork 08:33:35 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:33:35 INFO - Running setup.py install for mozprocess 08:33:35 INFO - Running setup.py install for mozprofile 08:33:35 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:33:35 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:33:35 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:33:35 INFO - Running setup.py install for mozrunner 08:33:36 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:33:36 INFO - Running setup.py install for mozscreenshot 08:33:36 INFO - Running setup.py install for moztest 08:33:36 INFO - Running setup.py install for mozversion 08:33:36 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:33:36 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:33:36 INFO - Cleaning up... 08:33:36 INFO - Return code: 0 08:33:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:33:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:33:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:33:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:33:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:33:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:33:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:33:36 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 0x1056b43f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10562a570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8acbd86e50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1054c9d30>, '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 0x105330db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1054c1b20>, '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.tj4MCtkVGK/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.mgEdqSmSxd/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:33:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 08:33:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:33:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tj4MCtkVGK/Render', 08:33:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:33:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:33:36 INFO - 'HOME': '/Users/cltbld', 08:33:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:33:36 INFO - 'LOGNAME': 'cltbld', 08:33:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:33:36 INFO - 'MOZ_NO_REMOTE': '1', 08:33:36 INFO - 'NO_EM_RESTART': '1', 08:33:36 INFO - 'PAGER': '/bin/cat', 08:33:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:33:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:33:36 INFO - 'PWD': '/builds/slave/test', 08:33:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:33:36 INFO - 'SHELL': '/bin/bash', 08:33:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.mgEdqSmSxd/Listeners', 08:33:36 INFO - 'TMPDIR': '/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/', 08:33:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:33:36 INFO - 'USER': 'cltbld', 08:33:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:33:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:33:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:33:36 INFO - 'XPC_FLAGS': '0x0', 08:33:36 INFO - 'XPC_SERVICE_NAME': '0', 08:33:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:33:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:33:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:33:36 INFO - Running setup.py (path:/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/pip-Lo2IID-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:33:36 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 08:33:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:33:36 INFO - Running setup.py (path:/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/pip-nSF8IU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:33:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:33:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:33:37 INFO - Running setup.py (path:/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/pip-QGK2xG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:33:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 08:33:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:33:37 INFO - Running setup.py (path:/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/pip-eWKXu0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:33:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:33:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:33:37 INFO - Running setup.py (path:/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/pip-OTjH7F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:33:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 08:33:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:33:37 INFO - Running setup.py (path:/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/pip-GCUhxf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:33:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 08:33:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:33:37 INFO - Running setup.py (path:/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/pip-bXrYsq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:33:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 08:33:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:33:37 INFO - Running setup.py (path:/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/pip-C2SAZR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:33:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 08:33:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:33:37 INFO - Running setup.py (path:/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/pip-PEUnaK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:33:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 08:33:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:33:37 INFO - Running setup.py (path:/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/pip-ebpNkD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:33:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:33:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:33:37 INFO - Running setup.py (path:/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/pip-jTlZ1f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:33:38 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 08:33:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:33:38 INFO - Running setup.py (path:/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/pip-HvtwMJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:33:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 08:33:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:33:38 INFO - Running setup.py (path:/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/pip-HaBq3r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:33:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 08:33:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:33:38 INFO - Running setup.py (path:/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/pip-E6qVqx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:33:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 08:33:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:33:38 INFO - Running setup.py (path:/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/pip-e6fBIS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:33:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 08:33:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:33:38 INFO - Running setup.py (path:/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/pip-ap8q8e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:33:38 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 08:33:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:33:38 INFO - Running setup.py (path:/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/pip-ARiQBj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:33:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 08:33:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:33:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:33:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 08:33:38 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:33:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:33:38 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:33:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:33:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:33:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:33:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:33:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:33:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:33:41 INFO - Downloading blessings-1.6.tar.gz 08:33:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:33:41 INFO - Installing collected packages: blessings 08:33:41 INFO - Running setup.py install for blessings 08:33:41 INFO - Successfully installed blessings 08:33:41 INFO - Cleaning up... 08:33:42 INFO - Return code: 0 08:33:42 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:33:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:33:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:33:42 INFO - Reading from file tmpfile_stdout 08:33:42 INFO - Current package versions: 08:33:42 INFO - blessings == 1.6 08:33:42 INFO - blobuploader == 1.2.4 08:33:42 INFO - docopt == 0.6.1 08:33:42 INFO - functools32 == 3.2.3-2 08:33:42 INFO - jsonschema == 2.5.1 08:33:42 INFO - manifestparser == 1.1 08:33:42 INFO - mozInstall == 1.12 08:33:42 INFO - mozcrash == 1.0 08:33:42 INFO - mozdebug == 0.1 08:33:42 INFO - mozdevice == 0.49 08:33:42 INFO - mozfile == 1.2 08:33:42 INFO - mozhttpd == 0.7 08:33:42 INFO - mozinfo == 0.9 08:33:42 INFO - mozleak == 0.1 08:33:42 INFO - mozlog == 3.4 08:33:42 INFO - moznetwork == 0.27 08:33:42 INFO - mozprocess == 0.23 08:33:42 INFO - mozprofile == 0.28 08:33:42 INFO - mozrunner == 6.13 08:33:42 INFO - mozscreenshot == 0.1 08:33:42 INFO - mozsystemmonitor == 0.3 08:33:42 INFO - moztest == 0.7 08:33:42 INFO - mozversion == 1.4 08:33:42 INFO - psutil == 3.1.1 08:33:42 INFO - requests == 1.2.3 08:33:42 INFO - wsgiref == 0.1.2 08:33:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:33:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:33:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:33:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:33:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:33:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:33:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:33:42 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 0x1056b43f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10562a570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8acbd86e50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1054c9d30>, '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 0x105330db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1054c1b20>, '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.tj4MCtkVGK/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.mgEdqSmSxd/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:33:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 08:33:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:33:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tj4MCtkVGK/Render', 08:33:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:33:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:33:42 INFO - 'HOME': '/Users/cltbld', 08:33:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:33:42 INFO - 'LOGNAME': 'cltbld', 08:33:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:33:42 INFO - 'MOZ_NO_REMOTE': '1', 08:33:42 INFO - 'NO_EM_RESTART': '1', 08:33:42 INFO - 'PAGER': '/bin/cat', 08:33:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:33:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:33:42 INFO - 'PWD': '/builds/slave/test', 08:33:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:33:42 INFO - 'SHELL': '/bin/bash', 08:33:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.mgEdqSmSxd/Listeners', 08:33:42 INFO - 'TMPDIR': '/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/', 08:33:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:33:42 INFO - 'USER': 'cltbld', 08:33:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:33:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:33:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:33:42 INFO - 'XPC_FLAGS': '0x0', 08:33:42 INFO - 'XPC_SERVICE_NAME': '0', 08:33:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:33:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:33:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 08:33:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 08:33:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 08:33:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 08:33:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 08:33:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 08:33:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 08:33:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 08:33:43 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 08:33:43 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 08:33:43 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 08:33:43 INFO - Cleaning up... 08:33:43 INFO - Return code: 0 08:33:43 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:33:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:33:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:33:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:33:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:33:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:33:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:33:43 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 0x1056b43f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10562a570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8acbd86e50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1054c9d30>, '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 0x105330db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1054c1b20>, '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.tj4MCtkVGK/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.mgEdqSmSxd/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:33:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 08:33:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 08:33:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tj4MCtkVGK/Render', 08:33:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:33:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:33:43 INFO - 'HOME': '/Users/cltbld', 08:33:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:33:43 INFO - 'LOGNAME': 'cltbld', 08:33:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:33:43 INFO - 'MOZ_NO_REMOTE': '1', 08:33:43 INFO - 'NO_EM_RESTART': '1', 08:33:43 INFO - 'PAGER': '/bin/cat', 08:33:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:33:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:33:43 INFO - 'PWD': '/builds/slave/test', 08:33:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:33:43 INFO - 'SHELL': '/bin/bash', 08:33:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.mgEdqSmSxd/Listeners', 08:33:43 INFO - 'TMPDIR': '/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/', 08:33:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:33:43 INFO - 'USER': 'cltbld', 08:33:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:33:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:33:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:33:43 INFO - 'XPC_FLAGS': '0x0', 08:33:43 INFO - 'XPC_SERVICE_NAME': '0', 08:33:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:33:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:33:43 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:33:43 INFO - Cleaning up... 08:33:43 INFO - Return code: 0 08:33:43 INFO - Running post-action listener: _resource_record_post_action 08:33:43 INFO - Running post-action listener: _start_resource_monitoring 08:33:43 INFO - Starting resource monitoring. 08:33:43 INFO - [mozharness: 2016-12-13 16:33:43.347421Z] Finished create-virtualenv step (success) 08:33:43 INFO - [mozharness: 2016-12-13 16:33:43.348473Z] Running install step. 08:33:43 INFO - Running pre-action listener: _resource_record_pre_action 08:33:43 INFO - Running main action method: install 08:33:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:33:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:33:43 INFO - Reading from file tmpfile_stdout 08:33:43 INFO - Detecting whether we're running mozinstall >=1.0... 08:33:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:33:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:33:43 INFO - Reading from file tmpfile_stdout 08:33:43 INFO - Output received: 08:33:43 INFO - Usage: mozinstall [options] installer 08:33:43 INFO - Options: 08:33:43 INFO - -h, --help show this help message and exit 08:33:43 INFO - -d DEST, --destination=DEST 08:33:43 INFO - Directory to install application into. [default: 08:33:43 INFO - "/builds/slave/test"] 08:33:43 INFO - --app=APP Application being installed. [default: firefox] 08:33:43 INFO - mkdir: /builds/slave/test/build/application 08:33:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0a1.en-US.mac64.dmg', '--destination', '/builds/slave/test/build/application'] 08:33:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0a1.en-US.mac64.dmg --destination /builds/slave/test/build/application 08:34:05 INFO - Reading from file tmpfile_stdout 08:34:05 INFO - Output received: 08:34:05 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 08:34:05 INFO - Running post-action listener: _resource_record_post_action 08:34:05 INFO - [mozharness: 2016-12-13 16:34:05.530439Z] Finished install step (success) 08:34:05 INFO - [mozharness: 2016-12-13 16:34:05.530608Z] Running run-tests step. 08:34:05 INFO - Running pre-action listener: _resource_record_pre_action 08:34:05 INFO - Running main action method: run_tests 08:34:05 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 08:34:05 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 08:34:05 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 08:34:05 INFO - 2016-12-13 08:34:05.545 screenresolution[1637:7646] starting screenresolution argv=screenresolution get 08:34:05 INFO - 2016-12-13 08:34:05.548 screenresolution[1637:7646] Display 0: 1600x1200x32@60 08:34:05 INFO - 2016-12-13 08:34:05.554 screenresolution[1638:7648] starting screenresolution argv=screenresolution list 08:34:05 INFO - Available Modes on Display 0 08:34:05 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 08:34:05 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 08:34:05 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 08:34:05 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 08:34:05 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 08:34:05 INFO - Intel Iris: 08:34:05 INFO - Chipset Model: Intel Iris 08:34:05 INFO - Type: GPU 08:34:05 INFO - Bus: Built-In 08:34:05 INFO - VRAM (Dynamic, Max): 1536 MB 08:34:05 INFO - Vendor: Intel (0x8086) 08:34:05 INFO - Device ID: 0x0a2e 08:34:05 INFO - Revision ID: 0x0009 08:34:05 INFO - Displays: 08:34:05 INFO - Display: 08:34:05 INFO - Resolution: 1600 x 1200 @ 60 Hz 08:34:05 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 08:34:05 INFO - Display Serial Number: 1600x1200 60 08:34:05 INFO - Main Display: Yes 08:34:05 INFO - Mirror: Off 08:34:05 INFO - Online: Yes 08:34:05 INFO - Rotation: Supported 08:34:05 INFO - Return code: 0 08:34:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:34:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:34:05 INFO - Python 2.7.3 08:34:05 INFO - Return code: 0 08:34:05 INFO - grabbing minidump binary from tooltool 08:34:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:34:05 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 0x1054c9d30>, '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 0x105330db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1054c1b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:34:05 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 08:34:05 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 08:34:05 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 08:34:05 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:34:05 INFO - Return code: 0 08:34:05 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 08:34:05 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:34:05 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:34:05 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 08:34:05 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:34:05 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/BmhrU5ufT7yOHH9Ugz2EyA/artifacts/public/build/firefox-53.0a1.en-US.mac64.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0181', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 08:34:05 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/BmhrU5ufT7yOHH9Ugz2EyA/artifacts/public/build/firefox-53.0a1.en-US.mac64.crashreporter-symbols.zip --title t-yosemite-r7-0181 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 08:34:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tj4MCtkVGK/Render', 08:34:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:34:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:34:05 INFO - 'HOME': '/Users/cltbld', 08:34:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:34:05 INFO - 'LOGNAME': 'cltbld', 08:34:05 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:34:05 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 08:34:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:34:05 INFO - 'MOZ_NO_REMOTE': '1', 08:34:05 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:34:05 INFO - 'NO_EM_RESTART': '1', 08:34:05 INFO - 'PAGER': '/bin/cat', 08:34:05 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:34:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:34:05 INFO - 'PWD': '/builds/slave/test', 08:34:05 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:34:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:34:05 INFO - 'SHELL': '/bin/bash', 08:34:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.mgEdqSmSxd/Listeners', 08:34:05 INFO - 'TMPDIR': '/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/', 08:34:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:34:05 INFO - 'USER': 'cltbld', 08:34:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:34:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:34:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:34:05 INFO - 'XPC_FLAGS': '0x0', 08:34:05 INFO - 'XPC_SERVICE_NAME': '0', 08:34:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:34:05 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/BmhrU5ufT7yOHH9Ugz2EyA/artifacts/public/build/firefox-53.0a1.en-US.mac64.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0181', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 08:34:06 INFO - mozversion application_buildid: 20161213070501 08:34:06 INFO - mozversion application_changeset: cb369201f52f7f4c9cb35c3e7dca9262b13f006b 08:34:06 INFO - mozversion application_display_name: Nightly 08:34:06 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:34:06 INFO - mozversion application_name: Firefox 08:34:06 INFO - mozversion application_remotingname: firefox 08:34:06 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 08:34:06 INFO - mozversion application_vendor: Mozilla 08:34:06 INFO - mozversion application_version: 53.0a1 08:34:06 INFO - mozversion platform_buildid: 20161213070501 08:34:06 INFO - mozversion platform_changeset: cb369201f52f7f4c9cb35c3e7dca9262b13f006b 08:34:06 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 08:34:06 INFO - mozversion platform_version: 53.0a1 08:34:06 INFO - using testdate: 1481646846 08:34:06 INFO - actual date: 1481646846 08:34:06 INFO - starting webserver on 'localhost:49241' 08:34:06 INFO - SUITE-START | Running 2 tests 08:34:06 INFO - TEST-START | dromaeo_css 08:34:06 INFO - operating with platform_type : mac_ 08:34:06 INFO - Initialising browser for dromaeo_css test... 08:34:06 INFO - TEST-INFO | started process 1648 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/tmpdJj17G/profile http://localhost:49241/getInfo.html) 08:34:08 INFO - PROCESS | 1648 | __metrics Screen width/height:1600/1200 08:34:08 INFO - PROCESS | 1648 | colorDepth:24 08:34:08 INFO - PROCESS | 1648 | Browser inner width/height: 1024/689 08:34:08 INFO - PROCESS | 1648 | __metrics 08:34:08 INFO - PROCESS | 1648 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 08:34:08 INFO - PROCESS | 1648 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:34:09 INFO - TEST-INFO | 1648: exit 0 08:34:09 INFO - Browser initialized. 08:34:09 INFO - Running cycle 1/1 for dromaeo_css test... 08:34:09 INFO - TEST-INFO | started process 1650 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/tmpdJj17G/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:34:21 INFO - PROCESS | 1650 | RSS: Main: 237420544 08:34:21 INFO - PROCESS | 1650 | 08:35:12 INFO - PROCESS | 1650 | 1481646912635 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 08:37:25 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49241/tests/dromaeo/cssquery-ext.html) 08:37:27 INFO - PROCESS | 1650 | RSS: Main: 387989504 08:37:27 INFO - PROCESS | 1650 | 08:40:30 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-ext.html (next: http://localhost:49241/tests/dromaeo/cssquery-jquery.html) 08:40:31 INFO - PROCESS | 1650 | RSS: Main: 372035584 08:40:31 INFO - PROCESS | 1650 | 08:43:33 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49241/tests/dromaeo/cssquery-mootools.html) 08:43:34 INFO - PROCESS | 1650 | RSS: Main: 342036480 08:43:34 INFO - PROCESS | 1650 | 08:46:36 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49241/tests/dromaeo/cssquery-prototype.html) 08:46:37 INFO - PROCESS | 1650 | RSS: Main: 340987904 08:46:37 INFO - PROCESS | 1650 | 08:49:40 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49241/tests/dromaeo/cssquery-yui.html) 08:49:41 INFO - PROCESS | 1650 | RSS: Main: 336830464 08:49:41 INFO - PROCESS | 1650 | 08:52:44 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-yui.html (next: http://localhost:49241/tests/dromaeo/cssquery-dojo.html) 08:52:44 INFO - PROCESS | 1650 | RSS: Main: 502104064 08:52:44 INFO - PROCESS | 1650 | 08:52:44 INFO - PROCESS | 1650 | __start_tp_report 08:52:44 INFO - PROCESS | 1650 | _x_x_mozilla_page_load 08:52:44 INFO - PROCESS | 1650 | _x_x_mozilla_page_load_details 08:52:44 INFO - PROCESS | 1650 | |i|pagename|runs| 08:52:44 INFO - PROCESS | 1650 | |0;dojo.html;3329.683680050395;3338.9332213355733;3345.39782839089;3347.681970212829;3385.7629965902383;4699.506551812062;5069.493050694929;5533.253010843535;5594.664320140794;5624.240727501786;5596.27248457701;5623.044082505973;5680.289963754531;5683.3464151622575;5698.487136157745;5146.74266286686;5226.033183860998;5230.816921407752;5236.4763523647525;5264.947350526503;5151.021305951857;5217.686938783666;5271.28837606922;5284.471552844704;5286.180642000477;4378.9562104378865;5274.604404669646;5305.7877684892555;5318.202269659562;5323.760430780624;5091.592672586185;5231.738413079369;5242.97378513105;5266.683998960056;5272.367315922075;5045.571126454256;5142.202958541432;5185.299984502081;5188.429272779991;5200.531952124327;5593.916091258634;5628.774849006035;5651.265335506399;5670.744816483269;5705.058665320217;6187.3503282155625;6190.350013248589;6193.597416167935;6193.938060619381;6207.689615519251;6104.883608894094;6106.346824600314;6163.753449862;6166.198394208769;6206.906896396557;4770.976145119287;5681.431856814285;5757.942420575824;5799.768009279624;5803.912941305884;6314.242290925118;6319.178506794087;6328.208973878265;6340.4293613575;6356.904646430215;5952.226210592596;6023.337432882379;6034.24571928509;6104.992676208465;6119.602225855305;6164.982777841606;6176.320604733476;6219.844503887439;6232.75068997235;6277.058441233851;6169.629822210592;6176.289726681399;6180.196574445294;6181.381861813783;6189.164462797465;6147.385261473817;6158.137860699506;6205.410486003822;6218.657973811393;6219.595726277777;4839.516048395132;4886.242632391985;4892.412910450697;4900.313956046157;4917.827876024322;4389.078293558325;4406.515283318832;4416.734995900256;4438.844640437569;4453.910921781546;5752.33848107473;5763.308402991668;5763.85590360236;5770.394108618619;5780.624259423124;6032.245969253843;6106.642687876592;6146.293176284785;6254.718537665816;6262.530310226751;5688.687122208318;5757.9424205757405;5766.336871259775;5769.163471296639;5773.191753154561;5338.839834804962;5342.652727572696;5345.198220266913;5351.956368508104;5384.326959130109;5485.424030476823;6172.85802126608;6344.4290013897125;6346.492280617632;6359.268684101387;6189.245785625353;6232.407921247474;6241.750329986749;6247.96876015617;6256.937430625818;6254.749810007549;6282.623042617458;6320.5575609706875;6322.399372059647;6337.90493142594;6114.877702446015;6134.528431832324;6153.230846144232;6156.876862462816;6156.984097623842;6207.286162091236;6217.813465596039;6231.626102433868;6235.875282494416;6247.062940558771;5863.94136058651;5923.052311630291;6032.245969253843;6038.064100064497;6047.727852246571;5962.821115366546;5970.3432622412365;5997.670128142994;6023.518118550418;6073;5439.972800135974;5853.209816674695;5863.677497737494;5868.031774757117;5871.588988770745;5730.74211660468;6015.338312785678;6033.3061697905305;6047.969760151171;6051.122587224916;5712.685802280915;5788.986927287624;5824.097264923944;5853.560982926383;5872.794452194153 08:52:44 INFO - PROCESS | 1650 | |1;ext.html;445.31199297086;477.04828866411503;492.618220878819;502.14133831148735;511.64440713703993;30582;37890.62109378906;39940;41279.38080928788;41279.793601032026;42450.15099698004;42714.786426067905;42816.14367712644;42823.00238983273;42836;9267.39761915475;9472.952635236848;9474.099960503741;9475.620975160986;9517.5717092731;8496.957515212416;8750.606222719962;11070.28043177195;11330;11331;11261.4369281536;11350.43247837609;11350.772984540345;11363.488643011044;11379.146564007691;8505.277051450634;11267.26762760418;11340.829887551694;11350.772984540345;11359.545618175263;8499.915000849975;9439.386439881386;10983.176261780398;11288.943555282252;11446.370449625267;39132.41301380481;39344.80327598372;40226.798866005774;40260;40576.797116014524;3414.709749671281;3427.143214196451;3452.3267962747273;3694.6674799268194;3795.8481660733537;29862.552061719092;30184.8490757547;30299.242518937204;30320;30541.847290763402;3154.9684503154904;3169.2869104451315;3176.4600017996995;3242.0435971388497;3262.3475304939107;488715.55642221915;488823.1117688813;490234.6464803031;490821;491069;62559.6872015637;62842.0573691395;62855.42861428501;62951;63029;65686.0147097794;65690.34309656842;65752.67123664351;65859.71911825812;65875;13279.26964016969;14923.626909327353;15362.539123826304;15724.921375393049;15948.601284967737;11778.234414763014;11778.587749428729;11899.524019039314;11906.166568340306;11931.58239461632;17136.742948855775;17203.967761934073;17241.741373879402;17284.91357543204;17323.960562366046;7308.707651693872;7351.301626345488;7427.962860185773;7469.153386006211;7484.812879677943;869.3697069624471;870.4690139015196;1012.6658202793061;1040.6825918095053;1052.8894466081103;27629.897360117877;30327.545086823717;30335;31179.68820311768;31264.37471250562;924.7872989212519;1040.6669865643073;1091.5306418240075;1095.2442814457997;1101.2291396022815;12102.152849300464;14054.929725351309;14302.284885755878;15237;16115.838841611669;648340;653707;655306;655370;655484;59874;60261.69869150626;60283.397166027775;60372;60385.69807150936;1256.434604428011;1289.1105137455127;1382.7718426459521;1387.3132799264429;1400.733860566489;29635.703642963294;31052.534211986385;31108.533371998987;31242.687573123978;32181.517277240393;51365.7431712839;52089;52092.21861672154;52133.21800173076;52296.69258268574;547965;552284;553232;553728;554891;38280.61719382882;39167.608323917535;39310.80344598259;40976.590234097275;41561.58438415698;41821.581784182985;41952.95117622084;42702.57297426986;42815;43443.9139021527;35361.82319088388;35808;35812.462813057304;35906.4614030795;36448.45327320039;34960.475592866635;35075.82462087673;35672.821635891654;36137.457938131476;36227.45658815067;34584.48123278203;34639.13402164966;34813;35343;35354.29291414209;30495.542566861957;31836;31839.522407163447;31973.68026319707;32682;23691.763082369645;23798.643020355055;23956.963419899814;23985.760142398354;24391 08:52:44 INFO - PROCESS | 1650 | |2;jquery.html;350.54954383617024;365.19838953497066;375.1109869609026;381.68129611774174;398.6233009805733;14607.926960365197;14881.18153501557;15420.739365478088;20655.69016464754;20728;19317.420477385665;19821.801781982176;20399.898000510013;20552.897235513803;20733.274335398262;1625.878059145563;1627;1627.0644379481787;1628.421910221866;1829.1128802530761;4018.216447792667;4267.381229721688;5740.79907203248;5881.558883083764;5895.086261629433;4295.398644189816;6403.103565500834;6420.486361091102;6450.161479007723;6453.677316134198;6175.07373893915;6317.526185536103;6434.646094464802;6437.485001199892;6447.967760161216;5614.3718321686665;5628.465295796893;5628.690422026787;5637.80267690633;5638.295213098363;24265.636015459782;24345.1479198229;24654.753452465604;25242.990280388763;25496.745032549807;2176.3144609447972;2389.7067994392505;2448.5837407640743;2811.2971757060736;2995.6405231372373;9207.849018872641;9574.329796914219;9657.661981830603;10200.48997550127;10301.79396412075;1466.6406730351025;1524.695060987807;1775.8401743843117;1811.1306572844976;1860.2744929477515;114682;118090.40954795257;118465;118739;118882.4055879715;11168;11274.492647830868;11374.132794849791;11388.715282118013;11624.593139240085;14056.71886562263;14331.140131592138;14352.641183970485;14371.281435928371;14396.136231826124;8157.877631835528;8298.294644955246;8310.875336869953;8482.491050536988;8496.872546911802;8207.466514676646;8215.95892020548;8234.670613175525;8363.080061193265;8440.409171357946;4360.716553424018;4471.32930060487;4477.7984990675495;4533.5013148553635;4647.697899636512;1849.546861019059;1897.3643829317334;1923.0961448119363;1961.6861302191867;1967.6163148185967;726.5386479585501;787.9606019698992;843.9913007043198;879.3448880584006;972.5331840716495;18562.79341842776;19564.510887227934;20386.592268154553;20786.48033799167;20823.479413014797;854.89291367679;867.8958524977044;926.0091701878924;932.524412549591;991.7520619845038;10565.260431769702;11150.21948463616;11159.665210043711;11170.93876081771;11204.93553112453;539297;548868;560601.5608985403;562893;564155;113815;122222;124318;128352.35823820821;129271;964.7154089543461;981.0532835813474;993.8658281132099;995.5271246158162;995.6067353395368;18560.5359865999;18771.71842422392;18970.051497424796;18977.240910363984;19035;55414.13373860163;55736.049238276464;56003.159952599926;57675.711621443304;57912;69168;81205.59397202976;81274.59362703149;81944.59027704824;83121.16878831376;6696.19645642526;7534.585597792174;7734.5359278443475;7934.801629959297;7977;11849.763004739685;11896.22674526153;12177.147599667938;12873.356332183166;13237.073404861567;10283.94858025705;10560.788784224425;10651.733706657396;10928.726781830517;11285.661430157108;10841.18691098155;10994.28537145083;11004.889951100708;11225.494852731483;11377.203595748219;11145.275557088764;11392;11733.237339572901;11759.706007349885;11773.999210066897;7868.173841746763;8358.95820520918;11214.383208923588;11601.361925094201;11968;10318.845217321896;11510.597129100775;11713.1800773945;12055.939720301343;12156 08:52:44 INFO - PROCESS | 1650 | |3;mootools.html;1479.881609471242;1510.7733839924006;1674.8073971493275;1727.490390334851;1848.833604975552;8002.919970800291;8401.453905496139;8407.369447291447;8409.159084091603;8421;6526.543141980063;7427.257274272583;7680.769576912688;7777.066751989769;8173.7547873563735;1966.6066786642657;2263.1400067974187;2325.4535184231777;2325.6278995360744;2329.487512747193;1993.3023441795328;2313.6529520571967;2329.8485598436046;2332.626779715246;2354.2701762453607;2294.6443301288245;2299.9310020699404;2329.312852708447;2330.487292795582;2334.253039027512;2274.1812947338944;2308.8383813133087;2312.2022902098747;2320.1879342230254;2322.581935251654;2317.8029867461287;2346.495503466746;2348.964765528501;2353.5881220786464;2358.2099996501192;8168.428210025241;8262.669493220264;8376.455530390505;8384.958075209646;8413.07456179826;4992.226204938241;5168.3281173447585;5173.120569503156;5184.896302073975;5193.2989046479;3310.2882880180878;3381.442062059757;3602.0454579536445;3612.692921101683;3614.34941710492;1053.3153450257316;1067.9786404271872;1074.4305518075432;1098.1873413673904;1101.1521128730913;10770.946145269223;10792.838107428395;10916.563337466492;10937.398443085707;10964.616238431696;4363.847265345697;4486.551344865487;4560.270356742905;4592.908141837212;4603;8447.788805279917;8796.164364385373;9329.440233586007;9331.253499720005;9338.066193380608;5175.275461435402;5179.585633149339;5184.015037143006;5185.196294574347;5187.636865419385;3853.402722578005;4211.368294755811;4725.929111063337;4742.976285118552;4755.595774359218;3731.384321586962;3734.6452087051684;3824.827882745283;3849.4225866120305;3870.2066076454257;1064.6539874540806;1258.8867001969866;1267.4359909840216;1280.359820089955;1282.9992605767516;838.5054462972729;847.0978407995465;888.9777755556033;889.2841262783392;915.1763412928418;5218.6868787872845;5253.527182553588;5501.477359650827;5653.23681303027;5787.971060144757;899.8437008444118;917.5228880981851;949.6941705155411;959.2445824141804;996.9225866207247;3794.317022935843;3819.9427008594894;3870.264649716601;3953.3081710701085;4007.138465229931;8382.580870956428;9861.852072218922;9925.255605829592;10064.194864410829;10074.546645400975;10023.997600239918;10027.649032283982;10031.347962382422;10033.498325083716;10047.246456515644;7649.349805266504;7897.210278972172;7903.41931613668;7908.565028923349;7909.1299957004685;5334.439469054953;5484.698341591251;5596.86007849807;5652.145731223793;5812.883742325214;8400.82388465603;8435.355105754319;8664.956675216583;8701.8694719578;9325.533723313943;7709.7301594443925;9102.453852768855;9427;9431.962484126603;9455.95272023663;6540.901886471612;6565.934340656723;6701.966490167518;6992.510524263456;7186.856262874818;7859.685612575433;7893.210678932061;7950.840983180419;7963.323117535075;7971.840563188588;6990.685419156252;7097.893531596927;7098.396636285974;7194.748183813542;7257.52826066304;6927.307269273032;6932.434776145129;6994.548601239939;7089.397401220954;7111.7866464006165;6522.478201743944;6563.343665633399;6605.5376123670885;6607.933920660732;6618.238902526271;4695.647826412965;4755.690880092783;4757.952420475889;4839.975800121118;4883.9011222474655;4601.769911504478;4728.527147285382;4838.419389673261;4901.1913034350355;5002.374703162105 08:52:44 INFO - PROCESS | 1650 | |4;prototype.html;325.9494778309362;352.50297081115633;359.94600809878517;369.123332086295;370.4665281993928;4523.932141017884;4618.58224913564;4742.055757139574;5419.780549376388;5423.674579525231;4027.8791636250885;4342.7863381097995;5151.83622878391;5168.793248270064;5348.315280686581;3469.9826500867584;4160.084781348106;4213.978930105345;4214.262504061792;4232.365145228225;3946.763194208342;4187.895302617444;4205.179989901971;4226.584094328388;4239.9576004240025;3237.6762323767553;3336.4828451590042;4022.879313620596;4240.5759424057505;4249.043965107857;4121.4848143982;4129.522286628029;4179.12238429927;4192.413062171298;4202.2646036943715;3092.4279008383296;3682.705383569335;3697.8890633280776;3704.9629503704887;3705.6294370562996;4846.927296090562;4919.384252574355;4995.300657907896;5153.6808436203855;5254.3990724591185;4243.766592837393;4581.633469322446;4611.746353950532;4640.257558790578;4667.929981050287;4754.429468463772;4976.402831660188;5257.053730328539;5287.603429742746;5653.547716182696;3146.905592832196;3646.3072016316814;3841.9423708644395;3843.5195600549932;3847.4228865670093;5520.288710499758;5601.543598664336;5796.97101514494;5805.7387417566315;5880.647161170344;3085.460044492205;3621.764585301947;3834.213986132836;3847.0185606155455;3900.5904380040256;3348.8158151301427;3945.3035194866484;3953.983468431121;3972.225416043844;3992.1436532012754;4178.752764616917;4295.355696645465;4558.544145585482;4648.628109751212;4657.697249678828;4769.95230047702;5372.677639341652;5631.577631677558;5637.605367624309;5644.8871022579315;1137.5847815547265;1217.933013684256;1276.3407570158756;1286.2346903592347;1287.266258232817;829.6930135849774;833.6415341403255;849.8824046378992;874.0210963720674;874.4141425245101;4577.450705915311;5064.442911279756;5090.516400941905;5112.3865136183895;5115.7953681852305;4784.952150478451;4851.90832062783;5552.890381386355;5557.249161665001;5564.742971626709;4294.7852607369505;5007.774650140753;5230.7769198090655;5404.135808021755;5430.266913966643;2499.800015998716;2629.198094581171;2705.9323516912236;2818.365867679797;2905.956410653842;4931.876703082452;5280.234366016906;5424.264235444699;5708.457696518824;5864.941350586525;4729.571060980761;5094.923576146361;5137.332146820964;5693.658380497183;5719.711166079438;5777.851071166308;5783.843231353746;5785.971070144622;5794.739236734441;5807.5063619591965;4824.517548245148;4882.389701287339;5383.892322153613;5406.78372865081;5606.831795046155;5406.837794866003;5494.022152025348;5769.336526299361;5772.278465191851;5786.247787787561;5996.310424301261;6065.545084118797;6112.724927378367;6114.388561144028;6120.510359171167;3734.7012239021356;3860.3051450739135;3881.050401694676;3888.911104890635;3897.70767192456;5006.62450316235;5229.790808367623;5323;5845.298564172326;5856.677882716492;4810.735409552508;4908.404768450197;5666.866626674764;5738.483536481736;5747.770089196552;5270.998510283034;5374.785008599612;5413.918791218056;5487;5615.466530679579;4549.928798061362;5049.8737531562;5374.909427079367;5476.890462190813;5703.486686198262;4757.524247575215;5267.73661316925;5529.529989950899;5624.550035997028;5680.971595141998;4672.462666793226;4959.60323174138;5357.276767636319;5523.630585343018;5566.268671629083 08:52:44 INFO - PROCESS | 1650 | |5;yui.html;720.664890825766;738;765.5942350554204;809.0816922792628;819.164452258696;14847.851521484781;15460.922695386507;15498.612534686625;15508.689826203468;15563.844361556381;11619.593314234004;13907.235102069382;13998.79001814971;14007.089539179971;14076.225807580604;617.9895870252125;669.6517810738413;671.241497108267;845.1675100026468;855.1576696953496;855.3456605696616;860.8493513635088;878.802269489363;878.8110556230409;879.1647934462254;934.5327336331834;937.2221056523069;937.446906325268;938.474454305591;939.3659279985982;715.606416470944;739.2976672161415;741.0884611927306;929.7489677786994;931.0689310689277;552.9668219906778;554.0055600197655;660.9372109649576;681.819317880762;683.8666460040295;14188.57434276963;14546.34541445627;14627.92686036563;14640.90193235501;14686.706265874729;13141.802872956914;13267.601971940858;13278.800817987738;13322;13322.400491977787;12081;12190.51237950481;12233.938830305791;12260.81608775869;12400.13199076065;4310.913781724379;4353.455818022747;4534.455865296152;4540.29625408059;4542.364069030338;102014.48992755063;107807;110327;111200.99999999919;114516.4274178632;10391.116755075904;10544.156467482737;10604.257701960943;10800.51397687106;10850.348979061124;20638.071286792132;20913.163473460892;20938.267160649306;20939.267125650527;20995.265165719127;6575.638339891256;7231.746888858865;7417.443691723034;7591.506552074097;7753.689852405953;4175.373693945932;4207.600277973587;4247.617714405718;4256.531781504032;4386.956130438719;3434.9656503435144;3463.6536346365665;3465.7227421806197;3471.878484253039;3486.1458942559234;616.1435604509735;625.1497962770628;632.794341838895;636.5512313818747;638.5019684645983;532.6883772992843;535.7803300646716;542.3573065916901;593.5666963116862;625.6965371794676;7937.3879340915755;8450.323974082059;8668.91331086681;8700.695475658447;8987.091106710477;554.5092593055175;559.3735016781231;573.6214098694842;620.2866703291252;620.9844753881189;4020.396940458896;4285.8285668573535;4303.90250486124;4413.13943780966;4434.756762112343;105208.94791052144;105466.94533054724;108077.37883931748;109242;112743.87256127334;67734;94763;97104;97322;99582;85316.57341713252;85467.99999999876;87627;87906.56046719853;88656;7079.761041817558;7462.664180111799;7632.580208088609;8296.70961516344;8619.913800862161;49995.250071248236;55286.72356638191;55915.44084559102;56465.435345646016;57883.421165789485;73526.63236683782;76061.61969190119;78769;79180.02049948798;80233;8624.956875215585;10797.244192906735;10819.67540973772;10887.727806804893;11358.26171298863;11878.346690931736;11918.284902905853;12160.270383777002;12455.564055258023;12572.434240459384;9471.763205919908;11484;11652.94173529127;11704.122190835891;11850;10995.065419439437;11066.502007409525;11126.221164518405;11246.493907774333;11246.718832029264;10134.189264858942;10828.187885908746;11054.889451105386;11403.429828508708;11615.419229038345;9109.407888487227;9124.041975592732;9255.25957923378;9297.95609988881;9540.33217674784;9267.67563135287;9601.951990240004;9631.807363852544;9646.565904534173;9690.12788849007 08:52:44 INFO - PROCESS | 1650 | __end_tp_report 08:52:44 INFO - PROCESS | 1650 | __start_cc_report 08:52:44 INFO - PROCESS | 1650 | _x_x_mozilla_cycle_collect,1644 08:52:44 INFO - PROCESS | 1650 | __end_cc_report 08:52:44 INFO - PROCESS | 1650 | __startTimestamp1481647964860__endTimestamp 08:52:44 INFO - PROCESS | 1650 | 08:52:44 INFO - PROCESS | 1650 | ------- Summary: start ------- 08:52:44 INFO - PROCESS | 1650 | Number of tests: 6 08:52:44 INFO - PROCESS | 1650 | 08:52:44 INFO - PROCESS | 1650 | [#0] dojo.html Cycles:165 Average:5688.68 Median:5853.56 stddev:642.93 (11.0%) stddev-sans-first:617.70 08:52:44 INFO - PROCESS | 1650 | Values: 3329.7 3338.9 3345.4 3347.7 3385.8 4699.5 5069.5 5533.3 5594.7 5624.2 5596.3 5623.0 5680.3 5683.3 5698.5 5146.7 5226.0 5230.8 5236.5 5264.9 5151.0 5217.7 5271.3 5284.5 5286.2 4379.0 5274.6 5305.8 5318.2 5323.8 5091.6 5231.7 5243.0 5266.7 5272.4 5045.6 5142.2 5185.3 5188.4 5200.5 5593.9 5628.8 5651.3 5670.7 5705.1 6187.4 6190.4 6193.6 6193.9 6207.7 6104.9 6106.3 6163.8 6166.2 6206.9 4771.0 5681.4 5757.9 5799.8 5803.9 6314.2 6319.2 6328.2 6340.4 6356.9 5952.2 6023.3 6034.2 6105.0 6119.6 6165.0 6176.3 6219.8 6232.8 6277.1 6169.6 6176.3 6180.2 6181.4 6189.2 6147.4 6158.1 6205.4 6218.7 6219.6 4839.5 4886.2 4892.4 4900.3 4917.8 4389.1 4406.5 4416.7 4438.8 4453.9 5752.3 5763.3 5763.9 5770.4 5780.6 6032.2 6106.6 6146.3 6254.7 6262.5 5688.7 5757.9 5766.3 5769.2 5773.2 5338.8 5342.7 5345.2 5352.0 5384.3 5485.4 6172.9 6344.4 6346.5 6359.3 6189.2 6232.4 6241.8 6248.0 6256.9 6254.7 6282.6 6320.6 6322.4 6337.9 6114.9 6134.5 6153.2 6156.9 6157.0 6207.3 6217.8 6231.6 6235.9 6247.1 5863.9 5923.1 6032.2 6038.1 6047.7 5962.8 5970.3 5997.7 6023.5 6073.0 5440.0 5853.2 5863.7 5868.0 5871.6 5730.7 6015.3 6033.3 6048.0 6051.1 5712.7 5789.0 5824.1 5853.6 5872.8 08:52:44 INFO - PROCESS | 1650 | 08:52:44 INFO - PROCESS | 1650 | [#1] ext.html Cycles:180 Average:70063.11 Median:35810.23 stddev:152108.19 (424.8%) stddev-sans-first:152445.08 08:52:44 INFO - PROCESS | 1650 | Values: 445.3 477.0 492.6 502.1 511.6 30582.0 37890.6 39940.0 41279.4 41279.8 42450.2 42714.8 42816.1 42823.0 42836.0 9267.4 9473.0 9474.1 9475.6 9517.6 8497.0 8750.6 11070.3 11330.0 11331.0 11261.4 11350.4 11350.8 11363.5 11379.1 8505.3 11267.3 11340.8 11350.8 11359.5 8499.9 9439.4 10983.2 11288.9 11446.4 39132.4 39344.8 40226.8 40260.0 40576.8 3414.7 3427.1 3452.3 3694.7 3795.8 29862.6 30184.8 30299.2 30320.0 30541.8 3155.0 3169.3 3176.5 3242.0 3262.3 488715.6 488823.1 490234.6 490821.0 491069.0 62559.7 62842.1 62855.4 62951.0 63029.0 65686.0 65690.3 65752.7 65859.7 65875.0 13279.3 14923.6 15362.5 15724.9 15948.6 11778.2 11778.6 11899.5 11906.2 11931.6 17136.7 17204.0 17241.7 17284.9 17324.0 7308.7 7351.3 7428.0 7469.2 7484.8 869.4 870.5 1012.7 1040.7 1052.9 27629.9 30327.5 30335.0 31179.7 31264.4 924.8 1040.7 1091.5 1095.2 1101.2 12102.2 14054.9 14302.3 15237.0 16115.8 648340.0 653707.0 655306.0 655370.0 655484.0 59874.0 60261.7 60283.4 60372.0 60385.7 1256.4 1289.1 1382.8 1387.3 1400.7 29635.7 31052.5 31108.5 31242.7 32181.5 51365.7 52089.0 52092.2 52133.2 52296.7 547965.0 552284.0 553232.0 553728.0 554891.0 38280.6 39167.6 39310.8 40976.6 41561.6 41821.6 41953.0 42702.6 42815.0 43443.9 35361.8 35808.0 35812.5 35906.5 36448.5 34960.5 35075.8 35672.8 36137.5 36227.5 34584.5 34639.1 34813.0 35343.0 35354.3 30495.5 31836.0 31839.5 31973.7 32682.0 23691.8 23798.6 23957.0 23985.8 24391.0 08:52:44 INFO - PROCESS | 1650 | 08:52:44 INFO - PROCESS | 1650 | [#2] jquery.html Cycles:180 Average:33622.79 Median:2283.01 stddev:93066.35 (4076.5%) stddev-sans-first:93293.90 08:52:44 INFO - PROCESS | 1650 | Values: 350.5 365.2 375.1 381.7 398.6 14607.9 14881.2 15420.7 20655.7 20728.0 19317.4 19821.8 20399.9 20552.9 20733.3 1625.9 1627.0 1627.1 1628.4 1829.1 4018.2 4267.4 5740.8 5881.6 5895.1 4295.4 6403.1 6420.5 6450.2 6453.7 6175.1 6317.5 6434.6 6437.5 6448.0 5614.4 5628.5 5628.7 5637.8 5638.3 24265.6 24345.1 24654.8 25243.0 25496.7 2176.3 2389.7 2448.6 2811.3 2995.6 9207.8 9574.3 9657.7 10200.5 10301.8 1466.6 1524.7 1775.8 1811.1 1860.3 114682.0 118090.4 118465.0 118739.0 118882.4 11168.0 11274.5 11374.1 11388.7 11624.6 14056.7 14331.1 14352.6 14371.3 14396.1 8157.9 8298.3 8310.9 8482.5 8496.9 8207.5 8216.0 8234.7 8363.1 8440.4 4360.7 4471.3 4477.8 4533.5 4647.7 1849.5 1897.4 1923.1 1961.7 1967.6 726.5 788.0 844.0 879.3 972.5 18562.8 19564.5 20386.6 20786.5 20823.5 854.9 867.9 926.0 932.5 991.8 10565.3 11150.2 11159.7 11170.9 11204.9 539297.0 548868.0 560601.6 562893.0 564155.0 113815.0 122222.0 124318.0 128352.4 129271.0 964.7 981.1 993.9 995.5 995.6 18560.5 18771.7 18970.1 18977.2 19035.0 55414.1 55736.0 56003.2 57675.7 57912.0 69168.0 81205.6 81274.6 81944.6 83121.2 6696.2 7534.6 7734.5 7934.8 7977.0 11849.8 11896.2 12177.1 12873.4 13237.1 10283.9 10560.8 10651.7 10928.7 11285.7 10841.2 10994.3 11004.9 11225.5 11377.2 11145.3 11392.0 11733.2 11759.7 11774.0 7868.2 8359.0 11214.4 11601.4 11968.0 10318.8 11510.6 11713.2 12055.9 12156.0 08:52:44 INFO - PROCESS | 1650 | 08:52:44 INFO - PROCESS | 1650 | [#3] mootools.html Cycles:180 Average:5367.61 Median:5177.43 stddev:2901.49 (56.0%) stddev-sans-first:2894.92 08:52:44 INFO - PROCESS | 1650 | Values: 1479.9 1510.8 1674.8 1727.5 1848.8 8002.9 8401.5 8407.4 8409.2 8421.0 6526.5 7427.3 7680.8 7777.1 8173.8 1966.6 2263.1 2325.5 2325.6 2329.5 1993.3 2313.7 2329.8 2332.6 2354.3 2294.6 2299.9 2329.3 2330.5 2334.3 2274.2 2308.8 2312.2 2320.2 2322.6 2317.8 2346.5 2349.0 2353.6 2358.2 8168.4 8262.7 8376.5 8385.0 8413.1 4992.2 5168.3 5173.1 5184.9 5193.3 3310.3 3381.4 3602.0 3612.7 3614.3 1053.3 1068.0 1074.4 1098.2 1101.2 10770.9 10792.8 10916.6 10937.4 10964.6 4363.8 4486.6 4560.3 4592.9 4603.0 8447.8 8796.2 9329.4 9331.3 9338.1 5175.3 5179.6 5184.0 5185.2 5187.6 3853.4 4211.4 4725.9 4743.0 4755.6 3731.4 3734.6 3824.8 3849.4 3870.2 1064.7 1258.9 1267.4 1280.4 1283.0 838.5 847.1 889.0 889.3 915.2 5218.7 5253.5 5501.5 5653.2 5788.0 899.8 917.5 949.7 959.2 996.9 3794.3 3819.9 3870.3 3953.3 4007.1 8382.6 9861.9 9925.3 10064.2 10074.5 10024.0 10027.6 10031.3 10033.5 10047.2 7649.3 7897.2 7903.4 7908.6 7909.1 5334.4 5484.7 5596.9 5652.1 5812.9 8400.8 8435.4 8665.0 8701.9 9325.5 7709.7 9102.5 9427.0 9432.0 9456.0 6540.9 6565.9 6702.0 6992.5 7186.9 7859.7 7893.2 7950.8 7963.3 7971.8 6990.7 7097.9 7098.4 7194.7 7257.5 6927.3 6932.4 6994.5 7089.4 7111.8 6522.5 6563.3 6605.5 6607.9 6618.2 4695.6 4755.7 4758.0 4840.0 4883.9 4601.8 4728.5 4838.4 4901.2 5002.4 08:52:44 INFO - PROCESS | 1650 | 08:52:44 INFO - PROCESS | 1650 | [#4] prototype.html Cycles:180 Average:4470.60 Median:4925.63 stddev:1372.13 (27.9%) stddev-sans-first:1340.25 08:52:44 INFO - PROCESS | 1650 | Values: 325.9 352.5 359.9 369.1 370.5 4523.9 4618.6 4742.1 5419.8 5423.7 4027.9 4342.8 5151.8 5168.8 5348.3 3470.0 4160.1 4214.0 4214.3 4232.4 3946.8 4187.9 4205.2 4226.6 4240.0 3237.7 3336.5 4022.9 4240.6 4249.0 4121.5 4129.5 4179.1 4192.4 4202.3 3092.4 3682.7 3697.9 3705.0 3705.6 4846.9 4919.4 4995.3 5153.7 5254.4 4243.8 4581.6 4611.7 4640.3 4667.9 4754.4 4976.4 5257.1 5287.6 5653.5 3146.9 3646.3 3841.9 3843.5 3847.4 5520.3 5601.5 5797.0 5805.7 5880.6 3085.5 3621.8 3834.2 3847.0 3900.6 3348.8 3945.3 3954.0 3972.2 3992.1 4178.8 4295.4 4558.5 4648.6 4657.7 4770.0 5372.7 5631.6 5637.6 5644.9 1137.6 1217.9 1276.3 1286.2 1287.3 829.7 833.6 849.9 874.0 874.4 4577.5 5064.4 5090.5 5112.4 5115.8 4785.0 4851.9 5552.9 5557.2 5564.7 4294.8 5007.8 5230.8 5404.1 5430.3 2499.8 2629.2 2705.9 2818.4 2906.0 4931.9 5280.2 5424.3 5708.5 5864.9 4729.6 5094.9 5137.3 5693.7 5719.7 5777.9 5783.8 5786.0 5794.7 5807.5 4824.5 4882.4 5383.9 5406.8 5606.8 5406.8 5494.0 5769.3 5772.3 5786.2 5996.3 6065.5 6112.7 6114.4 6120.5 3734.7 3860.3 3881.1 3888.9 3897.7 5006.6 5229.8 5323.0 5845.3 5856.7 4810.7 4908.4 5666.9 5738.5 5747.8 5271.0 5374.8 5413.9 5487.0 5615.5 4549.9 5049.9 5374.9 5476.9 5703.5 4757.5 5267.7 5529.5 5624.6 5681.0 4672.5 4959.6 5357.3 5523.6 5566.3 08:52:44 INFO - PROCESS | 1650 | 08:52:44 INFO - PROCESS | 1650 | [#5] yui.html Cycles:180 Average:20842.24 Median:539.07 stddev:31574.78 (5857.3%) stddev-sans-first:31627.21 08:52:44 INFO - PROCESS | 1650 | Values: 720.7 738.0 765.6 809.1 819.2 14847.9 15460.9 15498.6 15508.7 15563.8 11619.6 13907.2 13998.8 14007.1 14076.2 618.0 669.7 671.2 845.2 855.2 855.3 860.8 878.8 878.8 879.2 934.5 937.2 937.4 938.5 939.4 715.6 739.3 741.1 929.7 931.1 553.0 554.0 660.9 681.8 683.9 14188.6 14546.3 14627.9 14640.9 14686.7 13141.8 13267.6 13278.8 13322.0 13322.4 12081.0 12190.5 12233.9 12260.8 12400.1 4310.9 4353.5 4534.5 4540.3 4542.4 102014.5 107807.0 110327.0 111201.0 114516.4 10391.1 10544.2 10604.3 10800.5 10850.3 20638.1 20913.2 20938.3 20939.3 20995.3 6575.6 7231.7 7417.4 7591.5 7753.7 4175.4 4207.6 4247.6 4256.5 4387.0 3435.0 3463.7 3465.7 3471.9 3486.1 616.1 625.1 632.8 636.6 638.5 532.7 535.8 542.4 593.6 625.7 7937.4 8450.3 8668.9 8700.7 8987.1 554.5 559.4 573.6 620.3 621.0 4020.4 4285.8 4303.9 4413.1 4434.8 105208.9 105466.9 108077.4 109242.0 112743.9 67734.0 94763.0 97104.0 97322.0 99582.0 85316.6 85468.0 87627.0 87906.6 88656.0 7079.8 7462.7 7632.6 8296.7 8619.9 49995.3 55286.7 55915.4 56465.4 57883.4 73526.6 76061.6 78769.0 79180.0 80233.0 8625.0 10797.2 10819.7 10887.7 11358.3 11878.3 11918.3 12160.3 12455.6 12572.4 9471.8 11484.0 11652.9 11704.1 11850.0 10995.1 11066.5 11126.2 11246.5 11246.7 10134.2 10828.2 11054.9 11403.4 11615.4 9109.4 9124.0 9255.3 9298.0 9540.3 9267.7 9602.0 9631.8 9646.6 9690.1 08:52:44 INFO - PROCESS | 1650 | -------- Summary: end -------- 08:52:44 INFO - PROCESS | 1650 | 08:52:45 INFO - TEST-INFO | 1650: exit 0 08:52:45 INFO - TEST-OK | dromaeo_css | took 1119346ms 08:52:45 INFO - TEST-START | kraken 08:52:45 INFO - operating with platform_type : mac_ 08:52:45 INFO - Initialising browser for kraken test... 08:52:45 INFO - TEST-INFO | started process 1659 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/tmpxM5ZD9/profile http://localhost:49241/getInfo.html) 08:52:47 INFO - PROCESS | 1659 | __metrics Screen width/height:1600/1200 08:52:47 INFO - PROCESS | 1659 | colorDepth:24 08:52:47 INFO - PROCESS | 1659 | Browser inner width/height: 1024/689 08:52:47 INFO - PROCESS | 1659 | __metrics 08:52:47 INFO - PROCESS | 1659 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 08:52:47 INFO - PROCESS | 1659 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:52:48 INFO - TEST-INFO | 1659: exit 0 08:52:48 INFO - Browser initialized. 08:52:48 INFO - Running cycle 1/1 for kraken test... 08:52:48 INFO - TEST-INFO | started process 1660 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/tmpxM5ZD9/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:53:00 INFO - PROCESS | 1660 | RSS: Main: 236920832 08:53:00 INFO - PROCESS | 1660 | 08:53:03 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-beat-detection) 08:53:04 INFO - PROCESS | 1660 | RSS: Main: 289722368 08:53:04 INFO - PROCESS | 1660 | 08:53:06 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-dft) 08:53:07 INFO - PROCESS | 1660 | RSS: Main: 291647488 08:53:07 INFO - PROCESS | 1660 | 08:53:10 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-fft) 08:53:11 INFO - PROCESS | 1660 | RSS: Main: 384098304 08:53:11 INFO - PROCESS | 1660 | 08:53:13 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-oscillator) 08:53:14 INFO - PROCESS | 1660 | RSS: Main: 283168768 08:53:14 INFO - PROCESS | 1660 | 08:53:16 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:53:16 INFO - PROCESS | 1660 | RSS: Main: 287924224 08:53:16 INFO - PROCESS | 1660 | 08:53:19 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-darkroom) 08:53:20 INFO - PROCESS | 1660 | RSS: Main: 329850880 08:53:20 INFO - PROCESS | 1660 | 08:53:23 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-desaturate) 08:53:23 INFO - PROCESS | 1660 | RSS: Main: 333774848 08:53:23 INFO - PROCESS | 1660 | 08:53:26 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49241/tests/kraken/driver.html?testName=json-parse-financial) 08:53:27 INFO - PROCESS | 1660 | RSS: Main: 327516160 08:53:27 INFO - PROCESS | 1660 | 08:53:28 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49241/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:53:29 INFO - PROCESS | 1660 | RSS: Main: 306622464 08:53:29 INFO - PROCESS | 1660 | 08:53:31 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:53:32 INFO - PROCESS | 1660 | RSS: Main: 307175424 08:53:32 INFO - PROCESS | 1660 | 08:53:34 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:53:35 INFO - PROCESS | 1660 | RSS: Main: 309751808 08:53:35 INFO - PROCESS | 1660 | 08:53:38 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:53:38 INFO - PROCESS | 1660 | RSS: Main: 327737344 08:53:38 INFO - PROCESS | 1660 | 08:53:41 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:53:42 INFO - PROCESS | 1660 | RSS: Main: 321622016 08:53:42 INFO - PROCESS | 1660 | 08:53:44 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49241/tests/kraken/driver.html?testName=ai-astar) 08:53:44 INFO - PROCESS | 1660 | RSS: Main: 365600768 08:53:44 INFO - PROCESS | 1660 | 08:53:44 INFO - PROCESS | 1660 | __start_tp_report 08:53:44 INFO - PROCESS | 1660 | _x_x_mozilla_page_load 08:53:44 INFO - PROCESS | 1660 | _x_x_mozilla_page_load_details 08:53:44 INFO - PROCESS | 1660 | |i|pagename|runs| 08:53:44 INFO - PROCESS | 1660 | |0;ai-astar;114;114;115;115;113;114;115;115;113;117 08:53:44 INFO - PROCESS | 1660 | |1;audio-beat-detection;146;115;112;143;114;116;115;111;134;116 08:53:44 INFO - PROCESS | 1660 | |2;audio-dft;186;185;186;184;183;183;182;181;184;184 08:53:44 INFO - PROCESS | 1660 | |3;audio-fft;80;59;59;87;62;58;62;78;93;59 08:53:44 INFO - PROCESS | 1660 | |4;audio-oscillator;89;72;83;70;69;68;82;68;68;84 08:53:44 INFO - PROCESS | 1660 | |5;imaging-gaussian-blur;109;111;109;111;108;112;109;112;108;112 08:53:44 INFO - PROCESS | 1660 | |6;imaging-darkroom;96;97;93;100;146;115;94;95;97;93 08:53:44 INFO - PROCESS | 1660 | |7;imaging-desaturate;87;85;85;85;84;84;85;87;86;84 08:53:44 INFO - PROCESS | 1660 | |8;json-parse-financial;55;56;56;56;56;55;55;55;55;53 08:53:44 INFO - PROCESS | 1660 | |9;json-stringify-tinderbox;63;71;71;76;73;69;70;71;71;72 08:53:44 INFO - PROCESS | 1660 | |10;stanford-crypto-aes;89;89;93;89;100;110;108;107;90;88 08:53:44 INFO - PROCESS | 1660 | |11;stanford-crypto-ccm;150;149;150;150;155;148;142;152;215;159 08:53:44 INFO - PROCESS | 1660 | |12;stanford-crypto-pbkdf2;172;174;176;178;177;175;182;175;175;178 08:53:44 INFO - PROCESS | 1660 | |13;stanford-crypto-sha256-iterative;68;68;67;69;82;69;59;79;83;84 08:53:44 INFO - PROCESS | 1660 | __end_tp_report 08:53:44 INFO - PROCESS | 1660 | __start_cc_report 08:53:44 INFO - PROCESS | 1660 | _x_x_mozilla_cycle_collect,2043 08:53:44 INFO - PROCESS | 1660 | __end_cc_report 08:53:44 INFO - PROCESS | 1660 | __startTimestamp1481648024588__endTimestamp 08:53:44 INFO - PROCESS | 1660 | 08:53:44 INFO - PROCESS | 1660 | ------- Summary: start ------- 08:53:44 INFO - PROCESS | 1660 | Number of tests: 14 08:53:44 INFO - PROCESS | 1660 | 08:53:44 INFO - PROCESS | 1660 | [#0] ai-astar Cycles:10 Average:114.50 Median:115.00 stddev:1.18 (1.0%) stddev-sans-first:1.24 08:53:44 INFO - PROCESS | 1660 | Values: 114.0 114.0 115.0 115.0 113.0 114.0 115.0 115.0 113.0 117.0 08:53:44 INFO - PROCESS | 1660 | 08:53:44 INFO - PROCESS | 1660 | [#1] audio-beat-detection Cycles:10 Average:122.20 Median:116.00 stddev:13.40 (11.6%) stddev-sans-first:11.10 08:53:44 INFO - PROCESS | 1660 | Values: 146.0 115.0 112.0 143.0 114.0 116.0 115.0 111.0 134.0 116.0 08:53:44 INFO - PROCESS | 1660 | 08:53:44 INFO - PROCESS | 1660 | [#2] audio-dft Cycles:10 Average:183.80 Median:184.00 stddev:1.62 (0.9%) stddev-sans-first:1.51 08:53:44 INFO - PROCESS | 1660 | Values: 186.0 185.0 186.0 184.0 183.0 183.0 182.0 181.0 184.0 184.0 08:53:44 INFO - PROCESS | 1660 | 08:53:44 INFO - PROCESS | 1660 | [#3] audio-fft Cycles:10 Average:69.70 Median:70.00 stddev:13.40 (19.1%) stddev-sans-first:13.68 08:53:44 INFO - PROCESS | 1660 | Values: 80.0 59.0 59.0 87.0 62.0 58.0 62.0 78.0 93.0 59.0 08:53:44 INFO - PROCESS | 1660 | 08:53:44 INFO - PROCESS | 1660 | [#4] audio-oscillator Cycles:10 Average:75.30 Median:77.00 stddev:8.21 (10.7%) stddev-sans-first:7.05 08:53:44 INFO - PROCESS | 1660 | Values: 89.0 72.0 83.0 70.0 69.0 68.0 82.0 68.0 68.0 84.0 08:53:44 INFO - PROCESS | 1660 | 08:53:44 INFO - PROCESS | 1660 | [#5] imaging-gaussian-blur Cycles:10 Average:110.10 Median:111.00 stddev:1.66 (1.5%) stddev-sans-first:1.72 08:53:44 INFO - PROCESS | 1660 | Values: 109.0 111.0 109.0 111.0 108.0 112.0 109.0 112.0 108.0 112.0 08:53:44 INFO - PROCESS | 1660 | 08:53:44 INFO - PROCESS | 1660 | [#6] imaging-darkroom Cycles:10 Average:102.60 Median:94.50 stddev:16.55 (17.5%) stddev-sans-first:17.39 08:53:44 INFO - PROCESS | 1660 | Values: 96.0 97.0 93.0 100.0 146.0 115.0 94.0 95.0 97.0 93.0 08:53:44 INFO - PROCESS | 1660 | 08:53:44 INFO - PROCESS | 1660 | [#7] imaging-desaturate Cycles:10 Average:85.20 Median:85.00 stddev:1.14 (1.3%) stddev-sans-first:1.00 08:53:44 INFO - PROCESS | 1660 | Values: 87.0 85.0 85.0 85.0 84.0 84.0 85.0 87.0 86.0 84.0 08:53:44 INFO - PROCESS | 1660 | 08:53:44 INFO - PROCESS | 1660 | [#8] json-parse-financial Cycles:10 Average:55.20 Median:55.50 stddev:0.92 (1.7%) stddev-sans-first:0.97 08:53:44 INFO - PROCESS | 1660 | Values: 55.0 56.0 56.0 56.0 56.0 55.0 55.0 55.0 55.0 53.0 08:53:44 INFO - PROCESS | 1660 | 08:53:44 INFO - PROCESS | 1660 | [#9] json-stringify-tinderbox Cycles:10 Average:70.70 Median:71.00 stddev:3.30 (4.7%) stddev-sans-first:2.01 08:53:44 INFO - PROCESS | 1660 | Values: 63.0 71.0 71.0 76.0 73.0 69.0 70.0 71.0 71.0 72.0 08:53:44 INFO - PROCESS | 1660 | 08:53:44 INFO - PROCESS | 1660 | [#10] stanford-crypto-aes Cycles:10 Average:96.30 Median:89.00 stddev:9.02 (10.1%) stddev-sans-first:9.17 08:53:44 INFO - PROCESS | 1660 | Values: 89.0 89.0 93.0 89.0 100.0 110.0 108.0 107.0 90.0 88.0 08:53:44 INFO - PROCESS | 1660 | 08:53:44 INFO - PROCESS | 1660 | [#11] stanford-crypto-ccm Cycles:10 Average:157.00 Median:151.00 stddev:20.85 (13.8%) stddev-sans-first:21.96 08:53:44 INFO - PROCESS | 1660 | Values: 150.0 149.0 150.0 150.0 155.0 148.0 142.0 152.0 215.0 159.0 08:53:44 INFO - PROCESS | 1660 | 08:53:44 INFO - PROCESS | 1660 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:176.20 Median:176.50 stddev:2.74 (1.6%) stddev-sans-first:2.45 08:53:44 INFO - PROCESS | 1660 | Values: 172.0 174.0 176.0 178.0 177.0 175.0 182.0 175.0 175.0 178.0 08:53:44 INFO - PROCESS | 1660 | 08:53:44 INFO - PROCESS | 1660 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:72.80 Median:74.00 stddev:8.51 (11.5%) stddev-sans-first:8.85 08:53:44 INFO - PROCESS | 1660 | Values: 68.0 68.0 67.0 69.0 82.0 69.0 59.0 79.0 83.0 84.0 08:53:44 INFO - PROCESS | 1660 | -------- Summary: end -------- 08:53:44 INFO - PROCESS | 1660 | 08:53:45 INFO - TEST-INFO | 1660: exit 0 08:53:45 INFO - TEST-OK | kraken | took 60028ms 08:53:45 INFO - SUITE-END | took 1179s 08:53:45 INFO - Completed test suite (00:19:39) 08:53:45 INFO - javascript benchmark 08:53:45 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3329.683680050395, 3338.9332213355733, 3345.39782839089, 3347.681970212829, 3385.7629965902383, 4699.506551812062, 5069.493050694929, 5533.253010843535, 5594.664320140794, 5624.240727501786, 5596.27248457701, 5623.044082505973, 5680.289963754531, 5683.3464151622575, 5698.487136157745, 5146.74266286686, 5226.033183860998, 5230.816921407752, 5236.4763523647525, 5264.947350526503, 5151.021305951857, 5217.686938783666, 5271.28837606922, 5284.471552844704, 5286.180642000477, 4378.9562104378865, 5274.604404669646, 5305.7877684892555, 5318.202269659562, 5323.760430780624, 5091.592672586185, 5231.738413079369, 5242.97378513105, 5266.683998960056, 5272.367315922075, 5045.571126454256, 5142.202958541432, 5185.299984502081, 5188.429272779991, 5200.531952124327, 5593.916091258634, 5628.774849006035, 5651.265335506399, 5670.744816483269, 5705.058665320217, 6187.3503282155625, 6190.350013248589, 6193.597416167935, 6193.938060619381, 6207.689615519251, 6104.883608894094, 6106.346824600314, 6163.753449862, 6166.198394208769, 6206.906896396557, 4770.976145119287, 5681.431856814285, 5757.942420575824, 5799.768009279624, 5803.912941305884, 6314.242290925118, 6319.178506794087, 6328.208973878265, 6340.4293613575, 6356.904646430215, 5952.226210592596, 6023.337432882379, 6034.24571928509, 6104.992676208465, 6119.602225855305, 6164.982777841606, 6176.320604733476, 6219.844503887439, 6232.75068997235, 6277.058441233851, 6169.629822210592, 6176.289726681399, 6180.196574445294, 6181.381861813783, 6189.164462797465, 6147.385261473817, 6158.137860699506, 6205.410486003822, 6218.657973811393, 6219.595726277777, 4839.516048395132, 4886.242632391985, 4892.412910450697, 4900.313956046157, 4917.827876024322, 4389.078293558325, 4406.515283318832, 4416.734995900256, 4438.844640437569, 4453.910921781546, 5752.33848107473, 5763.308402991668, 5763.85590360236, 5770.394108618619, 5780.624259423124, 6032.245969253843, 6106.642687876592, 6146.293176284785, 6254.718537665816, 6262.530310226751, 5688.687122208318, 5757.9424205757405, 5766.336871259775, 5769.163471296639, 5773.191753154561, 5338.839834804962, 5342.652727572696, 5345.198220266913, 5351.956368508104, 5384.326959130109, 5485.424030476823, 6172.85802126608, 6344.4290013897125, 6346.492280617632, 6359.268684101387, 6189.245785625353, 6232.407921247474, 6241.750329986749, 6247.96876015617, 6256.937430625818, 6254.749810007549, 6282.623042617458, 6320.5575609706875, 6322.399372059647, 6337.90493142594, 6114.877702446015, 6134.528431832324, 6153.230846144232, 6156.876862462816, 6156.984097623842, 6207.286162091236, 6217.813465596039, 6231.626102433868, 6235.875282494416, 6247.062940558771, 5863.94136058651, 5923.052311630291, 6032.245969253843, 6038.064100064497, 6047.727852246571, 5962.821115366546, 5970.3432622412365, 5997.670128142994, 6023.518118550418, 6073.0, 5439.972800135974, 5853.209816674695, 5863.677497737494, 5868.031774757117, 5871.588988770745, 5730.74211660468, 6015.338312785678, 6033.3061697905305, 6047.969760151171, 6051.122587224916, 5712.685802280915, 5788.986927287624, 5824.097264923944, 5853.560982926383, 5872.794452194153], "value": 5647.9118452302055, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [445.31199297086, 477.04828866411503, 492.618220878819, 502.14133831148735, 511.64440713703993, 30582.0, 37890.62109378906, 39940.0, 41279.38080928788, 41279.793601032026, 42450.15099698004, 42714.786426067905, 42816.14367712644, 42823.00238983273, 42836.0, 9267.39761915475, 9472.952635236848, 9474.099960503741, 9475.620975160986, 9517.5717092731, 8496.957515212416, 8750.606222719962, 11070.28043177195, 11330.0, 11331.0, 11261.4369281536, 11350.43247837609, 11350.772984540345, 11363.488643011044, 11379.146564007691, 8505.277051450634, 11267.26762760418, 11340.829887551694, 11350.772984540345, 11359.545618175263, 8499.915000849975, 9439.386439881386, 10983.176261780398, 11288.943555282252, 11446.370449625267, 39132.41301380481, 39344.80327598372, 40226.798866005774, 40260.0, 40576.797116014524, 3414.709749671281, 3427.143214196451, 3452.3267962747273, 3694.6674799268194, 3795.8481660733537, 29862.552061719092, 30184.8490757547, 30299.242518937204, 30320.0, 30541.847290763402, 3154.9684503154904, 3169.2869104451315, 3176.4600017996995, 3242.0435971388497, 3262.3475304939107, 488715.55642221915, 488823.1117688813, 490234.6464803031, 490821.0, 491069.0, 62559.6872015637, 62842.0573691395, 62855.42861428501, 62951.0, 63029.0, 65686.0147097794, 65690.34309656842, 65752.67123664351, 65859.71911825812, 65875.0, 13279.26964016969, 14923.626909327353, 15362.539123826304, 15724.921375393049, 15948.601284967737, 11778.234414763014, 11778.587749428729, 11899.524019039314, 11906.166568340306, 11931.58239461632, 17136.742948855775, 17203.967761934073, 17241.741373879402, 17284.91357543204, 17323.960562366046, 7308.707651693872, 7351.301626345488, 7427.962860185773, 7469.153386006211, 7484.812879677943, 869.3697069624471, 870.4690139015196, 1012.6658202793061, 1040.6825918095053, 1052.8894466081103, 27629.897360117877, 30327.545086823717, 30335.0, 31179.68820311768, 31264.37471250562, 924.7872989212519, 1040.6669865643073, 1091.5306418240075, 1095.2442814457997, 1101.2291396022815, 12102.152849300464, 14054.929725351309, 14302.284885755878, 15237.0, 16115.838841611669, 648340.0, 653707.0, 655306.0, 655370.0, 655484.0, 59874.0, 60261.69869150626, 60283.397166027775, 60372.0, 60385.69807150936, 1256.434604428011, 1289.1105137455127, 1382.7718426459521, 1387.3132799264429, 1400.733860566489, 29635.703642963294, 31052.534211986385, 31108.533371998987, 31242.687573123978, 32181.517277240393, 51365.7431712839, 52089.0, 52092.21861672154, 52133.21800173076, 52296.69258268574, 547965.0, 552284.0, 553232.0, 553728.0, 554891.0, 38280.61719382882, 39167.608323917535, 39310.80344598259, 40976.590234097275, 41561.58438415698, 41821.581784182985, 41952.95117622084, 42702.57297426986, 42815.0, 43443.9139021527, 35361.82319088388, 35808.0, 35812.462813057304, 35906.4614030795, 36448.45327320039, 34960.475592866635, 35075.82462087673, 35672.821635891654, 36137.457938131476, 36227.45658815067, 34584.48123278203, 34639.13402164966, 34813.0, 35343.0, 35354.29291414209, 30495.542566861957, 31836.0, 31839.522407163447, 31973.68026319707, 32682.0, 23691.763082369645, 23798.643020355055, 23956.963419899814, 23985.760142398354, 24391.0], "value": 20037.53797329341, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [350.54954383617024, 365.19838953497066, 375.1109869609026, 381.68129611774174, 398.6233009805733, 14607.926960365197, 14881.18153501557, 15420.739365478088, 20655.69016464754, 20728.0, 19317.420477385665, 19821.801781982176, 20399.898000510013, 20552.897235513803, 20733.274335398262, 1625.878059145563, 1627.0, 1627.0644379481787, 1628.421910221866, 1829.1128802530761, 4018.216447792667, 4267.381229721688, 5740.79907203248, 5881.558883083764, 5895.086261629433, 4295.398644189816, 6403.103565500834, 6420.486361091102, 6450.161479007723, 6453.677316134198, 6175.07373893915, 6317.526185536103, 6434.646094464802, 6437.485001199892, 6447.967760161216, 5614.3718321686665, 5628.465295796893, 5628.690422026787, 5637.80267690633, 5638.295213098363, 24265.636015459782, 24345.1479198229, 24654.753452465604, 25242.990280388763, 25496.745032549807, 2176.3144609447972, 2389.7067994392505, 2448.5837407640743, 2811.2971757060736, 2995.6405231372373, 9207.849018872641, 9574.329796914219, 9657.661981830603, 10200.48997550127, 10301.79396412075, 1466.6406730351025, 1524.695060987807, 1775.8401743843117, 1811.1306572844976, 1860.2744929477515, 114682.0, 118090.40954795257, 118465.0, 118739.0, 118882.4055879715, 11168.0, 11274.492647830868, 11374.132794849791, 11388.715282118013, 11624.593139240085, 14056.71886562263, 14331.140131592138, 14352.641183970485, 14371.281435928371, 14396.136231826124, 8157.877631835528, 8298.294644955246, 8310.875336869953, 8482.491050536988, 8496.872546911802, 8207.466514676646, 8215.95892020548, 8234.670613175525, 8363.080061193265, 8440.409171357946, 4360.716553424018, 4471.32930060487, 4477.7984990675495, 4533.5013148553635, 4647.697899636512, 1849.546861019059, 1897.3643829317334, 1923.0961448119363, 1961.6861302191867, 1967.6163148185967, 726.5386479585501, 787.9606019698992, 843.9913007043198, 879.3448880584006, 972.5331840716495, 18562.79341842776, 19564.510887227934, 20386.592268154553, 20786.48033799167, 20823.479413014797, 854.89291367679, 867.8958524977044, 926.0091701878924, 932.524412549591, 991.7520619845038, 10565.260431769702, 11150.21948463616, 11159.665210043711, 11170.93876081771, 11204.93553112453, 539297.0, 548868.0, 560601.5608985403, 562893.0, 564155.0, 113815.0, 122222.0, 124318.0, 128352.35823820821, 129271.0, 964.7154089543461, 981.0532835813474, 993.8658281132099, 995.5271246158162, 995.6067353395368, 18560.5359865999, 18771.71842422392, 18970.051497424796, 18977.240910363984, 19035.0, 55414.13373860163, 55736.049238276464, 56003.159952599926, 57675.711621443304, 57912.0, 69168.0, 81205.59397202976, 81274.59362703149, 81944.59027704824, 83121.16878831376, 6696.19645642526, 7534.585597792174, 7734.5359278443475, 7934.801629959297, 7977.0, 11849.763004739685, 11896.22674526153, 12177.147599667938, 12873.356332183166, 13237.073404861567, 10283.94858025705, 10560.788784224425, 10651.733706657396, 10928.726781830517, 11285.661430157108, 10841.18691098155, 10994.28537145083, 11004.889951100708, 11225.494852731483, 11377.203595748219, 11145.275557088764, 11392.0, 11733.237339572901, 11759.706007349885, 11773.999210066897, 7868.173841746763, 8358.95820520918, 11214.383208923588, 11601.361925094201, 11968.0, 10318.845217321896, 11510.597129100775, 11713.1800773945, 12055.939720301343, 12156.0], "value": 9165.634395528263, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1479.881609471242, 1510.7733839924006, 1674.8073971493275, 1727.490390334851, 1848.833604975552, 8002.919970800291, 8401.453905496139, 8407.369447291447, 8409.159084091603, 8421.0, 6526.543141980063, 7427.257274272583, 7680.769576912688, 7777.066751989769, 8173.7547873563735, 1966.6066786642657, 2263.1400067974187, 2325.4535184231777, 2325.6278995360744, 2329.487512747193, 1993.3023441795328, 2313.6529520571967, 2329.8485598436046, 2332.626779715246, 2354.2701762453607, 2294.6443301288245, 2299.9310020699404, 2329.312852708447, 2330.487292795582, 2334.253039027512, 2274.1812947338944, 2308.8383813133087, 2312.2022902098747, 2320.1879342230254, 2322.581935251654, 2317.8029867461287, 2346.495503466746, 2348.964765528501, 2353.5881220786464, 2358.2099996501192, 8168.428210025241, 8262.669493220264, 8376.455530390505, 8384.958075209646, 8413.07456179826, 4992.226204938241, 5168.3281173447585, 5173.120569503156, 5184.896302073975, 5193.2989046479, 3310.2882880180878, 3381.442062059757, 3602.0454579536445, 3612.692921101683, 3614.34941710492, 1053.3153450257316, 1067.9786404271872, 1074.4305518075432, 1098.1873413673904, 1101.1521128730913, 10770.946145269223, 10792.838107428395, 10916.563337466492, 10937.398443085707, 10964.616238431696, 4363.847265345697, 4486.551344865487, 4560.270356742905, 4592.908141837212, 4603.0, 8447.788805279917, 8796.164364385373, 9329.440233586007, 9331.253499720005, 9338.066193380608, 5175.275461435402, 5179.585633149339, 5184.015037143006, 5185.196294574347, 5187.636865419385, 3853.402722578005, 4211.368294755811, 4725.929111063337, 4742.976285118552, 4755.595774359218, 3731.384321586962, 3734.6452087051684, 3824.827882745283, 3849.4225866120305, 3870.2066076454257, 1064.6539874540806, 1258.8867001969866, 1267.4359909840216, 1280.359820089955, 1282.9992605767516, 838.5054462972729, 847.0978407995465, 888.9777755556033, 889.2841262783392, 915.1763412928418, 5218.6868787872845, 5253.527182553588, 5501.477359650827, 5653.23681303027, 5787.971060144757, 899.8437008444118, 917.5228880981851, 949.6941705155411, 959.2445824141804, 996.9225866207247, 3794.317022935843, 3819.9427008594894, 3870.264649716601, 3953.3081710701085, 4007.138465229931, 8382.580870956428, 9861.852072218922, 9925.255605829592, 10064.194864410829, 10074.546645400975, 10023.997600239918, 10027.649032283982, 10031.347962382422, 10033.498325083716, 10047.246456515644, 7649.349805266504, 7897.210278972172, 7903.41931613668, 7908.565028923349, 7909.1299957004685, 5334.439469054953, 5484.698341591251, 5596.86007849807, 5652.145731223793, 5812.883742325214, 8400.82388465603, 8435.355105754319, 8664.956675216583, 8701.8694719578, 9325.533723313943, 7709.7301594443925, 9102.453852768855, 9427.0, 9431.962484126603, 9455.95272023663, 6540.901886471612, 6565.934340656723, 6701.966490167518, 6992.510524263456, 7186.856262874818, 7859.685612575433, 7893.210678932061, 7950.840983180419, 7963.323117535075, 7971.840563188588, 6990.685419156252, 7097.893531596927, 7098.396636285974, 7194.748183813542, 7257.52826066304, 6927.307269273032, 6932.434776145129, 6994.548601239939, 7089.397401220954, 7111.7866464006165, 6522.478201743944, 6563.343665633399, 6605.5376123670885, 6607.933920660732, 6618.238902526271, 4695.647826412965, 4755.690880092783, 4757.952420475889, 4839.975800121118, 4883.9011222474655, 4601.769911504478, 4728.527147285382, 4838.419389673261, 4901.1913034350355, 5002.374703162105], "value": 4379.43073769371, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [325.9494778309362, 352.50297081115633, 359.94600809878517, 369.123332086295, 370.4665281993928, 4523.932141017884, 4618.58224913564, 4742.055757139574, 5419.780549376388, 5423.674579525231, 4027.8791636250885, 4342.7863381097995, 5151.83622878391, 5168.793248270064, 5348.315280686581, 3469.9826500867584, 4160.084781348106, 4213.978930105345, 4214.262504061792, 4232.365145228225, 3946.763194208342, 4187.895302617444, 4205.179989901971, 4226.584094328388, 4239.9576004240025, 3237.6762323767553, 3336.4828451590042, 4022.879313620596, 4240.5759424057505, 4249.043965107857, 4121.4848143982, 4129.522286628029, 4179.12238429927, 4192.413062171298, 4202.2646036943715, 3092.4279008383296, 3682.705383569335, 3697.8890633280776, 3704.9629503704887, 3705.6294370562996, 4846.927296090562, 4919.384252574355, 4995.300657907896, 5153.6808436203855, 5254.3990724591185, 4243.766592837393, 4581.633469322446, 4611.746353950532, 4640.257558790578, 4667.929981050287, 4754.429468463772, 4976.402831660188, 5257.053730328539, 5287.603429742746, 5653.547716182696, 3146.905592832196, 3646.3072016316814, 3841.9423708644395, 3843.5195600549932, 3847.4228865670093, 5520.288710499758, 5601.543598664336, 5796.97101514494, 5805.7387417566315, 5880.647161170344, 3085.460044492205, 3621.764585301947, 3834.213986132836, 3847.0185606155455, 3900.5904380040256, 3348.8158151301427, 3945.3035194866484, 3953.983468431121, 3972.225416043844, 3992.1436532012754, 4178.752764616917, 4295.355696645465, 4558.544145585482, 4648.628109751212, 4657.697249678828, 4769.95230047702, 5372.677639341652, 5631.577631677558, 5637.605367624309, 5644.8871022579315, 1137.5847815547265, 1217.933013684256, 1276.3407570158756, 1286.2346903592347, 1287.266258232817, 829.6930135849774, 833.6415341403255, 849.8824046378992, 874.0210963720674, 874.4141425245101, 4577.450705915311, 5064.442911279756, 5090.516400941905, 5112.3865136183895, 5115.7953681852305, 4784.952150478451, 4851.90832062783, 5552.890381386355, 5557.249161665001, 5564.742971626709, 4294.7852607369505, 5007.774650140753, 5230.7769198090655, 5404.135808021755, 5430.266913966643, 2499.800015998716, 2629.198094581171, 2705.9323516912236, 2818.365867679797, 2905.956410653842, 4931.876703082452, 5280.234366016906, 5424.264235444699, 5708.457696518824, 5864.941350586525, 4729.571060980761, 5094.923576146361, 5137.332146820964, 5693.658380497183, 5719.711166079438, 5777.851071166308, 5783.843231353746, 5785.971070144622, 5794.739236734441, 5807.5063619591965, 4824.517548245148, 4882.389701287339, 5383.892322153613, 5406.78372865081, 5606.831795046155, 5406.837794866003, 5494.022152025348, 5769.336526299361, 5772.278465191851, 5786.247787787561, 5996.310424301261, 6065.545084118797, 6112.724927378367, 6114.388561144028, 6120.510359171167, 3734.7012239021356, 3860.3051450739135, 3881.050401694676, 3888.911104890635, 3897.70767192456, 5006.62450316235, 5229.790808367623, 5323.0, 5845.298564172326, 5856.677882716492, 4810.735409552508, 4908.404768450197, 5666.866626674764, 5738.483536481736, 5747.770089196552, 5270.998510283034, 5374.785008599612, 5413.918791218056, 5487.0, 5615.466530679579, 4549.928798061362, 5049.8737531562, 5374.909427079367, 5476.890462190813, 5703.486686198262, 4757.524247575215, 5267.73661316925, 5529.529989950899, 5624.550035997028, 5680.971595141998, 4672.462666793226, 4959.60323174138, 5357.276767636319, 5523.630585343018, 5566.268671629083], "value": 4044.8815255435015, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [720.664890825766, 738.0, 765.5942350554204, 809.0816922792628, 819.164452258696, 14847.851521484781, 15460.922695386507, 15498.612534686625, 15508.689826203468, 15563.844361556381, 11619.593314234004, 13907.235102069382, 13998.79001814971, 14007.089539179971, 14076.225807580604, 617.9895870252125, 669.6517810738413, 671.241497108267, 845.1675100026468, 855.1576696953496, 855.3456605696616, 860.8493513635088, 878.802269489363, 878.8110556230409, 879.1647934462254, 934.5327336331834, 937.2221056523069, 937.446906325268, 938.474454305591, 939.3659279985982, 715.606416470944, 739.2976672161415, 741.0884611927306, 929.7489677786994, 931.0689310689277, 552.9668219906778, 554.0055600197655, 660.9372109649576, 681.819317880762, 683.8666460040295, 14188.57434276963, 14546.34541445627, 14627.92686036563, 14640.90193235501, 14686.706265874729, 13141.802872956914, 13267.601971940858, 13278.800817987738, 13322.0, 13322.400491977787, 12081.0, 12190.51237950481, 12233.938830305791, 12260.81608775869, 12400.13199076065, 4310.913781724379, 4353.455818022747, 4534.455865296152, 4540.29625408059, 4542.364069030338, 102014.48992755063, 107807.0, 110327.0, 111200.99999999919, 114516.4274178632, 10391.116755075904, 10544.156467482737, 10604.257701960943, 10800.51397687106, 10850.348979061124, 20638.071286792132, 20913.163473460892, 20938.267160649306, 20939.267125650527, 20995.265165719127, 6575.638339891256, 7231.746888858865, 7417.443691723034, 7591.506552074097, 7753.689852405953, 4175.373693945932, 4207.600277973587, 4247.617714405718, 4256.531781504032, 4386.956130438719, 3434.9656503435144, 3463.6536346365665, 3465.7227421806197, 3471.878484253039, 3486.1458942559234, 616.1435604509735, 625.1497962770628, 632.794341838895, 636.5512313818747, 638.5019684645983, 532.6883772992843, 535.7803300646716, 542.3573065916901, 593.5666963116862, 625.6965371794676, 7937.3879340915755, 8450.323974082059, 8668.91331086681, 8700.695475658447, 8987.091106710477, 554.5092593055175, 559.3735016781231, 573.6214098694842, 620.2866703291252, 620.9844753881189, 4020.396940458896, 4285.8285668573535, 4303.90250486124, 4413.13943780966, 4434.756762112343, 105208.94791052144, 105466.94533054724, 108077.37883931748, 109242.0, 112743.87256127334, 67734.0, 94763.0, 97104.0, 97322.0, 99582.0, 85316.57341713252, 85467.99999999876, 87627.0, 87906.56046719853, 88656.0, 7079.761041817558, 7462.664180111799, 7632.580208088609, 8296.70961516344, 8619.913800862161, 49995.250071248236, 55286.72356638191, 55915.44084559102, 56465.435345646016, 57883.421165789485, 73526.63236683782, 76061.61969190119, 78769.0, 79180.02049948798, 80233.0, 8624.956875215585, 10797.244192906735, 10819.67540973772, 10887.727806804893, 11358.26171298863, 11878.346690931736, 11918.284902905853, 12160.270383777002, 12455.564055258023, 12572.434240459384, 9471.763205919908, 11484.0, 11652.94173529127, 11704.122190835891, 11850.0, 10995.065419439437, 11066.502007409525, 11126.221164518405, 11246.493907774333, 11246.718832029264, 10134.189264858942, 10828.187885908746, 11054.889451105386, 11403.429828508708, 11615.419229038345, 9109.407888487227, 9124.041975592732, 9255.25957923378, 9297.95609988881, 9540.33217674784, 9267.67563135287, 9601.951990240004, 9631.807363852544, 9646.565904534173, 9690.12788849007], "value": 7109.845841442664, "unit": "score"}], "name": "dromaeo_css", "value": 7123.406048272106, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 114.0, 115.0, 115.0, 113.0, 114.0, 115.0, 115.0, 113.0, 117.0], "value": 114.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 115.0, 112.0, 143.0, 114.0, 116.0, 115.0, 111.0, 134.0, 116.0], "value": 122.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [186.0, 185.0, 186.0, 184.0, 183.0, 183.0, 182.0, 181.0, 184.0, 184.0], "value": 183.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 59.0, 59.0, 87.0, 62.0, 58.0, 62.0, 78.0, 93.0, 59.0], "value": 69.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 72.0, 83.0, 70.0, 69.0, 68.0, 82.0, 68.0, 68.0, 84.0], "value": 75.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 111.0, 109.0, 111.0, 108.0, 112.0, 109.0, 112.0, 108.0, 112.0], "value": 110.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 97.0, 93.0, 100.0, 146.0, 115.0, 94.0, 95.0, 97.0, 93.0], "value": 102.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 85.0, 85.0, 85.0, 84.0, 84.0, 85.0, 87.0, 86.0, 84.0], "value": 85.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 56.0, 56.0, 56.0, 56.0, 55.0, 55.0, 55.0, 55.0, 53.0], "value": 55.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 71.0, 71.0, 76.0, 73.0, 69.0, 70.0, 71.0, 71.0, 72.0], "value": 70.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 89.0, 93.0, 89.0, 100.0, 110.0, 108.0, 107.0, 90.0, 88.0], "value": 96.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 149.0, 150.0, 150.0, 155.0, 148.0, 142.0, 152.0, 215.0, 159.0], "value": 157.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [172.0, 174.0, 176.0, 178.0, 177.0, 175.0, 182.0, 175.0, 175.0, 178.0], "value": 176.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 68.0, 67.0, 69.0, 82.0, 69.0, 59.0, 79.0, 83.0, 84.0], "value": 72.8, "unit": "score"}], "name": "kraken", "value": 1491.6000000000001, "alertThreshold": 2.0}]} 08:53:45 INFO - Return code: 0 08:53:45 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 08:53:45 INFO - # TBPL SUCCESS # 08:53:45 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 08:53:45 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 08:53:45 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 08:53:45 INFO - 2016-12-13 08:53:45.905 screenresolution[1664:9987] starting screenresolution argv=screenresolution get 08:53:45 INFO - 2016-12-13 08:53:45.907 screenresolution[1664:9987] Display 0: 1600x1200x32@60 08:53:45 INFO - 2016-12-13 08:53:45.914 screenresolution[1665:9990] starting screenresolution argv=screenresolution list 08:53:45 INFO - Available Modes on Display 0 08:53:45 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 08:53:45 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 08:53:45 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 08:53:45 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 08:53:46 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 08:53:46 INFO - Intel Iris: 08:53:46 INFO - Chipset Model: Intel Iris 08:53:46 INFO - Type: GPU 08:53:46 INFO - Bus: Built-In 08:53:46 INFO - VRAM (Dynamic, Max): 1536 MB 08:53:46 INFO - Vendor: Intel (0x8086) 08:53:46 INFO - Device ID: 0x0a2e 08:53:46 INFO - Revision ID: 0x0009 08:53:46 INFO - Displays: 08:53:46 INFO - Display: 08:53:46 INFO - Resolution: 1600 x 1200 @ 60 Hz 08:53:46 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 08:53:46 INFO - Display Serial Number: 1600x1200 60 08:53:46 INFO - Main Display: Yes 08:53:46 INFO - Mirror: Off 08:53:46 INFO - Online: Yes 08:53:46 INFO - Rotation: Supported 08:53:46 INFO - Return code: 0 08:53:46 INFO - Running post-action listener: _resource_record_post_action 08:53:46 INFO - [mozharness: 2016-12-13 16:53:46.150141Z] Finished run-tests step (success) 08:53:46 INFO - Running post-run listener: _resource_record_post_run 08:53:46 INFO - Total resource usage - Wall time: 1202s; CPU: 54.0%; Read bytes: 38540288; Write bytes: 549392384; Read time: 375; Write time: 1707 08:53:46 INFO - TinderboxPrint: CPU usage
53.5% 08:53:46 INFO - TinderboxPrint: I/O read bytes / time
38,540,288 / 375 08:53:46 INFO - TinderboxPrint: I/O write bytes / time
549,392,384 / 1,707 08:53:46 INFO - TinderboxPrint: CPU idle
2,235.4 (46.5%) 08:53:46 INFO - TinderboxPrint: CPU system
956.7 (19.9%) 08:53:46 INFO - TinderboxPrint: CPU user
1,617.6 (33.6%) 08:53:46 INFO - TinderboxPrint: Swap in / out
287,305,728 / 0 08:53:46 INFO - install - Wall time: 22s; CPU: 54.0%; Read bytes: 247480832; Write bytes: 241129472; Read time: 18050; Write time: 447 08:53:46 INFO - run-tests - Wall time: 1181s; CPU: 54.0%; Read bytes: 34354176; Write bytes: 296482816; Read time: 343; Write time: 1217 08:53:46 INFO - Running post-run listener: _upload_blobber_files 08:53:46 INFO - Blob upload gear active. 08:53:46 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:53:46 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 08:53:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 08:53:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 08:53:47 INFO - (blobuploader) - INFO - Open directory for files ... 08:53:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 08:53:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:53:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:53:48 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 08:53:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:53:48 INFO - (blobuploader) - INFO - Done attempting. 08:53:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 08:53:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:53:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:53:49 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 08:53:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:53:49 INFO - (blobuploader) - INFO - Done attempting. 08:53:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 08:53:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:53:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:53:52 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 08:53:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:53:52 INFO - (blobuploader) - INFO - Done attempting. 08:53:52 INFO - (blobuploader) - INFO - Iteration through files over. 08:53:52 INFO - Return code: 0 08:53:52 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:53:52 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:53:52 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/86a81e114f6982e479140b6452fef522a89874eaedebe634dd21653840a4ee0edb51f6d0a8123f5bc5b70b89f6639e1e49f9763ebd268f7ad447dca07aee4c7d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2bf9d1d9fd45e916ed4323e224bad6740d59b882e42a28cef56c6d95b5464a466d96b2c065079ab645d332657266750a0e339ee6b5d6a471bf59f5f643fb3441", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4ec3876f0e374b0ce35e088663a083be4b54e2e9472e71ad93728073ae4422e0336331433bd90006679c88b21573200be477d2fe3d399d36d8413345bf6ed0ff"} 08:53:52 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:53:52 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:53:52 INFO - Contents: 08:53:52 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/86a81e114f6982e479140b6452fef522a89874eaedebe634dd21653840a4ee0edb51f6d0a8123f5bc5b70b89f6639e1e49f9763ebd268f7ad447dca07aee4c7d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2bf9d1d9fd45e916ed4323e224bad6740d59b882e42a28cef56c6d95b5464a466d96b2c065079ab645d332657266750a0e339ee6b5d6a471bf59f5f643fb3441", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4ec3876f0e374b0ce35e088663a083be4b54e2e9472e71ad93728073ae4422e0336331433bd90006679c88b21573200be477d2fe3d399d36d8413345bf6ed0ff"} 08:53:52 INFO - Running post-run listener: copy_logs_to_upload_dir 08:53:52 INFO - Copying logs to upload dir... 08:53:52 INFO - mkdir: /builds/slave/test/build/upload/logs 08:53:52 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1264.809932 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 4 secs) (at 2016-12-13 08:53:52.258392) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-13 08:53:52.262164) ========= 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.tj4MCtkVGK/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.mgEdqSmSxd/Listeners TMPDIR=/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/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/86a81e114f6982e479140b6452fef522a89874eaedebe634dd21653840a4ee0edb51f6d0a8123f5bc5b70b89f6639e1e49f9763ebd268f7ad447dca07aee4c7d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2bf9d1d9fd45e916ed4323e224bad6740d59b882e42a28cef56c6d95b5464a466d96b2c065079ab645d332657266750a0e339ee6b5d6a471bf59f5f643fb3441", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4ec3876f0e374b0ce35e088663a083be4b54e2e9472e71ad93728073ae4422e0336331433bd90006679c88b21573200be477d2fe3d399d36d8413345bf6ed0ff"} build_url:https://queue.taskcluster.net/v1/task/BmhrU5ufT7yOHH9Ugz2EyA/artifacts/public/build/firefox-53.0a1.en-US.mac64.dmg program finished with exit code 0 elapsedTime=0.011118 build_url: 'https://queue.taskcluster.net/v1/task/BmhrU5ufT7yOHH9Ugz2EyA/artifacts/public/build/firefox-53.0a1.en-US.mac64.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/86a81e114f6982e479140b6452fef522a89874eaedebe634dd21653840a4ee0edb51f6d0a8123f5bc5b70b89f6639e1e49f9763ebd268f7ad447dca07aee4c7d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2bf9d1d9fd45e916ed4323e224bad6740d59b882e42a28cef56c6d95b5464a466d96b2c065079ab645d332657266750a0e339ee6b5d6a471bf59f5f643fb3441", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4ec3876f0e374b0ce35e088663a083be4b54e2e9472e71ad93728073ae4422e0336331433bd90006679c88b21573200be477d2fe3d399d36d8413345bf6ed0ff"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-13 08:53:52.303152) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-13 08:53:52.303752) ========= 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.tj4MCtkVGK/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.mgEdqSmSxd/Listeners TMPDIR=/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/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.005121 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-13 08:53:52.355039) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-13 08:53:52.355625) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-13 08:53:52.356249) ========= ========= Total master_lag: 0.20 =========