builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0084 starttime: 1484410422.54 results: success (0) buildid: 20170114070623 builduid: e53f46971e0f4a3cbea63fa9ed7b168f revision: 8a43d22ed38e343a63edec572ac9a299e50712df ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-01-14 08:13:42.538608) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-01-14 08:13:42.539116) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-14 08:13:42.539430) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-14 08:13:42.567082) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-14 08:13:42.567517) ========= 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.bXH5Kk85qy/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.DdPUgVyPmh/Listeners TMPDIR=/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2017-01-14 08:13:42-- 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% 176M=0s 2017-01-14 08:13:42 (176 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.102118 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-14 08:13:42.694397) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-14 08:13:42.694772) ========= 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.bXH5Kk85qy/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.DdPUgVyPmh/Listeners TMPDIR=/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/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.028235 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-14 08:13:42.745725) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 4 secs) (at 2017-01-14 08:13:42.746133) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 8a43d22ed38e343a63edec572ac9a299e50712df --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 8a43d22ed38e343a63edec572ac9a299e50712df --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.bXH5Kk85qy/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.DdPUgVyPmh/Listeners TMPDIR=/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2017-01-14 08:13:42,840 truncating revision to first 12 chars 2017-01-14 08:13:42,841 Setting DEBUG logging. 2017-01-14 08:13:42,841 attempt 1/10 2017-01-14 08:13:42,841 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/8a43d22ed38e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-01-14 08:13:44,079 unpacking tar archive at: mozilla-central-8a43d22ed38e/testing/mozharness/ program finished with exit code 0 elapsedTime=1.501767 ========= master_lag: 2.75 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 4 secs) (at 2017-01-14 08:13:46.997059) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-14 08:13:46.997379) ========= script_repo_revision: 8a43d22ed38e343a63edec572ac9a299e50712df ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-14 08:13:46.997763) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-14 08:13:46.998036) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-14 08:13:47.024698) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 3 secs) (at 2017-01-14 08:13:47.025011) ========= /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.bXH5Kk85qy/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.DdPUgVyPmh/Listeners TMPDIR=/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/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:13:47 INFO - MultiFileLogger online at 20170114 08:13:47 in /builds/slave/test 08:13: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:13:47 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:13:47 INFO - {'append_to_log': False, 08:13:47 INFO - 'base_work_dir': '/builds/slave/test', 08:13:47 INFO - 'blob_upload_branch': 'Firefox', 08:13:47 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:13:47 INFO - 'branch': 'Firefox', 08:13:47 INFO - 'buildbot_json_path': 'buildprops.json', 08:13:47 INFO - 'config_files': ('talos/mac_config.py',), 08:13:47 INFO - 'default_actions': ('clobber', 08:13:47 INFO - 'read-buildbot-config', 08:13:47 INFO - 'download-and-extract', 08:13:47 INFO - 'populate-webroot', 08:13:47 INFO - 'create-virtualenv', 08:13:47 INFO - 'install', 08:13:47 INFO - 'run-tests'), 08:13:47 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:13:47 INFO - 'download_minidump_stackwalk': True, 08:13:47 INFO - 'download_symbols': 'ondemand', 08:13:47 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:13:47 INFO - 'tooltool.py': '/tools/tooltool.py', 08:13:47 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:13:47 INFO - '/tools/misc-python/virtualenv.py')}, 08:13:47 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:13:47 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:13:47 INFO - 'installer_path': 'installer.exe', 08:13:47 INFO - 'log_level': 'info', 08:13:47 INFO - 'log_name': 'talos', 08:13:47 INFO - 'log_to_console': True, 08:13:47 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 08:13:47 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 08:13:47 INFO - 'opt_config_files': (), 08:13:47 INFO - 'pip_index': False, 08:13:47 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 08:13:47 INFO - 'cmd': ('bash', 08:13:47 INFO - '-c', 08:13:47 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 08:13:47 INFO - 'enabled': True, 08:13:47 INFO - 'halt_on_failure': False, 08:13:47 INFO - 'name': 'check_screen_resolution'},), 08:13:47 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 08:13:47 INFO - 'cmd': ('bash', 08:13:47 INFO - '-c', 08:13:47 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 08:13:47 INFO - 'enabled': True, 08:13:47 INFO - 'halt_on_failure': False, 08:13:47 INFO - 'name': 'check_screen_resolution'},), 08:13:47 INFO - 'run_cmd_checks_enabled': True, 08:13:47 INFO - 'sps_profile': False, 08:13:47 INFO - 'sps_profile_interval': 0, 08:13:47 INFO - 'suite': 'dromaeojs', 08:13:47 INFO - 'system_bits': '32', 08:13:47 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:13:47 INFO - 'title': 't-yosemite-r7-0084', 08:13:47 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:13:47 INFO - 'use_talos_json': True, 08:13:47 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:13:47 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:13:47 INFO - 'work_dir': 'build'} 08:13:47 INFO - [mozharness: 2017-01-14 16:13:47.234372Z] Running clobber step. 08:13:47 INFO - Running pre-action listener: _resource_record_pre_action 08:13:47 INFO - Running main action method: clobber 08:13:47 INFO - rmtree: /builds/slave/test/build 08:13:47 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:13:48 INFO - Running post-action listener: _resource_record_post_action 08:13:48 INFO - [mozharness: 2017-01-14 16:13:48.670166Z] Finished clobber step (success) 08:13:48 INFO - [mozharness: 2017-01-14 16:13:48.670325Z] Running read-buildbot-config step. 08:13:48 INFO - Running pre-action listener: _resource_record_pre_action 08:13:48 INFO - Running main action method: read_buildbot_config 08:13:48 INFO - Using buildbot properties: 08:13:48 INFO - { 08:13:48 INFO - "project": "", 08:13:48 INFO - "product": "firefox", 08:13:48 INFO - "script_repo_revision": "production", 08:13:48 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 08:13:48 INFO - "repository": "", 08:13:48 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 08:13:48 INFO - "buildid": "20170114070623", 08:13:48 INFO - "pgo_build": "False", 08:13:48 INFO - "basedir": "/builds/slave/test", 08:13:48 INFO - "buildnumber": 23, 08:13:48 INFO - "slavename": "t-yosemite-r7-0084", 08:13:48 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 08:13:48 INFO - "platform": "yosemite_r7", 08:13:48 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 08:13:48 INFO - "branch": "mozilla-central", 08:13:48 INFO - "repo_path": "mozilla-central", 08:13:48 INFO - "revision": "8a43d22ed38e343a63edec572ac9a299e50712df", 08:13:48 INFO - "stage_platform": "macosx64", 08:13:48 INFO - "builduid": "e53f46971e0f4a3cbea63fa9ed7b168f", 08:13:48 INFO - "slavebuilddir": "test" 08:13:48 INFO - } 08:13:48 INFO - Found installer url https://queue.taskcluster.net/v1/task/aoj3LXIwTpKG5l8ADfZGdg/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg. 08:13:48 INFO - Running post-action listener: _resource_record_post_action 08:13:48 INFO - [mozharness: 2017-01-14 16:13:48.673764Z] Finished read-buildbot-config step (success) 08:13:48 INFO - [mozharness: 2017-01-14 16:13:48.673903Z] Running download-and-extract step. 08:13:48 INFO - Running pre-action listener: _resource_record_pre_action 08:13:48 INFO - Running main action method: download_and_extract 08:13:48 INFO - mkdir: /builds/slave/test/build/tests 08:13:48 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:13:48 INFO - trying https://queue.taskcluster.net/v1/task/aoj3LXIwTpKG5l8ADfZGdg/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json 08:13:48 INFO - Downloading https://queue.taskcluster.net/v1/task/aoj3LXIwTpKG5l8ADfZGdg/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json 08:13:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/aoj3LXIwTpKG5l8ADfZGdg/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json'}, attempt #1 08:13:50 INFO - Downloaded 1199 bytes. 08:13:50 INFO - Reading from file /builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json 08:13:50 INFO - Using the following test package requirements: 08:13:50 INFO - {u'common': [u'firefox-53.0a1.en-US.mac.common.tests.zip'], 08:13:50 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 08:13:50 INFO - u'firefox-53.0a1.en-US.mac.cppunittest.tests.zip'], 08:13:50 INFO - u'gtest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 08:13:50 INFO - u'firefox-53.0a1.en-US.mac.gtest.tests.zip'], 08:13:50 INFO - u'jittest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 08:13:50 INFO - u'jsshell-mac.zip'], 08:13:50 INFO - u'mochitest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 08:13:50 INFO - u'firefox-53.0a1.en-US.mac.mochitest.tests.zip'], 08:13:50 INFO - u'mozbase': [u'firefox-53.0a1.en-US.mac.common.tests.zip'], 08:13:50 INFO - u'reftest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 08:13:50 INFO - u'firefox-53.0a1.en-US.mac.reftest.tests.zip'], 08:13:50 INFO - u'talos': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 08:13:50 INFO - u'firefox-53.0a1.en-US.mac.talos.tests.zip'], 08:13:50 INFO - u'web-platform': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 08:13:50 INFO - u'firefox-53.0a1.en-US.mac.web-platform.tests.zip'], 08:13:50 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 08:13:50 INFO - u'firefox-53.0a1.en-US.mac.xpcshell.tests.zip']} 08:13:50 INFO - Downloading packages: [u'firefox-53.0a1.en-US.mac.common.tests.zip'] for test suite category: common 08:13:50 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/aoj3LXIwTpKG5l8ADfZGdg/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip 08:13:50 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/aoj3LXIwTpKG5l8ADfZGdg/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip'}, attempt #1 08:13:50 INFO - Fetch https://queue.taskcluster.net/v1/task/aoj3LXIwTpKG5l8ADfZGdg/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip into memory 08:13:50 INFO - Expected file size: 16317987 08:13:50 INFO - Obtained file size: 16317987 08:13:57 INFO - Downloading packages: [u'firefox-53.0a1.en-US.mac.common.tests.zip', u'firefox-53.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 08:13:57 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/aoj3LXIwTpKG5l8ADfZGdg/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip 08:13:57 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/aoj3LXIwTpKG5l8ADfZGdg/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip'}, attempt #1 08:13:57 INFO - Fetch https://queue.taskcluster.net/v1/task/aoj3LXIwTpKG5l8ADfZGdg/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip into memory 08:13:58 INFO - Expected file size: 16317987 08:13:58 INFO - Obtained file size: 16317987 08:14:04 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/aoj3LXIwTpKG5l8ADfZGdg/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip 08:14:04 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/aoj3LXIwTpKG5l8ADfZGdg/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip'}, attempt #1 08:14:04 INFO - Fetch https://queue.taskcluster.net/v1/task/aoj3LXIwTpKG5l8ADfZGdg/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip into memory 08:14:05 INFO - Expected file size: 14403555 08:14:05 INFO - Obtained file size: 14403555 08:14:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:14:06 INFO - trying https://queue.taskcluster.net/v1/task/aoj3LXIwTpKG5l8ADfZGdg/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 08:14:06 INFO - Downloading https://queue.taskcluster.net/v1/task/aoj3LXIwTpKG5l8ADfZGdg/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg 08:14:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/aoj3LXIwTpKG5l8ADfZGdg/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg'}, attempt #1 08:14:08 INFO - Downloaded 70051675 bytes. 08:14:08 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/aoj3LXIwTpKG5l8ADfZGdg/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 08:14:08 INFO - mkdir: /builds/slave/test/properties 08:14:08 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:14:08 INFO - Writing to file /builds/slave/test/properties/build_url 08:14:08 INFO - Contents: 08:14:08 INFO - build_url:https://queue.taskcluster.net/v1/task/aoj3LXIwTpKG5l8ADfZGdg/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 08:14:08 INFO - Running post-action listener: _resource_record_post_action 08:14:08 INFO - Running post-action listener: set_extra_try_arguments 08:14:08 INFO - [mozharness: 2017-01-14 16:14:08.698355Z] Finished download-and-extract step (success) 08:14:08 INFO - [mozharness: 2017-01-14 16:14:08.698496Z] Running populate-webroot step. 08:14:08 INFO - Running pre-action listener: _resource_record_pre_action 08:14:08 INFO - Running main action method: populate_webroot 08:14:08 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:14:08 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:14:08 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:14:08 INFO - '--tppagecycles', 08:14:08 INFO - '7'], 08:14:08 INFO - 'tests': ['tsvgm']}}, 08:14:08 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:14:08 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:14:08 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:14:08 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:14:08 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:14:08 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:14:08 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 08:14:08 INFO - 'talos_options': ['--disable-e10s'], 08:14:08 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:14:08 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 08:14:08 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:14:08 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 08:14:08 INFO - 'talos_options': ['--disable-e10s'], 08:14:08 INFO - 'tests': ['damp', 'tps']}, 08:14:08 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 08:14:08 INFO - 'tests': ['damp', 'tps']}, 08:14:08 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:14:08 INFO - 'tests': ['dromaeo_dom']}, 08:14:08 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:14:08 INFO - 'g4': {'talos_options': ['--disable-e10s'], 08:14:08 INFO - 'tests': ['basic_compositor_video']}, 08:14:08 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 08:14:08 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:14:08 INFO - 'tests': ['a11yr', 08:14:08 INFO - 'ts_paint', 08:14:08 INFO - 'tpaint', 08:14:08 INFO - 'sessionrestore', 08:14:08 INFO - 'sessionrestore_no_auto_restore', 08:14:08 INFO - 'tabpaint']}, 08:14:08 INFO - 'other-e10s': {'tests': ['a11yr', 08:14:08 INFO - 'ts_paint', 08:14:08 INFO - 'tpaint', 08:14:08 INFO - 'sessionrestore', 08:14:08 INFO - 'sessionrestore_no_auto_restore', 08:14:08 INFO - 'tabpaint']}, 08:14:08 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:14:08 INFO - 'ts_paint', 08:14:08 INFO - 'tpaint', 08:14:08 INFO - 'sessionrestore', 08:14:08 INFO - 'sessionrestore_no_auto_restore', 08:14:08 INFO - 'tabpaint']}, 08:14:08 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:14:08 INFO - 'ts_paint', 08:14:08 INFO - 'tpaint', 08:14:08 INFO - 'sessionrestore', 08:14:08 INFO - 'sessionrestore_no_auto_restore', 08:14:08 INFO - 'tabpaint']}, 08:14:08 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:14:08 INFO - 'tests': ['a11yr', 08:14:08 INFO - 'ts_paint', 08:14:08 INFO - 'tpaint', 08:14:08 INFO - 'sessionrestore', 08:14:08 INFO - 'sessionrestore_no_auto_restore', 08:14:08 INFO - 'tabpaint']}, 08:14:08 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:14:08 INFO - 'tests': ['a11yr', 08:14:08 INFO - 'ts_paint', 08:14:08 INFO - 'tpaint', 08:14:08 INFO - 'sessionrestore', 08:14:08 INFO - 'sessionrestore_no_auto_restore', 08:14:08 INFO - 'tabpaint']}, 08:14:08 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:14:08 INFO - 'tests': ['tsvgx', 08:14:08 INFO - 'tsvgr_opacity', 08:14:08 INFO - 'tart', 08:14:08 INFO - 'tscrollx', 08:14:08 INFO - 'cart', 08:14:08 INFO - 'tsvg_static']}, 08:14:08 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:14:08 INFO - 'tsvgr_opacity', 08:14:08 INFO - 'tart', 08:14:08 INFO - 'tscrollx', 08:14:08 INFO - 'cart', 08:14:08 INFO - 'tsvg_static']}, 08:14:08 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 08:14:08 INFO - 'talos_options': ['--disable-e10s'], 08:14:08 INFO - 'tests': ['tp5o']}, 08:14:08 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 08:14:08 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 08:14:08 INFO - 'talos_options': ['--disable-e10s', 08:14:08 INFO - '--xperf_path', 08:14:08 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:14:08 INFO - 'tests': ['tp5n']}, 08:14:08 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 08:14:08 INFO - 'talos_options': ['--xperf_path', 08:14:08 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:14:08 INFO - 'tests': ['tp5n']}}, 08:14:08 INFO - 'talos.zip': {'path': '', 08:14:08 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:14:08 INFO - Running post-action listener: _resource_record_post_action 08:14:08 INFO - [mozharness: 2017-01-14 16:14:08.716796Z] Finished populate-webroot step (success) 08:14:08 INFO - [mozharness: 2017-01-14 16:14:08.716915Z] Running create-virtualenv step. 08:14:08 INFO - Running pre-action listener: _resource_record_pre_action 08:14:08 INFO - Running main action method: create_virtualenv 08:14:08 INFO - Creating virtualenv /builds/slave/test/build/venv 08:14:08 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:14:08 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:14:08 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:14:08 INFO - Using real prefix '/tools/python27' 08:14:08 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:14:09 INFO - Installing distribute.............................................................................................................................................................................................done. 08:14:12 INFO - Installing pip.................done. 08:14:12 INFO - Return code: 0 08:14:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 08:14:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 08:14:12 INFO - Reading from file tmpfile_stdout 08:14:12 INFO - Output received: 08:14:12 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:14:12 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:14:12 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:14:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:14:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:14:12 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:14:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:14:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:14:12 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 0x1043cfb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1043d2768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffdb1d76830>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1041add30>, '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 0x1040d4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1041a2be8>, '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.bXH5Kk85qy/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.DdPUgVyPmh/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/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:14:12 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:14:12 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:14:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bXH5Kk85qy/Render', 08:14:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:14:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:14:12 INFO - 'HOME': '/Users/cltbld', 08:14:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:14:12 INFO - 'LOGNAME': 'cltbld', 08:14:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:14:12 INFO - 'MOZ_NO_REMOTE': '1', 08:14:12 INFO - 'NO_EM_RESTART': '1', 08:14:12 INFO - 'PAGER': '/bin/cat', 08:14:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:14:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:14:12 INFO - 'PWD': '/builds/slave/test', 08:14:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:14:12 INFO - 'SHELL': '/bin/bash', 08:14:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DdPUgVyPmh/Listeners', 08:14:12 INFO - 'TMPDIR': '/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/', 08:14:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:14:12 INFO - 'USER': 'cltbld', 08:14:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:14:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:14:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:14:12 INFO - 'XPC_FLAGS': '0x0', 08:14:12 INFO - 'XPC_SERVICE_NAME': '0', 08:14:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:14:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:14:12 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:14:12 INFO - Cleaning up... 08:14:12 INFO - Return code: 0 08:14:12 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:14:12 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:14:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:14:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:14:12 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:14:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:14:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:14:12 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 0x1043cfb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1043d2768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffdb1d76830>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1041add30>, '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 0x1040d4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1041a2be8>, '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.bXH5Kk85qy/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.DdPUgVyPmh/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/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:14:12 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:14:12 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:14:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bXH5Kk85qy/Render', 08:14:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:14:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:14:12 INFO - 'HOME': '/Users/cltbld', 08:14:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:14:12 INFO - 'LOGNAME': 'cltbld', 08:14:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:14:12 INFO - 'MOZ_NO_REMOTE': '1', 08:14:12 INFO - 'NO_EM_RESTART': '1', 08:14:12 INFO - 'PAGER': '/bin/cat', 08:14:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:14:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:14:12 INFO - 'PWD': '/builds/slave/test', 08:14:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:14:12 INFO - 'SHELL': '/bin/bash', 08:14:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DdPUgVyPmh/Listeners', 08:14:12 INFO - 'TMPDIR': '/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/', 08:14:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:14:12 INFO - 'USER': 'cltbld', 08:14:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:14:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:14:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:14:12 INFO - 'XPC_FLAGS': '0x0', 08:14:12 INFO - 'XPC_SERVICE_NAME': '0', 08:14:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:14:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:14:13 INFO - Downloading/unpacking psutil>=3.1.1 08:14:13 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:14:13 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:14:13 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:14:13 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:14:13 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:14:13 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:14:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:14:16 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:14:16 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:14:16 INFO - Installing collected packages: psutil 08:14:16 INFO - Running setup.py install for psutil 08:14:16 INFO - building 'psutil._psutil_osx' extension 08:14:16 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 08:14:17 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:14:17 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:14:17 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:14:17 INFO - building 'psutil._psutil_posix' extension 08:14:17 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:14:17 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 08:14:17 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 08:14:17 INFO - ^ 08:14:17 INFO - 1 warning generated. 08:14:17 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:14:17 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:14:17 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:14:18 INFO - Successfully installed psutil 08:14:18 INFO - Cleaning up... 08:14:18 INFO - Return code: 0 08:14:18 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:14:18 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:14:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:14:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:14:18 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:14:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:14:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:14:18 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 0x1043cfb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1043d2768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffdb1d76830>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1041add30>, '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 0x1040d4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1041a2be8>, '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.bXH5Kk85qy/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.DdPUgVyPmh/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/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:14:18 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:14:18 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:14:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bXH5Kk85qy/Render', 08:14:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:14:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:14:18 INFO - 'HOME': '/Users/cltbld', 08:14:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:14:18 INFO - 'LOGNAME': 'cltbld', 08:14:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:14:18 INFO - 'MOZ_NO_REMOTE': '1', 08:14:18 INFO - 'NO_EM_RESTART': '1', 08:14:18 INFO - 'PAGER': '/bin/cat', 08:14:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:14:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:14:18 INFO - 'PWD': '/builds/slave/test', 08:14:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:14:18 INFO - 'SHELL': '/bin/bash', 08:14:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DdPUgVyPmh/Listeners', 08:14:18 INFO - 'TMPDIR': '/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/', 08:14:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:14:18 INFO - 'USER': 'cltbld', 08:14:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:14:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:14:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:14:18 INFO - 'XPC_FLAGS': '0x0', 08:14:18 INFO - 'XPC_SERVICE_NAME': '0', 08:14:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:14:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:14:18 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:14:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:14:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:14:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:14:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:14:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:14:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:14:21 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:14:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:14:21 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:14:21 INFO - Installing collected packages: mozsystemmonitor 08:14:21 INFO - Running setup.py install for mozsystemmonitor 08:14:21 INFO - Successfully installed mozsystemmonitor 08:14:21 INFO - Cleaning up... 08:14:21 INFO - Return code: 0 08:14:21 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:14:21 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:14:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:14:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:14:21 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:14:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:14:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:14:21 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 0x1043cfb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1043d2768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffdb1d76830>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1041add30>, '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 0x1040d4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1041a2be8>, '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.bXH5Kk85qy/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.DdPUgVyPmh/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/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:14:21 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:14:21 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:14:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bXH5Kk85qy/Render', 08:14:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:14:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:14:21 INFO - 'HOME': '/Users/cltbld', 08:14:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:14:21 INFO - 'LOGNAME': 'cltbld', 08:14:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:14:21 INFO - 'MOZ_NO_REMOTE': '1', 08:14:21 INFO - 'NO_EM_RESTART': '1', 08:14:21 INFO - 'PAGER': '/bin/cat', 08:14:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:14:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:14:21 INFO - 'PWD': '/builds/slave/test', 08:14:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:14:21 INFO - 'SHELL': '/bin/bash', 08:14:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DdPUgVyPmh/Listeners', 08:14:21 INFO - 'TMPDIR': '/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/', 08:14:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:14:21 INFO - 'USER': 'cltbld', 08:14:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:14:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:14:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:14:21 INFO - 'XPC_FLAGS': '0x0', 08:14:21 INFO - 'XPC_SERVICE_NAME': '0', 08:14:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:14:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:14:21 INFO - Downloading/unpacking jsonschema==2.5.1 08:14:21 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:14:21 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:14:21 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:14:21 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:14:21 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:14:21 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:14:24 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:14:24 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:14:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:14:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:14:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:14:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:14:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:14:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:14:24 INFO - Downloading functools32-3.2.3-2.tar.gz 08:14:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:14:24 INFO - warning: no files found matching '*.txt' 08:14:24 INFO - no previously-included directories found matching 'build' 08:14:24 INFO - no previously-included directories found matching 'dist' 08:14:24 INFO - no previously-included directories found matching '.git*' 08:14:24 INFO - Installing collected packages: jsonschema, functools32 08:14:24 INFO - Running setup.py install for functools32 08:14:24 INFO - warning: no files found matching '*.txt' 08:14:24 INFO - no previously-included directories found matching 'build' 08:14:24 INFO - no previously-included directories found matching 'dist' 08:14:24 INFO - no previously-included directories found matching '.git*' 08:14:24 INFO - Successfully installed jsonschema functools32 08:14:24 INFO - Cleaning up... 08:14:24 INFO - Return code: 0 08:14:24 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 08:14:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:14:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:14:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:14:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:14:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:14:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:14:24 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 0x1043cfb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1043d2768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffdb1d76830>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1041add30>, '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 0x1040d4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1041a2be8>, '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.bXH5Kk85qy/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.DdPUgVyPmh/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/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:14:24 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:14:24 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:14:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bXH5Kk85qy/Render', 08:14:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:14:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:14:24 INFO - 'HOME': '/Users/cltbld', 08:14:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:14:24 INFO - 'LOGNAME': 'cltbld', 08:14:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:14:24 INFO - 'MOZ_NO_REMOTE': '1', 08:14:24 INFO - 'NO_EM_RESTART': '1', 08:14:24 INFO - 'PAGER': '/bin/cat', 08:14:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:14:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:14:24 INFO - 'PWD': '/builds/slave/test', 08:14:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:14:24 INFO - 'SHELL': '/bin/bash', 08:14:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DdPUgVyPmh/Listeners', 08:14:24 INFO - 'TMPDIR': '/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/', 08:14:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:14:24 INFO - 'USER': 'cltbld', 08:14:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:14:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:14:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:14:24 INFO - 'XPC_FLAGS': '0x0', 08:14:24 INFO - 'XPC_SERVICE_NAME': '0', 08:14:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:14:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:14:25 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 08:14:25 INFO - Cleaning up... 08:14:25 INFO - Return code: 0 08:14:25 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:14:25 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:14:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:14:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:14:25 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:14:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:14:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:14:25 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 0x1043cfb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1043d2768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffdb1d76830>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1041add30>, '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 0x1040d4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1041a2be8>, '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.bXH5Kk85qy/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.DdPUgVyPmh/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/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:14:25 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:14:25 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:14:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bXH5Kk85qy/Render', 08:14:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:14:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:14:25 INFO - 'HOME': '/Users/cltbld', 08:14:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:14:25 INFO - 'LOGNAME': 'cltbld', 08:14:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:14:25 INFO - 'MOZ_NO_REMOTE': '1', 08:14:25 INFO - 'NO_EM_RESTART': '1', 08:14:25 INFO - 'PAGER': '/bin/cat', 08:14:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:14:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:14:25 INFO - 'PWD': '/builds/slave/test', 08:14:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:14:25 INFO - 'SHELL': '/bin/bash', 08:14:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DdPUgVyPmh/Listeners', 08:14:25 INFO - 'TMPDIR': '/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/', 08:14:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:14:25 INFO - 'USER': 'cltbld', 08:14:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:14:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:14:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:14:25 INFO - 'XPC_FLAGS': '0x0', 08:14:25 INFO - 'XPC_SERVICE_NAME': '0', 08:14:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:14:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:14:25 INFO - Downloading/unpacking blobuploader==1.2.4 08:14: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:14: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:14: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:14: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:14: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:14: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:14:28 INFO - Downloading blobuploader-1.2.4.tar.gz 08:14:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:14:28 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:14:28 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:14:28 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:14:28 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:14:28 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:14:28 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:14:28 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:14:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:14:28 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:14:28 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:14:28 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:14:28 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:14:28 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:14:28 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:14:28 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:14:29 INFO - Downloading docopt-0.6.1.tar.gz 08:14:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:14:29 INFO - Installing collected packages: blobuploader, requests, docopt 08:14:29 INFO - Running setup.py install for blobuploader 08:14:29 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:14:29 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:14:29 INFO - Running setup.py install for requests 08:14:30 INFO - Running setup.py install for docopt 08:14:30 INFO - Successfully installed blobuploader requests docopt 08:14:30 INFO - Cleaning up... 08:14:30 INFO - Return code: 0 08:14:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:14:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:14:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:14:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:14:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:14:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:14:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:14:30 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 0x1043cfb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1043d2768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffdb1d76830>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1041add30>, '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 0x1040d4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1041a2be8>, '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.bXH5Kk85qy/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.DdPUgVyPmh/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/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:14:30 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:14:30 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:14:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bXH5Kk85qy/Render', 08:14:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:14:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:14:30 INFO - 'HOME': '/Users/cltbld', 08:14:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:14:30 INFO - 'LOGNAME': 'cltbld', 08:14:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:14:30 INFO - 'MOZ_NO_REMOTE': '1', 08:14:30 INFO - 'NO_EM_RESTART': '1', 08:14:30 INFO - 'PAGER': '/bin/cat', 08:14:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:14:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:14:30 INFO - 'PWD': '/builds/slave/test', 08:14:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:14:30 INFO - 'SHELL': '/bin/bash', 08:14:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DdPUgVyPmh/Listeners', 08:14:30 INFO - 'TMPDIR': '/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/', 08:14:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:14:30 INFO - 'USER': 'cltbld', 08:14:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:14:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:14:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:14:30 INFO - 'XPC_FLAGS': '0x0', 08:14:30 INFO - 'XPC_SERVICE_NAME': '0', 08:14:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:14:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:14:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:14:30 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-CaPk3S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:14:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:14:30 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-FAyYdV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:14:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:14:30 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-aBC6D7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:14:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:14:31 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-Mn7vUU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:14:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:14:31 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-REg3Pt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:14:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:14:31 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-LrZ7R2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:14:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:14:31 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-fij1Zg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:14:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:14:31 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-NApHma-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:14:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:14:31 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-pOgl3g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:14:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:14:31 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-WKg3TX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:14:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:14:31 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-rfk99P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:14:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:14:31 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-K5Wdwg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:14:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:14:31 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-_08V8t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:14:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:14:32 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-JS7zuO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:14:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:14:32 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-vq79bI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:14:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:14:32 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-WCSgDK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:14:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:14:32 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-MCiEtF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:14:32 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:14:32 INFO - Running setup.py install for manifestparser 08:14:32 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:14:32 INFO - Running setup.py install for mozcrash 08:14:32 INFO - Running setup.py install for mozdebug 08:14:32 INFO - Running setup.py install for mozdevice 08:14:33 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:14:33 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:14:33 INFO - Running setup.py install for mozfile 08:14:33 INFO - Running setup.py install for mozhttpd 08:14:33 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:14:33 INFO - Running setup.py install for mozinfo 08:14:33 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:14:33 INFO - Running setup.py install for mozInstall 08:14:33 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:14:33 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:14:33 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:14:33 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:14:33 INFO - Running setup.py install for mozleak 08:14:33 INFO - Running setup.py install for mozlog 08:14:34 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:14:34 INFO - Running setup.py install for moznetwork 08:14:34 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:14:34 INFO - Running setup.py install for mozprocess 08:14:34 INFO - Running setup.py install for mozprofile 08:14:34 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:14:34 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:14:34 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:14:34 INFO - Running setup.py install for mozrunner 08:14:34 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:14:34 INFO - Running setup.py install for mozscreenshot 08:14:34 INFO - Running setup.py install for moztest 08:14:34 INFO - Running setup.py install for mozversion 08:14:35 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:14:35 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:14:35 INFO - Cleaning up... 08:14:35 INFO - Return code: 0 08:14:35 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:14:35 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:14:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:14:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:14:35 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:14:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:14:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:14:35 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 0x1043cfb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1043d2768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffdb1d76830>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1041add30>, '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 0x1040d4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1041a2be8>, '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.bXH5Kk85qy/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.DdPUgVyPmh/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/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:14:35 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:14:35 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:14:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bXH5Kk85qy/Render', 08:14:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:14:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:14:35 INFO - 'HOME': '/Users/cltbld', 08:14:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:14:35 INFO - 'LOGNAME': 'cltbld', 08:14:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:14:35 INFO - 'MOZ_NO_REMOTE': '1', 08:14:35 INFO - 'NO_EM_RESTART': '1', 08:14:35 INFO - 'PAGER': '/bin/cat', 08:14:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:14:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:14:35 INFO - 'PWD': '/builds/slave/test', 08:14:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:14:35 INFO - 'SHELL': '/bin/bash', 08:14:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DdPUgVyPmh/Listeners', 08:14:35 INFO - 'TMPDIR': '/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/', 08:14:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:14:35 INFO - 'USER': 'cltbld', 08:14:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:14:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:14:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:14:35 INFO - 'XPC_FLAGS': '0x0', 08:14:35 INFO - 'XPC_SERVICE_NAME': '0', 08:14:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:14:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:14:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:14:35 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-uhCPhG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:14:35 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:14:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:14:35 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-eXePJ4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:14:35 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:14:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:14:35 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-qnnwQx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:14:35 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:14:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:14:35 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-nHT3Ga-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:14:35 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:14:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:14:35 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-BATsQq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:14:35 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:14:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:14:35 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-ljRNir-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:14:36 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:14:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:14:36 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-dvdZFe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:14:36 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:14:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:14:36 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-iLtkAy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:14:36 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:14:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:14:36 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-NXHCZ9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:14:36 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:14:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:14:36 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-FPxQYA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:14:36 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:14:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:14:36 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-nyeFF9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:14:36 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:14:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:14:36 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-yVODky-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:14:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.24 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:14:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:14:36 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-E9d7XU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:14:36 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:14:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:14:36 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-YK4pye-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:14:36 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:14:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:14:36 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-1HAOhC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:14:37 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:14:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:14:37 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-4OHKMH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:14:37 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 08:14:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:14:37 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-5PiHq8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:14:37 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:14:37 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:14:37 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:14:37 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:14:37 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:14:37 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:14:37 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:14:37 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:14:37 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:14:37 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:14:37 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:14:37 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:14:37 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:14:39 INFO - Downloading blessings-1.6.tar.gz 08:14:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:14:40 INFO - Installing collected packages: blessings 08:14:40 INFO - Running setup.py install for blessings 08:14:40 INFO - Successfully installed blessings 08:14:40 INFO - Cleaning up... 08:14:40 INFO - Return code: 0 08:14:40 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:14:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:14:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:14:40 INFO - Reading from file tmpfile_stdout 08:14:40 INFO - Current package versions: 08:14:40 INFO - blessings == 1.6 08:14:40 INFO - blobuploader == 1.2.4 08:14:40 INFO - docopt == 0.6.1 08:14:40 INFO - functools32 == 3.2.3-2 08:14:40 INFO - jsonschema == 2.5.1 08:14:40 INFO - manifestparser == 1.1 08:14:40 INFO - mozInstall == 1.12 08:14:40 INFO - mozcrash == 1.0 08:14:40 INFO - mozdebug == 0.1 08:14:40 INFO - mozdevice == 0.49 08:14:40 INFO - mozfile == 1.2 08:14:40 INFO - mozhttpd == 0.7 08:14:40 INFO - mozinfo == 0.9 08:14:40 INFO - mozleak == 0.1 08:14:40 INFO - mozlog == 3.4 08:14:40 INFO - moznetwork == 0.27 08:14:40 INFO - mozprocess == 0.24 08:14:40 INFO - mozprofile == 0.28 08:14:40 INFO - mozrunner == 6.13 08:14:40 INFO - mozscreenshot == 0.1 08:14:40 INFO - mozsystemmonitor == 0.3 08:14:40 INFO - moztest == 0.8 08:14:40 INFO - mozversion == 1.4 08:14:40 INFO - psutil == 3.1.1 08:14:40 INFO - requests == 1.2.3 08:14:40 INFO - wsgiref == 0.1.2 08:14:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:14:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:14:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:14:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:14:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:14:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:14:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:14:41 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 0x1043cfb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1043d2768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffdb1d76830>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1041add30>, '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 0x1040d4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1041a2be8>, '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.bXH5Kk85qy/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.DdPUgVyPmh/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/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:14:41 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:14:41 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:14:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bXH5Kk85qy/Render', 08:14:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:14:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:14:41 INFO - 'HOME': '/Users/cltbld', 08:14:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:14:41 INFO - 'LOGNAME': 'cltbld', 08:14:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:14:41 INFO - 'MOZ_NO_REMOTE': '1', 08:14:41 INFO - 'NO_EM_RESTART': '1', 08:14:41 INFO - 'PAGER': '/bin/cat', 08:14:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:14:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:14:41 INFO - 'PWD': '/builds/slave/test', 08:14:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:14:41 INFO - 'SHELL': '/bin/bash', 08:14:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DdPUgVyPmh/Listeners', 08:14:41 INFO - 'TMPDIR': '/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/', 08:14:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:14:41 INFO - 'USER': 'cltbld', 08:14:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:14:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:14:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:14:41 INFO - 'XPC_FLAGS': '0x0', 08:14:41 INFO - 'XPC_SERVICE_NAME': '0', 08:14:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:14:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:14:41 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:14:41 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:14:41 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:14:41 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:14:41 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:14:41 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:14:41 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:14:41 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:14:41 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:14:41 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:14:41 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:14:41 INFO - Cleaning up... 08:14:41 INFO - Return code: 0 08:14:41 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:14:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:14:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:14:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:14:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:14:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:14:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:14:41 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1043cfb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1043d2768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffdb1d76830>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1041add30>, '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 0x1040d4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1041a2be8>, '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.bXH5Kk85qy/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.DdPUgVyPmh/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/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:14:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 08:14:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 08:14:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bXH5Kk85qy/Render', 08:14:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:14:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:14:41 INFO - 'HOME': '/Users/cltbld', 08:14:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:14:41 INFO - 'LOGNAME': 'cltbld', 08:14:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:14:41 INFO - 'MOZ_NO_REMOTE': '1', 08:14:41 INFO - 'NO_EM_RESTART': '1', 08:14:41 INFO - 'PAGER': '/bin/cat', 08:14:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:14:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:14:41 INFO - 'PWD': '/builds/slave/test', 08:14:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:14:41 INFO - 'SHELL': '/bin/bash', 08:14:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DdPUgVyPmh/Listeners', 08:14:41 INFO - 'TMPDIR': '/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/', 08:14:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:14:41 INFO - 'USER': 'cltbld', 08:14:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:14:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:14:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:14:41 INFO - 'XPC_FLAGS': '0x0', 08:14:41 INFO - 'XPC_SERVICE_NAME': '0', 08:14:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:14:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:14:42 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:14:42 INFO - Cleaning up... 08:14:42 INFO - Return code: 0 08:14:42 INFO - Running post-action listener: _resource_record_post_action 08:14:42 INFO - Running post-action listener: _start_resource_monitoring 08:14:42 INFO - Starting resource monitoring. 08:14:42 INFO - [mozharness: 2017-01-14 16:14:42.286872Z] Finished create-virtualenv step (success) 08:14:42 INFO - [mozharness: 2017-01-14 16:14:42.287826Z] Running install step. 08:14:42 INFO - Running pre-action listener: _resource_record_pre_action 08:14:42 INFO - Running main action method: install 08:14:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:14:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:14:42 INFO - Reading from file tmpfile_stdout 08:14:42 INFO - Detecting whether we're running mozinstall >=1.0... 08:14:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:14:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:14:42 INFO - Reading from file tmpfile_stdout 08:14:42 INFO - Output received: 08:14:42 INFO - Usage: mozinstall [options] installer 08:14:42 INFO - Options: 08:14:42 INFO - -h, --help show this help message and exit 08:14:42 INFO - -d DEST, --destination=DEST 08:14:42 INFO - Directory to install application into. [default: 08:14:42 INFO - "/builds/slave/test"] 08:14:42 INFO - --app=APP Application being installed. [default: firefox] 08:14:42 INFO - mkdir: /builds/slave/test/build/application 08:14:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 08:14:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 08:15:04 INFO - Reading from file tmpfile_stdout 08:15:04 INFO - Output received: 08:15:04 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 08:15:04 INFO - Running post-action listener: _resource_record_post_action 08:15:04 INFO - [mozharness: 2017-01-14 16:15:04.342222Z] Finished install step (success) 08:15:04 INFO - [mozharness: 2017-01-14 16:15:04.342350Z] Running run-tests step. 08:15:04 INFO - Running pre-action listener: _resource_record_pre_action 08:15:04 INFO - Running main action method: run_tests 08:15:04 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 08:15:04 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 08:15:04 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 08:15:04 INFO - 2017-01-14 08:15:04.354 screenresolution[1624:7513] starting screenresolution argv=screenresolution get 08:15:04 INFO - 2017-01-14 08:15:04.357 screenresolution[1624:7513] Display 0: 1600x1200x32@60 08:15:04 INFO - 2017-01-14 08:15:04.362 screenresolution[1625:7516] starting screenresolution argv=screenresolution list 08:15:04 INFO - Available Modes on Display 0 08:15:04 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 08:15:04 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 08:15:04 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 08:15:04 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 08:15:04 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 08:15:04 INFO - Intel Iris: 08:15:04 INFO - Chipset Model: Intel Iris 08:15:04 INFO - Type: GPU 08:15:04 INFO - Bus: Built-In 08:15:04 INFO - VRAM (Dynamic, Max): 1536 MB 08:15:04 INFO - Vendor: Intel (0x8086) 08:15:04 INFO - Device ID: 0x0a2e 08:15:04 INFO - Revision ID: 0x0009 08:15:04 INFO - Displays: 08:15:04 INFO - Display: 08:15:04 INFO - Resolution: 1600 x 1200 @ 60 Hz 08:15:04 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 08:15:04 INFO - Display Serial Number: 1600x1200 60 08:15:04 INFO - Main Display: Yes 08:15:04 INFO - Mirror: Off 08:15:04 INFO - Online: Yes 08:15:04 INFO - Rotation: Supported 08:15:04 INFO - Return code: 0 08:15:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:15:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:15:04 INFO - Python 2.7.3 08:15:04 INFO - Return code: 0 08:15:04 INFO - grabbing minidump binary from tooltool 08:15:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:15:04 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 0x1041add30>, '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 0x1040d4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1041a2be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:15:04 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:15:04 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:15:04 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:15:04 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:15:04 INFO - Return code: 0 08:15:04 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 08:15:04 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:15:04 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:15:04 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 08:15:04 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:15:04 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/aoj3LXIwTpKG5l8ADfZGdg/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0084', '--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:15:04 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/aoj3LXIwTpKG5l8ADfZGdg/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0084 --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:15:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bXH5Kk85qy/Render', 08:15:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:15:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:15:04 INFO - 'HOME': '/Users/cltbld', 08:15:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:15:04 INFO - 'LOGNAME': 'cltbld', 08:15:04 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:15:04 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 08:15:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:15:04 INFO - 'MOZ_NO_REMOTE': '1', 08:15:04 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:15:04 INFO - 'NO_EM_RESTART': '1', 08:15:04 INFO - 'PAGER': '/bin/cat', 08:15:04 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:15:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:15:04 INFO - 'PWD': '/builds/slave/test', 08:15:04 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:15:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:15:04 INFO - 'SHELL': '/bin/bash', 08:15:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DdPUgVyPmh/Listeners', 08:15:04 INFO - 'TMPDIR': '/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/', 08:15:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:15:04 INFO - 'USER': 'cltbld', 08:15:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:15:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:15:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:15:04 INFO - 'XPC_FLAGS': '0x0', 08:15:04 INFO - 'XPC_SERVICE_NAME': '0', 08:15:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:15:04 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/aoj3LXIwTpKG5l8ADfZGdg/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0084', '--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:15:04 INFO - mozversion application_buildid: 20170114070623 08:15:04 INFO - mozversion application_changeset: 8a43d22ed38e343a63edec572ac9a299e50712df 08:15:04 INFO - mozversion application_display_name: Nightly 08:15:04 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:15:04 INFO - mozversion application_name: Firefox 08:15:04 INFO - mozversion application_remotingname: firefox 08:15:04 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 08:15:04 INFO - mozversion application_vendor: Mozilla 08:15:04 INFO - mozversion application_version: 53.0a1 08:15:04 INFO - mozversion platform_buildid: 20170114070623 08:15:04 INFO - mozversion platform_changeset: 8a43d22ed38e343a63edec572ac9a299e50712df 08:15:04 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 08:15:04 INFO - mozversion platform_version: 53.0a1 08:15:04 INFO - using testdate: 1484410504 08:15:04 INFO - actual date: 1484410504 08:15:04 INFO - starting webserver on 'localhost:49245' 08:15:04 INFO - SUITE-START | Running 2 tests 08:15:04 INFO - TEST-START | dromaeo_css 08:15:04 INFO - operating with platform_type : mac_ 08:15:04 INFO - Initialising browser for dromaeo_css test... 08:15:04 INFO - TEST-INFO | started process 1635 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/tmpKOzvY6/profile http://localhost:49245/getInfo.html) 08:15:07 INFO - PROCESS | 1635 | __metrics Screen width/height:1600/1200 08:15:07 INFO - PROCESS | 1635 | colorDepth:24 08:15:07 INFO - PROCESS | 1635 | Browser inner width/height: 1024/689 08:15:07 INFO - PROCESS | 1635 | __metrics 08:15:07 INFO - PROCESS | 1635 | 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:15:07 INFO - PROCESS | 1635 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:15:08 INFO - TEST-INFO | 1635: exit 0 08:15:08 INFO - Browser initialized. 08:15:08 INFO - Running cycle 1/1 for dromaeo_css test... 08:15:08 INFO - TEST-INFO | started process 1637 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/tmpKOzvY6/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:15:20 INFO - PROCESS | 1637 | RSS: Main: 234909696 08:15:20 INFO - PROCESS | 1637 | 08:18:23 INFO - PROCESS | 1637 | Cycle 1(1): loaded http://localhost:49245/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49245/tests/dromaeo/cssquery-ext.html) 08:18:25 INFO - PROCESS | 1637 | RSS: Main: 399867904 08:18:25 INFO - PROCESS | 1637 | 08:20:10 INFO - PROCESS | 1637 | ************************* 08:20:10 INFO - PROCESS | 1637 | A coding exception was thrown and uncaught in a Task. 08:20:10 INFO - PROCESS | 1637 | 08:20:10 ERROR - PROCESS | 1637 | Full message: TypeError: NetworkError when attempting to fetch resource. 08:20:10 INFO - PROCESS | 1637 | Full stack: 08:20:10 INFO - PROCESS | 1637 | ************************* 08:21:28 INFO - PROCESS | 1637 | Cycle 1(1): loaded http://localhost:49245/tests/dromaeo/cssquery-ext.html (next: http://localhost:49245/tests/dromaeo/cssquery-jquery.html) 08:21:29 INFO - PROCESS | 1637 | RSS: Main: 367419392 08:21:29 INFO - PROCESS | 1637 | 08:24:31 INFO - PROCESS | 1637 | Cycle 1(1): loaded http://localhost:49245/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49245/tests/dromaeo/cssquery-mootools.html) 08:24:31 INFO - PROCESS | 1637 | RSS: Main: 335646720 08:24:31 INFO - PROCESS | 1637 | 08:27:34 INFO - PROCESS | 1637 | Cycle 1(1): loaded http://localhost:49245/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49245/tests/dromaeo/cssquery-prototype.html) 08:27:35 INFO - PROCESS | 1637 | RSS: Main: 339165184 08:27:35 INFO - PROCESS | 1637 | 08:30:38 INFO - PROCESS | 1637 | Cycle 1(1): loaded http://localhost:49245/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49245/tests/dromaeo/cssquery-yui.html) 08:30:39 INFO - PROCESS | 1637 | RSS: Main: 323067904 08:30:39 INFO - PROCESS | 1637 | 08:33:42 INFO - PROCESS | 1637 | Cycle 1(1): loaded http://localhost:49245/tests/dromaeo/cssquery-yui.html (next: http://localhost:49245/tests/dromaeo/cssquery-dojo.html) 08:33:42 INFO - PROCESS | 1637 | RSS: Main: 490778624 08:33:42 INFO - PROCESS | 1637 | 08:33:42 INFO - PROCESS | 1637 | __start_tp_report 08:33:42 INFO - PROCESS | 1637 | _x_x_mozilla_page_load 08:33:42 INFO - PROCESS | 1637 | _x_x_mozilla_page_load_details 08:33:42 INFO - PROCESS | 1637 | |i|pagename|runs| 08:33:42 INFO - PROCESS | 1637 | |0;dojo.html;3335.199552107494;3338.482535207043;3370.6460821613714;3371.292028673978;3429.988153494719;4404.810701110699;5344.625876188668;5636.577256705743;5686.886262274752;5697.373288938214;5278.313819203508;5591.440855914407;5607.887842243153;5624.606277560572;5630.352509461403;5094.439611642726;5132.8460146195675;5147.305113809644;5168.819091331804;5233.398159211702;5157.200633901752;5239.738013099349;5246.239295302179;5246.816361427351;5253.106971814782;5241.842744717665;5242.3184985951775;5243.475652434745;5245.291885595453;5247.973760131194;5180.507851754115;5209.895802083956;5210.452902445227;5248.947510524884;5307.867303317409;5115.872103197413;5185.274061631375;5198.194279886624;5201.115810312256;5271.42014378418;5718.34239062509;5768.221290125821;5775.249217601727;5780.248567686216;5784.971075144639;5165.535101840815;5887.116932460122;6226.346233645492;6234.688265586748;6269.404406581368;6237.313895471494;6308.463780578656;6329.430351268362;6341.587796793194;6343.492520598387;5815.592908496407;5840.3575606683235;5848;5850.151727999501;5883.588148829584;6203.410675985774;6270.498360131179;6313.368663133741;6340.968295158587;6369.936300636934;6021.879562408727;6141.990424691869;6146.5390095743;6171.259448866164;6173;6292.968535157295;6293.842653933688;6296.748130074838;6305.842353941188;6313.684315784192;6047.2743270806905;6074.635521868702;6221.191245138193;6226.875462490725;6233.3143354231;6109.101029780167;6137.499563105042;6153.692315384213;6188.81433556994;6236.970899801482;4859;4918.5819205367225;4937.432195297587;4946.802127914843;4968.27959945813;4412.977935110304;4443.422355093817;4455.598996090367;4465.106978604292;4482.8792801799555;5656.2929633795775;5662.8301150965535;5663.66018038919;5714.371419143891;5771.134329850472;6260.718267677966;6306.180196574416;6313.273973493016;6321.841953951188;6339.397757213057;5543.445655434424;5626.831195064155;5643.181738647873;5683.403242659544;5710.086386178192;4606.861794146181;5453.100238460689;5475.151351540518;5487.149491828773;5507.0637991541535;6292.559520833681;6316.052592111128;6318.936810631927;6320.5259605528845;6346.333634968447;6142.785002525069;6142.867137759864;6325.209348831396;6326.6520341381665;6339.809805705836;6263.123162757127;6294.024426213944;6313.494920406449;6330.841728956813;6338.714757836001;6180.103884936749;6222.906656400248;6234.532410069353;6249.281332646622;6258.374162583706;6261.279952805486;6303.9684801575695;6306.65313407767;6317.210348706411;6327.588706734047;5910.113482977587;5948.167256583995;6046.5767396281835;6049.485793707408;6096.993995990611;5862.062070068769;6101.786437474667;6103.176071230505;6114.38856114385;6116.8776624468155;5920.37836027211;5939.990201665813;5972;5982.192404025401;5989.401059893976;4829.9275510868065;5989.490893274121;5997.670128142994;6005.279366476051;6053.031514957585;5863.413658634103;5882.088276317178;5884.9705751470965;5910.143029260647;5931.851703707442 08:33:42 INFO - PROCESS | 1637 | |1;ext.html;430.70711915897186;452.58814478824274;498.3421883114291;501.28817079746756;512.2111947600695;30966.53550196749;41190;42898.14203715932;43076;45446.09107817842;43444.090031897125;43836.780816095874;43875.90310242245;43922.560774392245;43930.780346098305;7880.724174653874;9427.387219830689;9429.575669094907;9445.716628501155;9453.291003174754;8376.706815261467;8597.226249637532;11141.832872506919;11380.71548211293;11413.828792568118;11252.774944501105;11326.773464530705;11358.375289359083;11364.147688923322;11370.204085714004;6780.423663988567;11354.829677554802;11417.54329826806;11419.657410277705;11449.542018319256;8474.1187996081;10937.56249750009;11246.3814490203;11259.155563332783;11398.60104896333;41082;41240.38139427911;41243.381349279785;41382;41388.1722365554;4008.2584721826556;4027.234825383197;4056.6146216109423;4062.6749860011128;4193.97903010483;30106.28500311139;31011.06966791;31046.379072418425;31270.21824454384;31391.686083139106;3230.176305042199;3262.6411094779555;3297.7032067114073;3308.3217940322174;3368.6799754023327;485397;485489;486154;486907;488365;65126;65284;65547.34452655508;65555.01667474992;65631.01553476606;67947.98078028833;68136.6593167031;68204.6589767048;68248.6587567059;68378;16299.103549304902;16540.917295413445;16545.420910268323;16555;16568.502944911674;11313.83029254562;11626.128040397005;12639.87360126387;12702.047346449053;12726.936365318299;16515.33938642465;17988.893022999357;21493.67759483609;21639.67540486894;22047.44881377946;7758.9137520747145;8064;8551.230389264996;8641.049484556694;8689.522076285739;849.562475325208;861.7199410191588;891.4116682989196;898.3980732908967;940.1585580905052;30038.549421758693;30364.84817575898;30666.846665766527;31292.374152517277;31546.211344716106;1035.8705161854768;1081.216118314216;1081.853949716794;1122.5004872831512;1127.8984891359653;14205.147691138565;15917.602059948362;15994.680106397807;16072.602657846912;16304.103274320027;648540;653375;653532;654482;655733;63069.68465157645;63603;63706.36293637097;63856;63925;1435.7128574284975;1442.9602817067603;1465.0257578710252;1482.7405204089457;1488.7245859515808;29715;30113.94601188948;30396.240093997825;30401.847990759903;31000.84499577578;54160.916781663356;54455.45544544504;54627.907441851734;54704.72647636737;54780.45219547913;515144;564822.1660050615;566897;567286;567584;36095.81952090328;36837.81581092077;43018.92452688708;43068.49260275875;43767.78116109399;39694.80152599219;47678.80802979953;47736.28395574;50323.74838125933;51631.48368516417;40212;40430;40566;40696.1860762789;41263;40165;40440.59559404368;41243.38134928038;41381.37927931143;41449.171016580105;37711;38307.80846095863;38555.42166867443;38762.224755505296;39210.803945980086;34142;34825.95522134239;35414.468782967764;35526.64473355233;35635.46546801852;25144.874275628506;25168.119115830857;25256.873715631304;25591.744082558936;25626 08:33:42 INFO - PROCESS | 1637 | |2;jquery.html;390.5333126913339;392.19012738694613;396.60735871487225;397.11047254150674;424.0628211652248;14193.574192774233;20008.29970951017;20399.592008159827;21338.679919801198;21367.465813354655;20738.792612073874;20902.163913443444;21117.838518881454;21493.775933609926;21731.23940662077;4665.766711664412;5640.37955824861;5664.858378540549;5745.023346031185;5746.683932383718;5525.613207075507;5646.858828529279;5759.424057594228;5767.365589785141;5779.190913272145;5794.130880367937;5796.44933731297;5797.913031304533;5804.071348584227;5804.622699524517;5593.664380137185;5689.374168841424;5768.567357448187;5784.2769653793275;5876.089206173007;5107.412647545542;5137.434882162959;5157.613179011551;5182.637215394924;5199.948000519984;26105.347366315804;26256.73743262562;26308.60537091926;26432.0748773792;26620.866895665593;2766.2531116598607;2790;2790.7906906981852;2797.426527561845;2799.2861820235707;15053.849461505355;15616.531504054896;15712.29294681742;15910.0453972762;16248.268827902773;1821.3352126473874;1837.9982909314456;1839.7700287464068;1855.396995976313;1894.6021335519558;92503;125535.37232313871;129261.41477170498;129574.3521282397;130105.34947325298;9327.766805829908;11178.832317515244;11482.48328825205;11524.250923689933;11567.595134170264;12851.935740321425;13533.578974207763;14423.278836058365;14566.41734330636;14572.489962851461;7716.035495563055;7802.180771019075;7944.165862584461;8365.456245344034;8863.202311791969;8549.316054715608;8596.613152408157;8608.741737747878;8764.56177191138;8765.71285767837;6999.930000699927;7112.608806515691;7138.535995160298;7143.464240182007;7148.28517148281;1871.9719204211947;1912.4358314297315;1915.7222202780797;1917.7027560728109;1918.8177123173277;886.2776836877924;1000.7248006798188;1049.732318258839;1051.3534176481562;1090.373035504588;18293.02719488092;19147.13837877299;21867.015984280744;22520.54958900813;22557.43606409853;1039.2465462539599;1065.2170654568886;1075.854759607443;1118.2172479264548;1124.8931351521592;11497.482613282422;11662.84517994228;11793.233439826385;11805.291682499077;11808.88191118095;598716;711350;724465;724863;740714;120062.19906701407;132696.3365183168;134711.32644336912;138563;141888.29055854655;1031.8194315994672;1041.4740556019162;1051.952662130206;1058.2645061682058;1065.280935368623;18863.43409697711;19491.902540487208;19523.316683915993;19527.12127954217;19528.21887124499;51078.744606276734;51309.48690513047;51972.48027519828;53832.73083634557;56295;77194;78434;79599;81438;86871;5891.528677705859;7346.33882950537;7424.554526728413;7589.6205189739185;8342.12407697183;8626.956865215634;12912.548060817826;12943.417546210254;12955.676108097374;13381.732365352833;10659.413732244491;10663.520141593492;10989.340639561333;11074.058705009842;11168.720781980515;11092.389918554558;11124.721881953015;11229.3262404256;11398.658040258806;11608.071354291467;11294.717632059264;11375.886241137814;11408.030317423112;11724.88275117238;11772.646820595395;6226.844328891814;7372.078490188726;7548.8490230196185;7607.12518060408;7790.298873101448;9036.2831062098;9909.851352229867;11040.613578524713;11344.262622929484;11371.204015719151 08:33:42 INFO - PROCESS | 1637 | |3;mootools.html;1266.613682826738;1432.8423873373927;1454.665426951801;1458.5259790568068;1463.7438448271553;8162.061362943264;8558.871616925751;8583.356248281381;8589.527575983318;8592.054873963874;7149.571025738459;7362.042934418531;7699.884501732478;8120.553369564672;8311.293540049088;2277.3737222263844;2280.9885950570224;2289.7710228977053;2313.9421514462188;2314.0628045641542;2305.3660243433023;2331.219041621059;2335.2877372401413;2346.5658853112145;2380.8809559521956;2053.691946208073;2125.3836387447623;2202.526456811785;2295.7933785959262;2309.803666688325;2290.6678531612906;2334.5447637710654;2337.7662233776655;2344.2498400511845;2346.624540073597;2038.6738121900573;2309.93070207894;2339.5320935812906;2373.1931143411325;2373.6439534069855;8305.003399592028;8377.120402357787;8378.916210837875;8391.790205244857;8394.496330220207;4324.567543245682;5056.342675452204;5202.843914682566;5219.582433405357;5227.242049902781;3284.2774589590254;3440.673136052071;3441.6730410610953;3470.288590838897;3490.301939612062;1142.5601143559707;1185.887340702632;1200;1233.481937586216;1246.5200897654377;10609.9469502652;10794.73013174669;10875.891241087567;10895.945520272428;10904.182186335976;4404.8458303959205;4575.290829921368;4596.655250856199;4640.83757068501;4687.484376718558;9426.575804088832;9427.245820334358;9428.481433521221;9437.716868493957;9439.716808495756;5191.5846732261325;5191.740412979336;5202.739863006835;5204.71374074422;5204.869878252998;3909.7654140751647;4224.66202703783;4333.111712099012;4611.054733779567;4774.092922344744;3805.8667946621736;3869.8258578364043;3935.4883865097927;3940.802959851996;3947.980260098681;1264.8861602455822;1295.3070107492447;1295.9481620735064;1304.419533307688;1308.0385916351474;665.5607299182516;748.7267147491126;783.561205724796;791.3708601661692;818.8976377952756;5089.312942752681;5359.758810853521;5400.621956463088;5448.56411487088;5485.985092757853;553.750812134533;561.7809054468761;570.0764761087065;575.3211210771246;580.054511146828;3611.6207798180812;3676.227992121631;3703.4453898730517;3747.9250414992093;3861.4014827701753;8447.873281900776;9912.504374781232;9923.454210018519;9946.055124763281;9954.352967057119;9718.659846905466;9723.124918757347;9851.359661621971;9870.654527091518;9889.258305627107;7380.298871607296;7683.308502234826;7764.883526747103;7777.494462859896;7805.765827025199;5430.185472179205;5612.803551875665;5634.197056941739;5647.407022262768;5732.796112816355;8894.555272236234;9006.414583052081;9223.76940576491;9281.59569896769;9301.395409298373;9078.954605226932;9272.675456358995;9427.434353938786;9535.47554884488;9554.904450955402;6651.135352404156;6863.039174515472;6863.897041544281;7096.829023211112;7280.381167600814;7608.16310205888;7895.210478952059;7898.210178982055;7982.1618730032515;7992.800179995546;7042.647867606497;7116.46626503004;7116.822079448055;7175.31834475724;7255.165655949633;6829.282925292773;6922.216613715799;6981.266966968598;7025.297470252934;7064.82337941535;6190.783322583688;6196.1635179252025;6321.589096708699;6332.430081292706;6338.556301059066;4869.561739443467;4871.537203965618;4908.263760435963;4928.063667903087;4996.925046124238;4823.6382271329085;4853.665242058462;4914.533119353656;4947.356843610308;4957.752112394293 08:33:42 INFO - PROCESS | 1637 | |4;prototype.html;349.655589244594;353.4186263596384;358.8385226648009;367.24347843442496;370.33894498320484;4692.419169456798;5125.384953805544;5160.819371322;5173.844784656457;5217.113090774577;4003.9980009995;4876.487968763282;4959.701798304123;5028.245763135532;5076.309555935361;3274.885379011723;4024.8993775155564;4040.2121586290687;4076.9388459173138;4091.034000349752;4035.1526179502193;4060.9847538115473;4064.9187016259657;4074.431343932578;4078.163976384834;3719.442083687455;4022.8189731462007;4023.517177938637;4023.5574086850424;4077.8368865245357;3549;3928.860630417176;4026.798660066985;4030.717849750519;4066.410370496291;3067.340521787826;3581.6776490116013;3584.5698516178227;3591.6587924147166;3620.8275034979065;4310.698251122422;4384.693071484998;4801.73590452525;4989.376327959005;4997.400831733847;3933.6853051755793;4173.561776013536;4608.308753686941;4619.353290539327;4674.878029272984;5238.266642670029;5409.026375252453;5448.318960129984;5449.6730196187955;5478.945210547923;3975.7735668026;3976.0457490202434;3994.960050399517;3998.6401223889698;4007.2786898358286;5242.79028838846;5418.539424148952;5425.538829199523;5655.858603534863;5695.971520142414;3207.566978457925;3652.634736526326;4061.756294622332;4066.1867626474823;4070.674346052309;4130.834766609302;4131.690123240709;4148.460700108966;4177.394277829698;4188.204241194163;4404.427424434867;4654.697444666153;4699.331737233233;4702.059588082398;4708.858734237979;4873.905070280398;5395.244665746799;5451.700156491352;5485.725713714299;5502.367227768777;1276.189619591566;1341.0746584856417;1356.7761319382191;1362.557168920105;1368.8015237790464;902.6028547439106;903.9909600904039;922.1101636920404;952.7237101240701;956.6173530587681;4091.529474110456;4118.9588104119175;4506.662000349987;4619.46876109245;4692.5218556154705;4834.6374021948495;5124.461931497139;5198.636095473356;5208.099043848968;5229.947700523022;4539.568740969603;4648.535146485325;4675.509071547506;4690.695104818176;4705.64707646921;2379.9052435879344;2396.3410062233024;2670.9065182718514;2723.7412445817617;2747.0385365122047;4464.933026004613;4540.137373898949;5022.547970682583;5044.369453818273;5364.570834333244;4492.303692927601;4803.471618122004;5192.792288308501;5347.807398966483;5384.91922621161;4303.170178541039;4725.8582242532775;5256.053910296107;5401.864953376197;5439.945600543944;4548.340490628774;4824.372831532019;5064.569511591409;5103.529599872122;5172.844814655567;4317.229935726337;4463.2147141143805;4562.452505699337;4932.901341973069;5136.717480538607;4973.651844370859;5201.531862132426;5210.785416198025;5369.060414427538;5382.640061550157;3495.423255162971;3809.7523660961947;3811.828467718904;3816.7137464690813;3858.942115868208;4073.2260870434525;4522.88692782683;4854.15542094002;5213.348331458567;5213.6350455467755;4222.704410691222;4453.599176074169;4979.477154898684;5043.344365232496;5068.884845334021;4270.850520231777;4553.408056952575;5040.731670748251;5098.031374038921;5171.767270472763;3997.7401468904427;4464;4853.95146048535;5059.772310246121;5303.761330740049;4677.368555244999;5041.6722913010535;5238.607104467256;5269.683818970874;5316.760745766527;4596.655250856266;5315.707636080053;5326.467353264643;5334;5340.317799893021 08:33:42 INFO - PROCESS | 1637 | |5;yui.html;711.978640640781;727.6107282603801;770.506875599616;795.8892321161203;804.6933840726207;13432.932835335834;13996.270727208173;14468.565943021713;15533.922330388346;15551;13147.079704420694;15201.543953681406;15319.463818766346;15768.84231157688;16353;798.4331124901313;875.1685898396516;877.7981064355203;878.9692360767342;881.497546398553;698.584342316321;719.4316489972915;877.5436772878099;880.6873559886244;883;882.4264228251624;909.1363204955286;914.4056363363834;915.4232833315002;915.5239275576729;896.7892545251893;901.1529162587148;902.0979020979054;903.7785742493065;904.8371293167228;674.1842370731421;675.5068799776191;677.0724107972061;678.5352033856775;678.9219239787438;14154.575362739135;14214.92892535541;14422.495212667507;14430.422783088663;14443.638909027359;13247.933760331136;13457.327133643279;13507.86492135076;13627.250501222428;13705.859758865445;12186.268823870596;12308.938455307756;12430.440630171574;12704;12939.935300323437;4305.22505948929;4325.480942286914;4337.783110844445;4507.909841803178;4515.209838278321;106030;107050;107207.46396267969;107923;109375;10419;10637.62768303121;10713.517891694892;10732.570697172181;10871.239013268996;18417.539561510803;20598.691019634716;21102.577948440947;21212.25757098494;21408.929553522572;7473.925260747432;7507.1366792818435;7523.623818809037;7546.1321947976685;7748.8450230996195;4146.688998325078;4168.416421700964;4203.831846726158;4210.400466272515;4257.382679511454;3311.6853898879567;3409.9659003410143;3414.931701365959;3415.7096646785303;3418.4701371287492;634.4892361648824;641.5733537197805;646.6572716460283;654.2443477783168;655.3806652713236;599.6372194822158;634.3117717276806;640.8077576726963;655.8524332025352;666.8566258254499;8131.9428474297965;9102.544872756336;9473.336866419284;9598.472084035446;9819.06234617315;600.8798240351947;610.2951091489336;657.9374959378852;660.5493618674675;668.518666560076;4553.59017688403;4632.745199014086;4640.767961601907;4658.650601204856;4715.552022557851;103783;106492;106920;108077.37883931748;109591;58930.70534647299;67605.66197168983;72057.63971180111;77989.61005194938;79466;72140.63929680423;73503.63248183831;73542.89685654719;74474;74576.25423745693;9761.511924403894;9840.212782977202;9846.45844478532;10168.745781355525;10509.737256568647;36883.89348319555;46801.53198468108;47835.760821197066;48287.275690863964;48926.77683057952;62658.68670656617;68850.65574672095;70363.29636703567;70918.74487530765;71109.28890711234;11773.470193841127;12550.497980080694;12980.870191297967;13022.348882555645;13250.80123798163;14440;14710.779338310149;14761.92619036898;14819.25903704832;15358.692826143639;11626.88373116258;13088.73822523525;13134.277614731282;13186.142900711808;13644.727105457636;13530.255835929118;13666.18002919828;13773.862261377659;14237.145771253758;14286;12650.936745316214;12771.169873958535;13113.934430328169;13462.663433414244;13471.932640336736;10332.380057196593;10699.679009629723;10745.731356715833;10887.23789334739;11281.266717663326;9282.607608858725;10146.594136234764;10181.796364072825;10202.234832387452;10202.540885660015 08:33:42 INFO - PROCESS | 1637 | __end_tp_report 08:33:42 INFO - PROCESS | 1637 | __start_cc_report 08:33:42 INFO - PROCESS | 1637 | _x_x_mozilla_cycle_collect,1686 08:33:42 INFO - PROCESS | 1637 | __end_cc_report 08:33:42 INFO - PROCESS | 1637 | __startTimestamp1484411622385__endTimestamp 08:33:42 INFO - PROCESS | 1637 | 08:33:42 INFO - PROCESS | 1637 | ------- Summary: start ------- 08:33:42 INFO - PROCESS | 1637 | Number of tests: 6 08:33:42 INFO - PROCESS | 1637 | 08:33:42 INFO - PROCESS | 1637 | [#0] dojo.html Cycles:165 Average:5718.32 Median:5910.11 stddev:656.56 (11.1%) stddev-sans-first:631.39 08:33:42 INFO - PROCESS | 1637 | Values: 3335.2 3338.5 3370.6 3371.3 3430.0 4404.8 5344.6 5636.6 5686.9 5697.4 5278.3 5591.4 5607.9 5624.6 5630.4 5094.4 5132.8 5147.3 5168.8 5233.4 5157.2 5239.7 5246.2 5246.8 5253.1 5241.8 5242.3 5243.5 5245.3 5248.0 5180.5 5209.9 5210.5 5248.9 5307.9 5115.9 5185.3 5198.2 5201.1 5271.4 5718.3 5768.2 5775.2 5780.2 5785.0 5165.5 5887.1 6226.3 6234.7 6269.4 6237.3 6308.5 6329.4 6341.6 6343.5 5815.6 5840.4 5848.0 5850.2 5883.6 6203.4 6270.5 6313.4 6341.0 6369.9 6021.9 6142.0 6146.5 6171.3 6173.0 6293.0 6293.8 6296.7 6305.8 6313.7 6047.3 6074.6 6221.2 6226.9 6233.3 6109.1 6137.5 6153.7 6188.8 6237.0 4859.0 4918.6 4937.4 4946.8 4968.3 4413.0 4443.4 4455.6 4465.1 4482.9 5656.3 5662.8 5663.7 5714.4 5771.1 6260.7 6306.2 6313.3 6321.8 6339.4 5543.4 5626.8 5643.2 5683.4 5710.1 4606.9 5453.1 5475.2 5487.1 5507.1 6292.6 6316.1 6318.9 6320.5 6346.3 6142.8 6142.9 6325.2 6326.7 6339.8 6263.1 6294.0 6313.5 6330.8 6338.7 6180.1 6222.9 6234.5 6249.3 6258.4 6261.3 6304.0 6306.7 6317.2 6327.6 5910.1 5948.2 6046.6 6049.5 6097.0 5862.1 6101.8 6103.2 6114.4 6116.9 5920.4 5940.0 5972.0 5982.2 5989.4 4829.9 5989.5 5997.7 6005.3 6053.0 5863.4 5882.1 5885.0 5910.1 5931.9 08:33:42 INFO - PROCESS | 1637 | 08:33:42 INFO - PROCESS | 1637 | [#1] ext.html Cycles:180 Average:71384.98 Median:22248.61 stddev:151910.08 (682.8%) stddev-sans-first:152242.81 08:33:42 INFO - PROCESS | 1637 | Values: 430.7 452.6 498.3 501.3 512.2 30966.5 41190.0 42898.1 43076.0 45446.1 43444.1 43836.8 43875.9 43922.6 43930.8 7880.7 9427.4 9429.6 9445.7 9453.3 8376.7 8597.2 11141.8 11380.7 11413.8 11252.8 11326.8 11358.4 11364.1 11370.2 6780.4 11354.8 11417.5 11419.7 11449.5 8474.1 10937.6 11246.4 11259.2 11398.6 41082.0 41240.4 41243.4 41382.0 41388.2 4008.3 4027.2 4056.6 4062.7 4194.0 30106.3 31011.1 31046.4 31270.2 31391.7 3230.2 3262.6 3297.7 3308.3 3368.7 485397.0 485489.0 486154.0 486907.0 488365.0 65126.0 65284.0 65547.3 65555.0 65631.0 67948.0 68136.7 68204.7 68248.7 68378.0 16299.1 16540.9 16545.4 16555.0 16568.5 11313.8 11626.1 12639.9 12702.0 12726.9 16515.3 17988.9 21493.7 21639.7 22047.4 7758.9 8064.0 8551.2 8641.0 8689.5 849.6 861.7 891.4 898.4 940.2 30038.5 30364.8 30666.8 31292.4 31546.2 1035.9 1081.2 1081.9 1122.5 1127.9 14205.1 15917.6 15994.7 16072.6 16304.1 648540.0 653375.0 653532.0 654482.0 655733.0 63069.7 63603.0 63706.4 63856.0 63925.0 1435.7 1443.0 1465.0 1482.7 1488.7 29715.0 30113.9 30396.2 30401.8 31000.8 54160.9 54455.5 54627.9 54704.7 54780.5 515144.0 564822.2 566897.0 567286.0 567584.0 36095.8 36837.8 43018.9 43068.5 43767.8 39694.8 47678.8 47736.3 50323.7 51631.5 40212.0 40430.0 40566.0 40696.2 41263.0 40165.0 40440.6 41243.4 41381.4 41449.2 37711.0 38307.8 38555.4 38762.2 39210.8 34142.0 34826.0 35414.5 35526.6 35635.5 25144.9 25168.1 25256.9 25591.7 25626.0 08:33:42 INFO - PROCESS | 1637 | 08:33:42 INFO - PROCESS | 1637 | [#2] jquery.html Cycles:180 Average:38367.70 Median:21799.13 stddev:116516.82 (534.5%) stddev-sans-first:116808.78 08:33:42 INFO - PROCESS | 1637 | Values: 390.5 392.2 396.6 397.1 424.1 14193.6 20008.3 20399.6 21338.7 21367.5 20738.8 20902.2 21117.8 21493.8 21731.2 4665.8 5640.4 5664.9 5745.0 5746.7 5525.6 5646.9 5759.4 5767.4 5779.2 5794.1 5796.4 5797.9 5804.1 5804.6 5593.7 5689.4 5768.6 5784.3 5876.1 5107.4 5137.4 5157.6 5182.6 5199.9 26105.3 26256.7 26308.6 26432.1 26620.9 2766.3 2790.0 2790.8 2797.4 2799.3 15053.8 15616.5 15712.3 15910.0 16248.3 1821.3 1838.0 1839.8 1855.4 1894.6 92503.0 125535.4 129261.4 129574.4 130105.3 9327.8 11178.8 11482.5 11524.3 11567.6 12851.9 13533.6 14423.3 14566.4 14572.5 7716.0 7802.2 7944.2 8365.5 8863.2 8549.3 8596.6 8608.7 8764.6 8765.7 6999.9 7112.6 7138.5 7143.5 7148.3 1872.0 1912.4 1915.7 1917.7 1918.8 886.3 1000.7 1049.7 1051.4 1090.4 18293.0 19147.1 21867.0 22520.5 22557.4 1039.2 1065.2 1075.9 1118.2 1124.9 11497.5 11662.8 11793.2 11805.3 11808.9 598716.0 711350.0 724465.0 724863.0 740714.0 120062.2 132696.3 134711.3 138563.0 141888.3 1031.8 1041.5 1052.0 1058.3 1065.3 18863.4 19491.9 19523.3 19527.1 19528.2 51078.7 51309.5 51972.5 53832.7 56295.0 77194.0 78434.0 79599.0 81438.0 86871.0 5891.5 7346.3 7424.6 7589.6 8342.1 8627.0 12912.5 12943.4 12955.7 13381.7 10659.4 10663.5 10989.3 11074.1 11168.7 11092.4 11124.7 11229.3 11398.7 11608.1 11294.7 11375.9 11408.0 11724.9 11772.6 6226.8 7372.1 7548.8 7607.1 7790.3 9036.3 9909.9 11040.6 11344.3 11371.2 08:33:42 INFO - PROCESS | 1637 | 08:33:42 INFO - PROCESS | 1637 | [#3] mootools.html Cycles:180 Average:5371.46 Median:5293.50 stddev:2955.31 (55.8%) stddev-sans-first:2947.50 08:33:42 INFO - PROCESS | 1637 | Values: 1266.6 1432.8 1454.7 1458.5 1463.7 8162.1 8558.9 8583.4 8589.5 8592.1 7149.6 7362.0 7699.9 8120.6 8311.3 2277.4 2281.0 2289.8 2313.9 2314.1 2305.4 2331.2 2335.3 2346.6 2380.9 2053.7 2125.4 2202.5 2295.8 2309.8 2290.7 2334.5 2337.8 2344.2 2346.6 2038.7 2309.9 2339.5 2373.2 2373.6 8305.0 8377.1 8378.9 8391.8 8394.5 4324.6 5056.3 5202.8 5219.6 5227.2 3284.3 3440.7 3441.7 3470.3 3490.3 1142.6 1185.9 1200.0 1233.5 1246.5 10609.9 10794.7 10875.9 10895.9 10904.2 4404.8 4575.3 4596.7 4640.8 4687.5 9426.6 9427.2 9428.5 9437.7 9439.7 5191.6 5191.7 5202.7 5204.7 5204.9 3909.8 4224.7 4333.1 4611.1 4774.1 3805.9 3869.8 3935.5 3940.8 3948.0 1264.9 1295.3 1295.9 1304.4 1308.0 665.6 748.7 783.6 791.4 818.9 5089.3 5359.8 5400.6 5448.6 5486.0 553.8 561.8 570.1 575.3 580.1 3611.6 3676.2 3703.4 3747.9 3861.4 8447.9 9912.5 9923.5 9946.1 9954.4 9718.7 9723.1 9851.4 9870.7 9889.3 7380.3 7683.3 7764.9 7777.5 7805.8 5430.2 5612.8 5634.2 5647.4 5732.8 8894.6 9006.4 9223.8 9281.6 9301.4 9079.0 9272.7 9427.4 9535.5 9554.9 6651.1 6863.0 6863.9 7096.8 7280.4 7608.2 7895.2 7898.2 7982.2 7992.8 7042.6 7116.5 7116.8 7175.3 7255.2 6829.3 6922.2 6981.3 7025.3 7064.8 6190.8 6196.2 6321.6 6332.4 6338.6 4869.6 4871.5 4908.3 4928.1 4996.9 4823.6 4853.7 4914.5 4947.4 4957.8 08:33:42 INFO - PROCESS | 1637 | 08:33:42 INFO - PROCESS | 1637 | [#4] prototype.html Cycles:180 Average:4263.21 Median:4651.62 stddev:1221.85 (26.3%) stddev-sans-first:1189.45 08:33:42 INFO - PROCESS | 1637 | Values: 349.7 353.4 358.8 367.2 370.3 4692.4 5125.4 5160.8 5173.8 5217.1 4004.0 4876.5 4959.7 5028.2 5076.3 3274.9 4024.9 4040.2 4076.9 4091.0 4035.2 4061.0 4064.9 4074.4 4078.2 3719.4 4022.8 4023.5 4023.6 4077.8 3549.0 3928.9 4026.8 4030.7 4066.4 3067.3 3581.7 3584.6 3591.7 3620.8 4310.7 4384.7 4801.7 4989.4 4997.4 3933.7 4173.6 4608.3 4619.4 4674.9 5238.3 5409.0 5448.3 5449.7 5478.9 3975.8 3976.0 3995.0 3998.6 4007.3 5242.8 5418.5 5425.5 5655.9 5696.0 3207.6 3652.6 4061.8 4066.2 4070.7 4130.8 4131.7 4148.5 4177.4 4188.2 4404.4 4654.7 4699.3 4702.1 4708.9 4873.9 5395.2 5451.7 5485.7 5502.4 1276.2 1341.1 1356.8 1362.6 1368.8 902.6 904.0 922.1 952.7 956.6 4091.5 4119.0 4506.7 4619.5 4692.5 4834.6 5124.5 5198.6 5208.1 5229.9 4539.6 4648.5 4675.5 4690.7 4705.6 2379.9 2396.3 2670.9 2723.7 2747.0 4464.9 4540.1 5022.5 5044.4 5364.6 4492.3 4803.5 5192.8 5347.8 5384.9 4303.2 4725.9 5256.1 5401.9 5439.9 4548.3 4824.4 5064.6 5103.5 5172.8 4317.2 4463.2 4562.5 4932.9 5136.7 4973.7 5201.5 5210.8 5369.1 5382.6 3495.4 3809.8 3811.8 3816.7 3858.9 4073.2 4522.9 4854.2 5213.3 5213.6 4222.7 4453.6 4979.5 5043.3 5068.9 4270.9 4553.4 5040.7 5098.0 5171.8 3997.7 4464.0 4854.0 5059.8 5303.8 4677.4 5041.7 5238.6 5269.7 5316.8 4596.7 5315.7 5326.5 5334.0 5340.3 08:33:42 INFO - PROCESS | 1637 | 08:33:42 INFO - PROCESS | 1637 | [#5] yui.html Cycles:180 Average:19826.43 Median:4233.89 stddev:28578.06 (675.0%) stddev-sans-first:28622.19 08:33:42 INFO - PROCESS | 1637 | Values: 712.0 727.6 770.5 795.9 804.7 13432.9 13996.3 14468.6 15533.9 15551.0 13147.1 15201.5 15319.5 15768.8 16353.0 798.4 875.2 877.8 879.0 881.5 698.6 719.4 877.5 880.7 883.0 882.4 909.1 914.4 915.4 915.5 896.8 901.2 902.1 903.8 904.8 674.2 675.5 677.1 678.5 678.9 14154.6 14214.9 14422.5 14430.4 14443.6 13247.9 13457.3 13507.9 13627.3 13705.9 12186.3 12308.9 12430.4 12704.0 12939.9 4305.2 4325.5 4337.8 4507.9 4515.2 106030.0 107050.0 107207.5 107923.0 109375.0 10419.0 10637.6 10713.5 10732.6 10871.2 18417.5 20598.7 21102.6 21212.3 21408.9 7473.9 7507.1 7523.6 7546.1 7748.8 4146.7 4168.4 4203.8 4210.4 4257.4 3311.7 3410.0 3414.9 3415.7 3418.5 634.5 641.6 646.7 654.2 655.4 599.6 634.3 640.8 655.9 666.9 8131.9 9102.5 9473.3 9598.5 9819.1 600.9 610.3 657.9 660.5 668.5 4553.6 4632.7 4640.8 4658.7 4715.6 103783.0 106492.0 106920.0 108077.4 109591.0 58930.7 67605.7 72057.6 77989.6 79466.0 72140.6 73503.6 73542.9 74474.0 74576.3 9761.5 9840.2 9846.5 10168.7 10509.7 36883.9 46801.5 47835.8 48287.3 48926.8 62658.7 68850.7 70363.3 70918.7 71109.3 11773.5 12550.5 12980.9 13022.3 13250.8 14440.0 14710.8 14761.9 14819.3 15358.7 11626.9 13088.7 13134.3 13186.1 13644.7 13530.3 13666.2 13773.9 14237.1 14286.0 12650.9 12771.2 13113.9 13462.7 13471.9 10332.4 10699.7 10745.7 10887.2 11281.3 9282.6 10146.6 10181.8 10202.2 10202.5 08:33:42 INFO - PROCESS | 1637 | -------- Summary: end -------- 08:33:42 INFO - PROCESS | 1637 | 08:33:43 INFO - TEST-INFO | 1637: exit 0 08:33:43 INFO - TEST-OK | dromaeo_css | took 1118109ms 08:33:43 INFO - TEST-START | kraken 08:33:43 INFO - operating with platform_type : mac_ 08:33:43 INFO - Initialising browser for kraken test... 08:33:43 INFO - TEST-INFO | started process 1648 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/tmpFm_1RY/profile http://localhost:49245/getInfo.html) 08:33:45 INFO - PROCESS | 1648 | __metrics Screen width/height:1600/1200 08:33:45 INFO - PROCESS | 1648 | colorDepth:24 08:33:45 INFO - PROCESS | 1648 | Browser inner width/height: 1024/689 08:33:45 INFO - PROCESS | 1648 | __metrics 08:33:45 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:33:45 INFO - PROCESS | 1648 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:33:46 INFO - TEST-INFO | 1648: exit 0 08:33:46 INFO - Browser initialized. 08:33:46 INFO - Running cycle 1/1 for kraken test... 08:33:46 INFO - TEST-INFO | started process 1649 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/tmpFm_1RY/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:33:58 INFO - PROCESS | 1649 | RSS: Main: 235413504 08:33:58 INFO - PROCESS | 1649 | 08:34:01 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49245/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49245/tests/kraken/driver.html?testName=audio-beat-detection) 08:34:02 INFO - PROCESS | 1649 | RSS: Main: 287412224 08:34:02 INFO - PROCESS | 1649 | 08:34:04 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49245/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49245/tests/kraken/driver.html?testName=audio-dft) 08:34:05 INFO - PROCESS | 1649 | RSS: Main: 286793728 08:34:05 INFO - PROCESS | 1649 | 08:34:08 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49245/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49245/tests/kraken/driver.html?testName=audio-fft) 08:34:09 INFO - PROCESS | 1649 | RSS: Main: 381865984 08:34:09 INFO - PROCESS | 1649 | 08:34:11 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49245/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49245/tests/kraken/driver.html?testName=audio-oscillator) 08:34:11 INFO - PROCESS | 1649 | RSS: Main: 282914816 08:34:11 INFO - PROCESS | 1649 | 08:34:14 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49245/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49245/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:34:14 INFO - PROCESS | 1649 | RSS: Main: 287440896 08:34:14 INFO - PROCESS | 1649 | 08:34:17 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49245/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49245/tests/kraken/driver.html?testName=imaging-darkroom) 08:34:18 INFO - PROCESS | 1649 | RSS: Main: 329674752 08:34:18 INFO - PROCESS | 1649 | 08:34:21 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49245/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49245/tests/kraken/driver.html?testName=imaging-desaturate) 08:34:21 INFO - PROCESS | 1649 | RSS: Main: 331251712 08:34:21 INFO - PROCESS | 1649 | 08:34:24 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49245/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49245/tests/kraken/driver.html?testName=json-parse-financial) 08:34:25 INFO - PROCESS | 1649 | RSS: Main: 328503296 08:34:25 INFO - PROCESS | 1649 | 08:34:26 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49245/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49245/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:34:27 INFO - PROCESS | 1649 | RSS: Main: 303857664 08:34:27 INFO - PROCESS | 1649 | 08:34:29 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49245/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49245/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:34:30 INFO - PROCESS | 1649 | RSS: Main: 307367936 08:34:30 INFO - PROCESS | 1649 | 08:34:32 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49245/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49245/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:34:32 INFO - PROCESS | 1649 | RSS: Main: 308768768 08:34:32 INFO - PROCESS | 1649 | 08:34:35 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49245/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49245/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:34:36 INFO - PROCESS | 1649 | RSS: Main: 325509120 08:34:36 INFO - PROCESS | 1649 | 08:34:39 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49245/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49245/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:34:40 INFO - PROCESS | 1649 | RSS: Main: 319725568 08:34:40 INFO - PROCESS | 1649 | 08:34:42 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49245/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49245/tests/kraken/driver.html?testName=ai-astar) 08:34:42 INFO - PROCESS | 1649 | RSS: Main: 364273664 08:34:42 INFO - PROCESS | 1649 | 08:34:42 INFO - PROCESS | 1649 | __start_tp_report 08:34:42 INFO - PROCESS | 1649 | _x_x_mozilla_page_load 08:34:42 INFO - PROCESS | 1649 | _x_x_mozilla_page_load_details 08:34:42 INFO - PROCESS | 1649 | |i|pagename|runs| 08:34:42 INFO - PROCESS | 1649 | |0;ai-astar;113;115;114;114;115;115;116;113;122;167 08:34:42 INFO - PROCESS | 1649 | |1;audio-beat-detection;142;111;109;148;114;111;111;111;130;112 08:34:42 INFO - PROCESS | 1649 | |2;audio-dft;184;184;182;182;183;182;182;182;180;182 08:34:42 INFO - PROCESS | 1649 | |3;audio-fft;79;59;58;87;59;61;75;80;94;60 08:34:42 INFO - PROCESS | 1649 | |4;audio-oscillator;86;71;83;68;63;69;68;88;91;111 08:34:42 INFO - PROCESS | 1649 | |5;imaging-gaussian-blur;87;83;86;90;134;71;118;128;96;86 08:34:42 INFO - PROCESS | 1649 | |6;imaging-darkroom;93;94;92;92;93;93;93;93;93;97 08:34:42 INFO - PROCESS | 1649 | |7;imaging-desaturate;86;85;84;86;87;85;85;86;85;84 08:34:42 INFO - PROCESS | 1649 | |8;json-parse-financial;56;53;43;42;76;81;82;80;82;63 08:34:42 INFO - PROCESS | 1649 | |9;json-stringify-tinderbox;65;67;74;74;78;72;71;71;72;70 08:34:42 INFO - PROCESS | 1649 | |10;stanford-crypto-aes;87;104;89;86;87;85;87;90;85;90 08:34:42 INFO - PROCESS | 1649 | |11;stanford-crypto-ccm;141;153;153;152;158;142;138;140;198;173 08:34:42 INFO - PROCESS | 1649 | |12;stanford-crypto-pbkdf2;173;172;173;171;173;171;167;167;171;174 08:34:42 INFO - PROCESS | 1649 | |13;stanford-crypto-sha256-iterative;67;68;66;67;66;66;67;68;71;80 08:34:42 INFO - PROCESS | 1649 | __end_tp_report 08:34:42 INFO - PROCESS | 1649 | __start_cc_report 08:34:42 INFO - PROCESS | 1649 | _x_x_mozilla_cycle_collect,1984 08:34:42 INFO - PROCESS | 1649 | __end_cc_report 08:34:42 INFO - PROCESS | 1649 | __startTimestamp1484411682298__endTimestamp 08:34:42 INFO - PROCESS | 1649 | 08:34:42 INFO - PROCESS | 1649 | ------- Summary: start ------- 08:34:42 INFO - PROCESS | 1649 | Number of tests: 14 08:34:42 INFO - PROCESS | 1649 | 08:34:42 INFO - PROCESS | 1649 | [#0] ai-astar Cycles:10 Average:120.40 Median:115.00 stddev:16.57 (14.4%) stddev-sans-first:17.36 08:34:42 INFO - PROCESS | 1649 | Values: 113.0 115.0 114.0 114.0 115.0 115.0 116.0 113.0 122.0 167.0 08:34:42 INFO - PROCESS | 1649 | 08:34:42 INFO - PROCESS | 1649 | [#1] audio-beat-detection Cycles:10 Average:119.90 Median:113.00 stddev:14.58 (12.9%) stddev-sans-first:13.09 08:34:42 INFO - PROCESS | 1649 | Values: 142.0 111.0 109.0 148.0 114.0 111.0 111.0 111.0 130.0 112.0 08:34:42 INFO - PROCESS | 1649 | 08:34:42 INFO - PROCESS | 1649 | [#2] audio-dft Cycles:10 Average:182.30 Median:182.00 stddev:1.16 (0.6%) stddev-sans-first:1.05 08:34:42 INFO - PROCESS | 1649 | Values: 184.0 184.0 182.0 182.0 183.0 182.0 182.0 182.0 180.0 182.0 08:34:42 INFO - PROCESS | 1649 | 08:34:42 INFO - PROCESS | 1649 | [#3] audio-fft Cycles:10 Average:71.20 Median:77.00 stddev:13.43 (17.4%) stddev-sans-first:13.95 08:34:42 INFO - PROCESS | 1649 | Values: 79.0 59.0 58.0 87.0 59.0 61.0 75.0 80.0 94.0 60.0 08:34:42 INFO - PROCESS | 1649 | 08:34:42 INFO - PROCESS | 1649 | [#4] audio-oscillator Cycles:10 Average:79.80 Median:77.00 stddev:14.79 (19.2%) stddev-sans-first:15.52 08:34:42 INFO - PROCESS | 1649 | Values: 86.0 71.0 83.0 68.0 63.0 69.0 68.0 88.0 91.0 111.0 08:34:42 INFO - PROCESS | 1649 | 08:34:42 INFO - PROCESS | 1649 | [#5] imaging-gaussian-blur Cycles:10 Average:97.90 Median:86.00 stddev:21.15 (24.6%) stddev-sans-first:22.06 08:34:42 INFO - PROCESS | 1649 | Values: 87.0 83.0 86.0 90.0 134.0 71.0 118.0 128.0 96.0 86.0 08:34:42 INFO - PROCESS | 1649 | 08:34:42 INFO - PROCESS | 1649 | [#6] imaging-darkroom Cycles:10 Average:93.30 Median:93.00 stddev:1.42 (1.5%) stddev-sans-first:1.50 08:34:42 INFO - PROCESS | 1649 | Values: 93.0 94.0 92.0 92.0 93.0 93.0 93.0 93.0 93.0 97.0 08:34:42 INFO - PROCESS | 1649 | 08:34:42 INFO - PROCESS | 1649 | [#7] imaging-desaturate Cycles:10 Average:85.30 Median:85.50 stddev:0.95 (1.1%) stddev-sans-first:0.97 08:34:42 INFO - PROCESS | 1649 | Values: 86.0 85.0 84.0 86.0 87.0 85.0 85.0 86.0 85.0 84.0 08:34:42 INFO - PROCESS | 1649 | 08:34:42 INFO - PROCESS | 1649 | [#8] json-parse-financial Cycles:10 Average:65.80 Median:78.00 stddev:16.38 (21.0%) stddev-sans-first:16.99 08:34:42 INFO - PROCESS | 1649 | Values: 56.0 53.0 43.0 42.0 76.0 81.0 82.0 80.0 82.0 63.0 08:34:42 INFO - PROCESS | 1649 | 08:34:42 INFO - PROCESS | 1649 | [#9] json-stringify-tinderbox Cycles:10 Average:71.40 Median:72.00 stddev:3.66 (5.1%) stddev-sans-first:3.06 08:34:42 INFO - PROCESS | 1649 | Values: 65.0 67.0 74.0 74.0 78.0 72.0 71.0 71.0 72.0 70.0 08:34:42 INFO - PROCESS | 1649 | 08:34:42 INFO - PROCESS | 1649 | [#10] stanford-crypto-aes Cycles:10 Average:89.00 Median:87.00 stddev:5.58 (6.4%) stddev-sans-first:5.87 08:34:42 INFO - PROCESS | 1649 | Values: 87.0 104.0 89.0 86.0 87.0 85.0 87.0 90.0 85.0 90.0 08:34:42 INFO - PROCESS | 1649 | 08:34:42 INFO - PROCESS | 1649 | [#11] stanford-crypto-ccm Cycles:10 Average:154.80 Median:153.00 stddev:18.49 (12.1%) stddev-sans-first:18.93 08:34:42 INFO - PROCESS | 1649 | Values: 141.0 153.0 153.0 152.0 158.0 142.0 138.0 140.0 198.0 173.0 08:34:42 INFO - PROCESS | 1649 | 08:34:42 INFO - PROCESS | 1649 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:171.20 Median:172.50 stddev:2.44 (1.4%) stddev-sans-first:2.50 08:34:42 INFO - PROCESS | 1649 | Values: 173.0 172.0 173.0 171.0 173.0 171.0 167.0 167.0 171.0 174.0 08:34:42 INFO - PROCESS | 1649 | 08:34:42 INFO - PROCESS | 1649 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.60 Median:67.50 stddev:4.27 (6.3%) stddev-sans-first:4.49 08:34:42 INFO - PROCESS | 1649 | Values: 67.0 68.0 66.0 67.0 66.0 66.0 67.0 68.0 71.0 80.0 08:34:42 INFO - PROCESS | 1649 | -------- Summary: end -------- 08:34:42 INFO - PROCESS | 1649 | 08:34:43 INFO - TEST-INFO | 1649: exit 0 08:34:43 INFO - TEST-OK | kraken | took 60151ms 08:34:43 INFO - SUITE-END | took 1178s 08:34:43 INFO - Completed test suite (00:19:38) 08:34:43 INFO - javascript benchmark 08:34:43 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3335.199552107494, 3338.482535207043, 3370.6460821613714, 3371.292028673978, 3429.988153494719, 4404.810701110699, 5344.625876188668, 5636.577256705743, 5686.886262274752, 5697.373288938214, 5278.313819203508, 5591.440855914407, 5607.887842243153, 5624.606277560572, 5630.352509461403, 5094.439611642726, 5132.8460146195675, 5147.305113809644, 5168.819091331804, 5233.398159211702, 5157.200633901752, 5239.738013099349, 5246.239295302179, 5246.816361427351, 5253.106971814782, 5241.842744717665, 5242.3184985951775, 5243.475652434745, 5245.291885595453, 5247.973760131194, 5180.507851754115, 5209.895802083956, 5210.452902445227, 5248.947510524884, 5307.867303317409, 5115.872103197413, 5185.274061631375, 5198.194279886624, 5201.115810312256, 5271.42014378418, 5718.34239062509, 5768.221290125821, 5775.249217601727, 5780.248567686216, 5784.971075144639, 5165.535101840815, 5887.116932460122, 6226.346233645492, 6234.688265586748, 6269.404406581368, 6237.313895471494, 6308.463780578656, 6329.430351268362, 6341.587796793194, 6343.492520598387, 5815.592908496407, 5840.3575606683235, 5848.0, 5850.151727999501, 5883.588148829584, 6203.410675985774, 6270.498360131179, 6313.368663133741, 6340.968295158587, 6369.936300636934, 6021.879562408727, 6141.990424691869, 6146.5390095743, 6171.259448866164, 6173.0, 6292.968535157295, 6293.842653933688, 6296.748130074838, 6305.842353941188, 6313.684315784192, 6047.2743270806905, 6074.635521868702, 6221.191245138193, 6226.875462490725, 6233.3143354231, 6109.101029780167, 6137.499563105042, 6153.692315384213, 6188.81433556994, 6236.970899801482, 4859.0, 4918.5819205367225, 4937.432195297587, 4946.802127914843, 4968.27959945813, 4412.977935110304, 4443.422355093817, 4455.598996090367, 4465.106978604292, 4482.8792801799555, 5656.2929633795775, 5662.8301150965535, 5663.66018038919, 5714.371419143891, 5771.134329850472, 6260.718267677966, 6306.180196574416, 6313.273973493016, 6321.841953951188, 6339.397757213057, 5543.445655434424, 5626.831195064155, 5643.181738647873, 5683.403242659544, 5710.086386178192, 4606.861794146181, 5453.100238460689, 5475.151351540518, 5487.149491828773, 5507.0637991541535, 6292.559520833681, 6316.052592111128, 6318.936810631927, 6320.5259605528845, 6346.333634968447, 6142.785002525069, 6142.867137759864, 6325.209348831396, 6326.6520341381665, 6339.809805705836, 6263.123162757127, 6294.024426213944, 6313.494920406449, 6330.841728956813, 6338.714757836001, 6180.103884936749, 6222.906656400248, 6234.532410069353, 6249.281332646622, 6258.374162583706, 6261.279952805486, 6303.9684801575695, 6306.65313407767, 6317.210348706411, 6327.588706734047, 5910.113482977587, 5948.167256583995, 6046.5767396281835, 6049.485793707408, 6096.993995990611, 5862.062070068769, 6101.786437474667, 6103.176071230505, 6114.38856114385, 6116.8776624468155, 5920.37836027211, 5939.990201665813, 5972.0, 5982.192404025401, 5989.401059893976, 4829.9275510868065, 5989.490893274121, 5997.670128142994, 6005.279366476051, 6053.031514957585, 5863.413658634103, 5882.088276317178, 5884.9705751470965, 5910.143029260647, 5931.851703707442], "value": 5676.806605559569, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [430.70711915897186, 452.58814478824274, 498.3421883114291, 501.28817079746756, 512.2111947600695, 30966.53550196749, 41190.0, 42898.14203715932, 43076.0, 45446.09107817842, 43444.090031897125, 43836.780816095874, 43875.90310242245, 43922.560774392245, 43930.780346098305, 7880.724174653874, 9427.387219830689, 9429.575669094907, 9445.716628501155, 9453.291003174754, 8376.706815261467, 8597.226249637532, 11141.832872506919, 11380.71548211293, 11413.828792568118, 11252.774944501105, 11326.773464530705, 11358.375289359083, 11364.147688923322, 11370.204085714004, 6780.423663988567, 11354.829677554802, 11417.54329826806, 11419.657410277705, 11449.542018319256, 8474.1187996081, 10937.56249750009, 11246.3814490203, 11259.155563332783, 11398.60104896333, 41082.0, 41240.38139427911, 41243.381349279785, 41382.0, 41388.1722365554, 4008.2584721826556, 4027.234825383197, 4056.6146216109423, 4062.6749860011128, 4193.97903010483, 30106.28500311139, 31011.06966791, 31046.379072418425, 31270.21824454384, 31391.686083139106, 3230.176305042199, 3262.6411094779555, 3297.7032067114073, 3308.3217940322174, 3368.6799754023327, 485397.0, 485489.0, 486154.0, 486907.0, 488365.0, 65126.0, 65284.0, 65547.34452655508, 65555.01667474992, 65631.01553476606, 67947.98078028833, 68136.6593167031, 68204.6589767048, 68248.6587567059, 68378.0, 16299.103549304902, 16540.917295413445, 16545.420910268323, 16555.0, 16568.502944911674, 11313.83029254562, 11626.128040397005, 12639.87360126387, 12702.047346449053, 12726.936365318299, 16515.33938642465, 17988.893022999357, 21493.67759483609, 21639.67540486894, 22047.44881377946, 7758.9137520747145, 8064.0, 8551.230389264996, 8641.049484556694, 8689.522076285739, 849.562475325208, 861.7199410191588, 891.4116682989196, 898.3980732908967, 940.1585580905052, 30038.549421758693, 30364.84817575898, 30666.846665766527, 31292.374152517277, 31546.211344716106, 1035.8705161854768, 1081.216118314216, 1081.853949716794, 1122.5004872831512, 1127.8984891359653, 14205.147691138565, 15917.602059948362, 15994.680106397807, 16072.602657846912, 16304.103274320027, 648540.0, 653375.0, 653532.0, 654482.0, 655733.0, 63069.68465157645, 63603.0, 63706.36293637097, 63856.0, 63925.0, 1435.7128574284975, 1442.9602817067603, 1465.0257578710252, 1482.7405204089457, 1488.7245859515808, 29715.0, 30113.94601188948, 30396.240093997825, 30401.847990759903, 31000.84499577578, 54160.916781663356, 54455.45544544504, 54627.907441851734, 54704.72647636737, 54780.45219547913, 515144.0, 564822.1660050615, 566897.0, 567286.0, 567584.0, 36095.81952090328, 36837.81581092077, 43018.92452688708, 43068.49260275875, 43767.78116109399, 39694.80152599219, 47678.80802979953, 47736.28395574, 50323.74838125933, 51631.48368516417, 40212.0, 40430.0, 40566.0, 40696.1860762789, 41263.0, 40165.0, 40440.59559404368, 41243.38134928038, 41381.37927931143, 41449.171016580105, 37711.0, 38307.80846095863, 38555.42166867443, 38762.224755505296, 39210.803945980086, 34142.0, 34825.95522134239, 35414.468782967764, 35526.64473355233, 35635.46546801852, 25144.874275628506, 25168.119115830857, 25256.873715631304, 25591.744082558936, 25626.0], "value": 20943.4820828852, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [390.5333126913339, 392.19012738694613, 396.60735871487225, 397.11047254150674, 424.0628211652248, 14193.574192774233, 20008.29970951017, 20399.592008159827, 21338.679919801198, 21367.465813354655, 20738.792612073874, 20902.163913443444, 21117.838518881454, 21493.775933609926, 21731.23940662077, 4665.766711664412, 5640.37955824861, 5664.858378540549, 5745.023346031185, 5746.683932383718, 5525.613207075507, 5646.858828529279, 5759.424057594228, 5767.365589785141, 5779.190913272145, 5794.130880367937, 5796.44933731297, 5797.913031304533, 5804.071348584227, 5804.622699524517, 5593.664380137185, 5689.374168841424, 5768.567357448187, 5784.2769653793275, 5876.089206173007, 5107.412647545542, 5137.434882162959, 5157.613179011551, 5182.637215394924, 5199.948000519984, 26105.347366315804, 26256.73743262562, 26308.60537091926, 26432.0748773792, 26620.866895665593, 2766.2531116598607, 2790.0, 2790.7906906981852, 2797.426527561845, 2799.2861820235707, 15053.849461505355, 15616.531504054896, 15712.29294681742, 15910.0453972762, 16248.268827902773, 1821.3352126473874, 1837.9982909314456, 1839.7700287464068, 1855.396995976313, 1894.6021335519558, 92503.0, 125535.37232313871, 129261.41477170498, 129574.3521282397, 130105.34947325298, 9327.766805829908, 11178.832317515244, 11482.48328825205, 11524.250923689933, 11567.595134170264, 12851.935740321425, 13533.578974207763, 14423.278836058365, 14566.41734330636, 14572.489962851461, 7716.035495563055, 7802.180771019075, 7944.165862584461, 8365.456245344034, 8863.202311791969, 8549.316054715608, 8596.613152408157, 8608.741737747878, 8764.56177191138, 8765.71285767837, 6999.930000699927, 7112.608806515691, 7138.535995160298, 7143.464240182007, 7148.28517148281, 1871.9719204211947, 1912.4358314297315, 1915.7222202780797, 1917.7027560728109, 1918.8177123173277, 886.2776836877924, 1000.7248006798188, 1049.732318258839, 1051.3534176481562, 1090.373035504588, 18293.02719488092, 19147.13837877299, 21867.015984280744, 22520.54958900813, 22557.43606409853, 1039.2465462539599, 1065.2170654568886, 1075.854759607443, 1118.2172479264548, 1124.8931351521592, 11497.482613282422, 11662.84517994228, 11793.233439826385, 11805.291682499077, 11808.88191118095, 598716.0, 711350.0, 724465.0, 724863.0, 740714.0, 120062.19906701407, 132696.3365183168, 134711.32644336912, 138563.0, 141888.29055854655, 1031.8194315994672, 1041.4740556019162, 1051.952662130206, 1058.2645061682058, 1065.280935368623, 18863.43409697711, 19491.902540487208, 19523.316683915993, 19527.12127954217, 19528.21887124499, 51078.744606276734, 51309.48690513047, 51972.48027519828, 53832.73083634557, 56295.0, 77194.0, 78434.0, 79599.0, 81438.0, 86871.0, 5891.528677705859, 7346.33882950537, 7424.554526728413, 7589.6205189739185, 8342.12407697183, 8626.956865215634, 12912.548060817826, 12943.417546210254, 12955.676108097374, 13381.732365352833, 10659.413732244491, 10663.520141593492, 10989.340639561333, 11074.058705009842, 11168.720781980515, 11092.389918554558, 11124.721881953015, 11229.3262404256, 11398.658040258806, 11608.071354291467, 11294.717632059264, 11375.886241137814, 11408.030317423112, 11724.88275117238, 11772.646820595395, 6226.844328891814, 7372.078490188726, 7548.8490230196185, 7607.12518060408, 7790.298873101448, 9036.2831062098, 9909.851352229867, 11040.613578524713, 11344.262622929484, 11371.204015719151], "value": 9910.940238766021, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1266.613682826738, 1432.8423873373927, 1454.665426951801, 1458.5259790568068, 1463.7438448271553, 8162.061362943264, 8558.871616925751, 8583.356248281381, 8589.527575983318, 8592.054873963874, 7149.571025738459, 7362.042934418531, 7699.884501732478, 8120.553369564672, 8311.293540049088, 2277.3737222263844, 2280.9885950570224, 2289.7710228977053, 2313.9421514462188, 2314.0628045641542, 2305.3660243433023, 2331.219041621059, 2335.2877372401413, 2346.5658853112145, 2380.8809559521956, 2053.691946208073, 2125.3836387447623, 2202.526456811785, 2295.7933785959262, 2309.803666688325, 2290.6678531612906, 2334.5447637710654, 2337.7662233776655, 2344.2498400511845, 2346.624540073597, 2038.6738121900573, 2309.93070207894, 2339.5320935812906, 2373.1931143411325, 2373.6439534069855, 8305.003399592028, 8377.120402357787, 8378.916210837875, 8391.790205244857, 8394.496330220207, 4324.567543245682, 5056.342675452204, 5202.843914682566, 5219.582433405357, 5227.242049902781, 3284.2774589590254, 3440.673136052071, 3441.6730410610953, 3470.288590838897, 3490.301939612062, 1142.5601143559707, 1185.887340702632, 1200.0, 1233.481937586216, 1246.5200897654377, 10609.9469502652, 10794.73013174669, 10875.891241087567, 10895.945520272428, 10904.182186335976, 4404.8458303959205, 4575.290829921368, 4596.655250856199, 4640.83757068501, 4687.484376718558, 9426.575804088832, 9427.245820334358, 9428.481433521221, 9437.716868493957, 9439.716808495756, 5191.5846732261325, 5191.740412979336, 5202.739863006835, 5204.71374074422, 5204.869878252998, 3909.7654140751647, 4224.66202703783, 4333.111712099012, 4611.054733779567, 4774.092922344744, 3805.8667946621736, 3869.8258578364043, 3935.4883865097927, 3940.802959851996, 3947.980260098681, 1264.8861602455822, 1295.3070107492447, 1295.9481620735064, 1304.419533307688, 1308.0385916351474, 665.5607299182516, 748.7267147491126, 783.561205724796, 791.3708601661692, 818.8976377952756, 5089.312942752681, 5359.758810853521, 5400.621956463088, 5448.56411487088, 5485.985092757853, 553.750812134533, 561.7809054468761, 570.0764761087065, 575.3211210771246, 580.054511146828, 3611.6207798180812, 3676.227992121631, 3703.4453898730517, 3747.9250414992093, 3861.4014827701753, 8447.873281900776, 9912.504374781232, 9923.454210018519, 9946.055124763281, 9954.352967057119, 9718.659846905466, 9723.124918757347, 9851.359661621971, 9870.654527091518, 9889.258305627107, 7380.298871607296, 7683.308502234826, 7764.883526747103, 7777.494462859896, 7805.765827025199, 5430.185472179205, 5612.803551875665, 5634.197056941739, 5647.407022262768, 5732.796112816355, 8894.555272236234, 9006.414583052081, 9223.76940576491, 9281.59569896769, 9301.395409298373, 9078.954605226932, 9272.675456358995, 9427.434353938786, 9535.47554884488, 9554.904450955402, 6651.135352404156, 6863.039174515472, 6863.897041544281, 7096.829023211112, 7280.381167600814, 7608.16310205888, 7895.210478952059, 7898.210178982055, 7982.1618730032515, 7992.800179995546, 7042.647867606497, 7116.46626503004, 7116.822079448055, 7175.31834475724, 7255.165655949633, 6829.282925292773, 6922.216613715799, 6981.266966968598, 7025.297470252934, 7064.82337941535, 6190.783322583688, 6196.1635179252025, 6321.589096708699, 6332.430081292706, 6338.556301059066, 4869.561739443467, 4871.537203965618, 4908.263760435963, 4928.063667903087, 4996.925046124238, 4823.6382271329085, 4853.665242058462, 4914.533119353656, 4947.356843610308, 4957.752112394293], "value": 4306.176311369665, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [349.655589244594, 353.4186263596384, 358.8385226648009, 367.24347843442496, 370.33894498320484, 4692.419169456798, 5125.384953805544, 5160.819371322, 5173.844784656457, 5217.113090774577, 4003.9980009995, 4876.487968763282, 4959.701798304123, 5028.245763135532, 5076.309555935361, 3274.885379011723, 4024.8993775155564, 4040.2121586290687, 4076.9388459173138, 4091.034000349752, 4035.1526179502193, 4060.9847538115473, 4064.9187016259657, 4074.431343932578, 4078.163976384834, 3719.442083687455, 4022.8189731462007, 4023.517177938637, 4023.5574086850424, 4077.8368865245357, 3549.0, 3928.860630417176, 4026.798660066985, 4030.717849750519, 4066.410370496291, 3067.340521787826, 3581.6776490116013, 3584.5698516178227, 3591.6587924147166, 3620.8275034979065, 4310.698251122422, 4384.693071484998, 4801.73590452525, 4989.376327959005, 4997.400831733847, 3933.6853051755793, 4173.561776013536, 4608.308753686941, 4619.353290539327, 4674.878029272984, 5238.266642670029, 5409.026375252453, 5448.318960129984, 5449.6730196187955, 5478.945210547923, 3975.7735668026, 3976.0457490202434, 3994.960050399517, 3998.6401223889698, 4007.2786898358286, 5242.79028838846, 5418.539424148952, 5425.538829199523, 5655.858603534863, 5695.971520142414, 3207.566978457925, 3652.634736526326, 4061.756294622332, 4066.1867626474823, 4070.674346052309, 4130.834766609302, 4131.690123240709, 4148.460700108966, 4177.394277829698, 4188.204241194163, 4404.427424434867, 4654.697444666153, 4699.331737233233, 4702.059588082398, 4708.858734237979, 4873.905070280398, 5395.244665746799, 5451.700156491352, 5485.725713714299, 5502.367227768777, 1276.189619591566, 1341.0746584856417, 1356.7761319382191, 1362.557168920105, 1368.8015237790464, 902.6028547439106, 903.9909600904039, 922.1101636920404, 952.7237101240701, 956.6173530587681, 4091.529474110456, 4118.9588104119175, 4506.662000349987, 4619.46876109245, 4692.5218556154705, 4834.6374021948495, 5124.461931497139, 5198.636095473356, 5208.099043848968, 5229.947700523022, 4539.568740969603, 4648.535146485325, 4675.509071547506, 4690.695104818176, 4705.64707646921, 2379.9052435879344, 2396.3410062233024, 2670.9065182718514, 2723.7412445817617, 2747.0385365122047, 4464.933026004613, 4540.137373898949, 5022.547970682583, 5044.369453818273, 5364.570834333244, 4492.303692927601, 4803.471618122004, 5192.792288308501, 5347.807398966483, 5384.91922621161, 4303.170178541039, 4725.8582242532775, 5256.053910296107, 5401.864953376197, 5439.945600543944, 4548.340490628774, 4824.372831532019, 5064.569511591409, 5103.529599872122, 5172.844814655567, 4317.229935726337, 4463.2147141143805, 4562.452505699337, 4932.901341973069, 5136.717480538607, 4973.651844370859, 5201.531862132426, 5210.785416198025, 5369.060414427538, 5382.640061550157, 3495.423255162971, 3809.7523660961947, 3811.828467718904, 3816.7137464690813, 3858.942115868208, 4073.2260870434525, 4522.88692782683, 4854.15542094002, 5213.348331458567, 5213.6350455467755, 4222.704410691222, 4453.599176074169, 4979.477154898684, 5043.344365232496, 5068.884845334021, 4270.850520231777, 4553.408056952575, 5040.731670748251, 5098.031374038921, 5171.767270472763, 3997.7401468904427, 4464.0, 4853.95146048535, 5059.772310246121, 5303.761330740049, 4677.368555244999, 5041.6722913010535, 5238.607104467256, 5269.683818970874, 5316.760745766527, 4596.655250856266, 5315.707636080053, 5326.467353264643, 5334.0, 5340.317799893021], "value": 3899.654275846236, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [711.978640640781, 727.6107282603801, 770.506875599616, 795.8892321161203, 804.6933840726207, 13432.932835335834, 13996.270727208173, 14468.565943021713, 15533.922330388346, 15551.0, 13147.079704420694, 15201.543953681406, 15319.463818766346, 15768.84231157688, 16353.0, 798.4331124901313, 875.1685898396516, 877.7981064355203, 878.9692360767342, 881.497546398553, 698.584342316321, 719.4316489972915, 877.5436772878099, 880.6873559886244, 883.0, 882.4264228251624, 909.1363204955286, 914.4056363363834, 915.4232833315002, 915.5239275576729, 896.7892545251893, 901.1529162587148, 902.0979020979054, 903.7785742493065, 904.8371293167228, 674.1842370731421, 675.5068799776191, 677.0724107972061, 678.5352033856775, 678.9219239787438, 14154.575362739135, 14214.92892535541, 14422.495212667507, 14430.422783088663, 14443.638909027359, 13247.933760331136, 13457.327133643279, 13507.86492135076, 13627.250501222428, 13705.859758865445, 12186.268823870596, 12308.938455307756, 12430.440630171574, 12704.0, 12939.935300323437, 4305.22505948929, 4325.480942286914, 4337.783110844445, 4507.909841803178, 4515.209838278321, 106030.0, 107050.0, 107207.46396267969, 107923.0, 109375.0, 10419.0, 10637.62768303121, 10713.517891694892, 10732.570697172181, 10871.239013268996, 18417.539561510803, 20598.691019634716, 21102.577948440947, 21212.25757098494, 21408.929553522572, 7473.925260747432, 7507.1366792818435, 7523.623818809037, 7546.1321947976685, 7748.8450230996195, 4146.688998325078, 4168.416421700964, 4203.831846726158, 4210.400466272515, 4257.382679511454, 3311.6853898879567, 3409.9659003410143, 3414.931701365959, 3415.7096646785303, 3418.4701371287492, 634.4892361648824, 641.5733537197805, 646.6572716460283, 654.2443477783168, 655.3806652713236, 599.6372194822158, 634.3117717276806, 640.8077576726963, 655.8524332025352, 666.8566258254499, 8131.9428474297965, 9102.544872756336, 9473.336866419284, 9598.472084035446, 9819.06234617315, 600.8798240351947, 610.2951091489336, 657.9374959378852, 660.5493618674675, 668.518666560076, 4553.59017688403, 4632.745199014086, 4640.767961601907, 4658.650601204856, 4715.552022557851, 103783.0, 106492.0, 106920.0, 108077.37883931748, 109591.0, 58930.70534647299, 67605.66197168983, 72057.63971180111, 77989.61005194938, 79466.0, 72140.63929680423, 73503.63248183831, 73542.89685654719, 74474.0, 74576.25423745693, 9761.511924403894, 9840.212782977202, 9846.45844478532, 10168.745781355525, 10509.737256568647, 36883.89348319555, 46801.53198468108, 47835.760821197066, 48287.275690863964, 48926.77683057952, 62658.68670656617, 68850.65574672095, 70363.29636703567, 70918.74487530765, 71109.28890711234, 11773.470193841127, 12550.497980080694, 12980.870191297967, 13022.348882555645, 13250.80123798163, 14440.0, 14710.779338310149, 14761.92619036898, 14819.25903704832, 15358.692826143639, 11626.88373116258, 13088.73822523525, 13134.277614731282, 13186.142900711808, 13644.727105457636, 13530.255835929118, 13666.18002919828, 13773.862261377659, 14237.145771253758, 14286.0, 12650.936745316214, 12771.169873958535, 13113.934430328169, 13462.663433414244, 13471.932640336736, 10332.380057196593, 10699.679009629723, 10745.731356715833, 10887.23789334739, 11281.266717663326, 9282.607608858725, 10146.594136234764, 10181.796364072825, 10202.234832387452, 10202.540885660015], "value": 7372.41952997059, "unit": "score"}], "name": "dromaeo_css", "value": 7255.62462772109, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 115.0, 114.0, 114.0, 115.0, 115.0, 116.0, 113.0, 122.0, 167.0], "value": 120.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 111.0, 109.0, 148.0, 114.0, 111.0, 111.0, 111.0, 130.0, 112.0], "value": 119.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [184.0, 184.0, 182.0, 182.0, 183.0, 182.0, 182.0, 182.0, 180.0, 182.0], "value": 182.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 59.0, 58.0, 87.0, 59.0, 61.0, 75.0, 80.0, 94.0, 60.0], "value": 71.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 71.0, 83.0, 68.0, 63.0, 69.0, 68.0, 88.0, 91.0, 111.0], "value": 79.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 83.0, 86.0, 90.0, 134.0, 71.0, 118.0, 128.0, 96.0, 86.0], "value": 97.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 94.0, 92.0, 92.0, 93.0, 93.0, 93.0, 93.0, 93.0, 97.0], "value": 93.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 85.0, 84.0, 86.0, 87.0, 85.0, 85.0, 86.0, 85.0, 84.0], "value": 85.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 53.0, 43.0, 42.0, 76.0, 81.0, 82.0, 80.0, 82.0, 63.0], "value": 65.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 67.0, 74.0, 74.0, 78.0, 72.0, 71.0, 71.0, 72.0, 70.0], "value": 71.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 104.0, 89.0, 86.0, 87.0, 85.0, 87.0, 90.0, 85.0, 90.0], "value": 89.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 153.0, 153.0, 152.0, 158.0, 142.0, 138.0, 140.0, 198.0, 173.0], "value": 154.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [173.0, 172.0, 173.0, 171.0, 173.0, 171.0, 167.0, 167.0, 171.0, 174.0], "value": 171.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 68.0, 66.0, 67.0, 66.0, 66.0, 67.0, 68.0, 71.0, 80.0], "value": 68.6, "unit": "score"}], "name": "kraken", "value": 1470.8999999999996, "alertThreshold": 2.0}]} 08:34:43 INFO - Return code: 0 08:34:43 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 08:34:43 ERROR - # TBPL SUCCESS # 08:34:43 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 08:34:43 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 08:34:43 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 08:34:43 INFO - 2017-01-14 08:34:43.608 screenresolution[1653:10393] starting screenresolution argv=screenresolution get 08:34:43 INFO - 2017-01-14 08:34:43.611 screenresolution[1653:10393] Display 0: 1600x1200x32@60 08:34:43 INFO - 2017-01-14 08:34:43.617 screenresolution[1654:10396] starting screenresolution argv=screenresolution list 08:34:43 INFO - Available Modes on Display 0 08:34:43 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 08:34:43 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 08:34:43 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 08:34:43 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 08:34:43 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 08:34:43 INFO - Intel Iris: 08:34:43 INFO - Chipset Model: Intel Iris 08:34:43 INFO - Type: GPU 08:34:43 INFO - Bus: Built-In 08:34:43 INFO - VRAM (Dynamic, Max): 1536 MB 08:34:43 INFO - Vendor: Intel (0x8086) 08:34:43 INFO - Device ID: 0x0a2e 08:34:43 INFO - Revision ID: 0x0009 08:34:43 INFO - Displays: 08:34:43 INFO - Display: 08:34:43 INFO - Resolution: 1600 x 1200 @ 60 Hz 08:34:43 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 08:34:43 INFO - Display Serial Number: 1600x1200 60 08:34:43 INFO - Main Display: Yes 08:34:43 INFO - Mirror: Off 08:34:43 INFO - Online: Yes 08:34:43 INFO - Rotation: Supported 08:34:43 INFO - Return code: 0 08:34:43 INFO - Running post-action listener: _resource_record_post_action 08:34:43 INFO - [mozharness: 2017-01-14 16:34:43.853740Z] Finished run-tests step (success) 08:34:43 INFO - Running post-run listener: _resource_record_post_run 08:34:43 INFO - Total resource usage - Wall time: 1201s; CPU: 54.0%; Read bytes: 38982656; Write bytes: 553545728; Read time: 386; Write time: 2080 08:34:43 INFO - TinderboxPrint: CPU usage
53.9% 08:34:43 INFO - TinderboxPrint: I/O read bytes / time
38,982,656 / 386 08:34:43 INFO - TinderboxPrint: I/O write bytes / time
553,545,728 / 2,080 08:34:43 INFO - TinderboxPrint: CPU idle
2,214.7 (46.1%) 08:34:43 INFO - TinderboxPrint: CPU system
960.8 (20.0%) 08:34:43 INFO - TinderboxPrint: CPU user
1,630.2 (33.9%) 08:34:43 INFO - TinderboxPrint: Swap in / out
289,914,880 / 0 08:34:43 INFO - install - Wall time: 22s; CPU: 54.0%; Read bytes: 252561920; Write bytes: 254728192; Read time: 18099; Write time: 512 08:34:43 INFO - run-tests - Wall time: 1180s; CPU: 54.0%; Read bytes: 34505728; Write bytes: 297224192; Read time: 349; Write time: 1562 08:34:44 INFO - Running post-run listener: _upload_blobber_files 08:34:44 INFO - Blob upload gear active. 08:34:44 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:34:44 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:34:44 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:34:44 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:34:44 INFO - (blobuploader) - INFO - Open directory for files ... 08:34:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 08:34:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:34:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:34:46 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 08:34:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:34:46 INFO - (blobuploader) - INFO - Done attempting. 08:34:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 08:34:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:34:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:34:47 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 08:34:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:34:47 INFO - (blobuploader) - INFO - Done attempting. 08:34:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 08:34:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:34:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:34:48 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 08:34:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:34:48 INFO - (blobuploader) - INFO - Done attempting. 08:34:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 08:34:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:34:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:34:50 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 08:34:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:34:50 INFO - (blobuploader) - INFO - Done attempting. 08:34:50 INFO - (blobuploader) - INFO - Iteration through files over. 08:34:50 INFO - Return code: 0 08:34:50 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:34:50 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:34:50 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/eee5cdf784fb19d924a1136aa38576d25cfc6dca0252decbb4969ddf2ee8b5830e37bcff5d1a17da6076c34686dfa3f0c935306cb934945f91e6ae86a57f7247", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9be3f1eab2d47aa49fa695130d94ce2e3c28122069023b26c3289a3e00d70d0a15debf5343cecf2be579321ef534bcd3bfa008b04cf9f5f550ee75bdd8d3dd72", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2a5d4f90074c6d0d652740a64b2b726e8c170f479240e2da7475ec8974b42f77b3f56594861f424c85b3b2778cacf3e1e1f46df818dd4a94d7bc073b1e8de811", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/84e90fe1ceffbb768d984048a6c916a550a4482fb4c69efcfdc13b7ac23ae99d462234467f97b6e3d4a381040a771657877a2645cf425cdf9c9fcbeefe44186b"} 08:34:50 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:34:50 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:34:50 INFO - Contents: 08:34:50 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/eee5cdf784fb19d924a1136aa38576d25cfc6dca0252decbb4969ddf2ee8b5830e37bcff5d1a17da6076c34686dfa3f0c935306cb934945f91e6ae86a57f7247", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9be3f1eab2d47aa49fa695130d94ce2e3c28122069023b26c3289a3e00d70d0a15debf5343cecf2be579321ef534bcd3bfa008b04cf9f5f550ee75bdd8d3dd72", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2a5d4f90074c6d0d652740a64b2b726e8c170f479240e2da7475ec8974b42f77b3f56594861f424c85b3b2778cacf3e1e1f46df818dd4a94d7bc073b1e8de811", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/84e90fe1ceffbb768d984048a6c916a550a4482fb4c69efcfdc13b7ac23ae99d462234467f97b6e3d4a381040a771657877a2645cf425cdf9c9fcbeefe44186b"} 08:34:50 INFO - Running post-run listener: copy_logs_to_upload_dir 08:34:50 INFO - Copying logs to upload dir... 08:34:50 INFO - mkdir: /builds/slave/test/build/upload/logs 08:34:50 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1263.712847 ========= master_lag: 0.10 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 3 secs) (at 2017-01-14 08:34:50.838126) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-14 08:34:50.841228) ========= 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.bXH5Kk85qy/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.DdPUgVyPmh/Listeners TMPDIR=/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/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/eee5cdf784fb19d924a1136aa38576d25cfc6dca0252decbb4969ddf2ee8b5830e37bcff5d1a17da6076c34686dfa3f0c935306cb934945f91e6ae86a57f7247", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9be3f1eab2d47aa49fa695130d94ce2e3c28122069023b26c3289a3e00d70d0a15debf5343cecf2be579321ef534bcd3bfa008b04cf9f5f550ee75bdd8d3dd72", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2a5d4f90074c6d0d652740a64b2b726e8c170f479240e2da7475ec8974b42f77b3f56594861f424c85b3b2778cacf3e1e1f46df818dd4a94d7bc073b1e8de811", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/84e90fe1ceffbb768d984048a6c916a550a4482fb4c69efcfdc13b7ac23ae99d462234467f97b6e3d4a381040a771657877a2645cf425cdf9c9fcbeefe44186b"} build_url:https://queue.taskcluster.net/v1/task/aoj3LXIwTpKG5l8ADfZGdg/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011180 build_url: 'https://queue.taskcluster.net/v1/task/aoj3LXIwTpKG5l8ADfZGdg/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/eee5cdf784fb19d924a1136aa38576d25cfc6dca0252decbb4969ddf2ee8b5830e37bcff5d1a17da6076c34686dfa3f0c935306cb934945f91e6ae86a57f7247", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9be3f1eab2d47aa49fa695130d94ce2e3c28122069023b26c3289a3e00d70d0a15debf5343cecf2be579321ef534bcd3bfa008b04cf9f5f550ee75bdd8d3dd72", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2a5d4f90074c6d0d652740a64b2b726e8c170f479240e2da7475ec8974b42f77b3f56594861f424c85b3b2778cacf3e1e1f46df818dd4a94d7bc073b1e8de811", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/84e90fe1ceffbb768d984048a6c916a550a4482fb4c69efcfdc13b7ac23ae99d462234467f97b6e3d4a381040a771657877a2645cf425cdf9c9fcbeefe44186b"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-14 08:34:50.877414) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-14 08:34:50.877855) ========= 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.bXH5Kk85qy/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.DdPUgVyPmh/Listeners TMPDIR=/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/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.005382 ========= master_lag: 0.28 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-14 08:34:51.164265) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-14 08:34:51.164656) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-14 08:34:51.165136) ========= ========= Total master_lag: 3.20 =========