builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0327 starttime: 1481128429.57 results: success (0) buildid: 20161207062738 builduid: 865d439b197647eeb575deaeee89acc3 revision: c2526f6786f074888d71c8e166a02aea3e19e75b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-12-07 08:33:49.571441) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-12-07 08:33:49.572092) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-07 08:33:49.572465) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-07 08:33:49.599007) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-07 08:33:49.599312) ========= 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.8QzykyWzVk/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.N1jdOs0C78/Listeners TMPDIR=/var/folders/1b/b370xjvx7_vbkyyr8hgyjzcm00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-12-07 08:33:49-- 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% 164M=0s 2016-12-07 08:33:49 (164 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.135877 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-07 08:33:49.760886) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-07 08:33:49.761285) ========= 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.8QzykyWzVk/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.N1jdOs0C78/Listeners TMPDIR=/var/folders/1b/b370xjvx7_vbkyyr8hgyjzcm00000w/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.024802 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-07 08:33:49.810893) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-07 08:33:49.811308) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev c2526f6786f074888d71c8e166a02aea3e19e75b --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 c2526f6786f074888d71c8e166a02aea3e19e75b --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.8QzykyWzVk/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.N1jdOs0C78/Listeners TMPDIR=/var/folders/1b/b370xjvx7_vbkyyr8hgyjzcm00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-12-07 08:33:49,909 truncating revision to first 12 chars 2016-12-07 08:33:49,910 Setting DEBUG logging. 2016-12-07 08:33:49,910 attempt 1/10 2016-12-07 08:33:49,910 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/c2526f6786f0?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-12-07 08:33:50,420 unpacking tar archive at: mozilla-central-c2526f6786f0/testing/mozharness/ program finished with exit code 0 elapsedTime=0.792686 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-07 08:33:50.629726) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-07 08:33:50.630036) ========= script_repo_revision: c2526f6786f074888d71c8e166a02aea3e19e75b ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-07 08:33:50.630470) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-07 08:33:50.630834) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-07 08:33:50.724090) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 18 secs) (at 2016-12-07 08:33:50.724437) ========= /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.8QzykyWzVk/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.N1jdOs0C78/Listeners TMPDIR=/var/folders/1b/b370xjvx7_vbkyyr8hgyjzcm00000w/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:33:50 INFO - MultiFileLogger online at 20161207 08:33:50 in /builds/slave/test 08:33:50 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:33:50 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:33:50 INFO - {'append_to_log': False, 08:33:50 INFO - 'base_work_dir': '/builds/slave/test', 08:33:50 INFO - 'blob_upload_branch': 'Firefox', 08:33:50 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:33:50 INFO - 'branch': 'Firefox', 08:33:50 INFO - 'buildbot_json_path': 'buildprops.json', 08:33:50 INFO - 'config_files': ('talos/mac_config.py',), 08:33:50 INFO - 'default_actions': ('clobber', 08:33:50 INFO - 'read-buildbot-config', 08:33:50 INFO - 'download-and-extract', 08:33:50 INFO - 'populate-webroot', 08:33:50 INFO - 'create-virtualenv', 08:33:50 INFO - 'install', 08:33:50 INFO - 'run-tests'), 08:33:50 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:33:50 INFO - 'download_minidump_stackwalk': True, 08:33:50 INFO - 'download_symbols': 'ondemand', 08:33:50 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:33:50 INFO - 'tooltool.py': '/tools/tooltool.py', 08:33:50 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:33:50 INFO - '/tools/misc-python/virtualenv.py')}, 08:33:50 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:33:50 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:33:50 INFO - 'installer_path': 'installer.exe', 08:33:50 INFO - 'log_level': 'info', 08:33:50 INFO - 'log_name': 'talos', 08:33:50 INFO - 'log_to_console': True, 08:33:50 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 08:33:50 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 08:33:50 INFO - 'opt_config_files': (), 08:33:50 INFO - 'pip_index': False, 08:33:50 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 08:33:50 INFO - 'cmd': ('bash', 08:33:50 INFO - '-c', 08:33:50 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 08:33:50 INFO - 'enabled': True, 08:33:50 INFO - 'halt_on_failure': False, 08:33:50 INFO - 'name': 'check_screen_resolution'},), 08:33:50 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 08:33:50 INFO - 'cmd': ('bash', 08:33:50 INFO - '-c', 08:33:50 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 08:33:50 INFO - 'enabled': True, 08:33:50 INFO - 'halt_on_failure': False, 08:33:50 INFO - 'name': 'check_screen_resolution'},), 08:33:50 INFO - 'run_cmd_checks_enabled': True, 08:33:50 INFO - 'sps_profile': False, 08:33:50 INFO - 'sps_profile_interval': 0, 08:33:50 INFO - 'suite': 'dromaeojs', 08:33:50 INFO - 'system_bits': '32', 08:33:50 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:33:50 INFO - 'title': 't-yosemite-r7-0327', 08:33:50 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:33:50 INFO - 'use_talos_json': True, 08:33:50 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:33:50 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:33:50 INFO - 'work_dir': 'build'} 08:33:50 INFO - [mozharness: 2016-12-07 16:33:50.927563Z] Running clobber step. 08:33:50 INFO - Running pre-action listener: _resource_record_pre_action 08:33:50 INFO - Running main action method: clobber 08:33:50 INFO - rmtree: /builds/slave/test/build 08:33:50 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:33:53 INFO - Running post-action listener: _resource_record_post_action 08:33:53 INFO - [mozharness: 2016-12-07 16:33:53.176321Z] Finished clobber step (success) 08:33:53 INFO - [mozharness: 2016-12-07 16:33:53.176505Z] Running read-buildbot-config step. 08:33:53 INFO - Running pre-action listener: _resource_record_pre_action 08:33:53 INFO - Running main action method: read_buildbot_config 08:33:53 INFO - Using buildbot properties: 08:33:53 INFO - { 08:33:53 INFO - "project": "", 08:33:53 INFO - "product": "firefox", 08:33:53 INFO - "script_repo_revision": "production", 08:33:53 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 08:33:53 INFO - "repository": "", 08:33:53 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 08:33:53 INFO - "buildid": "20161207062738", 08:33:53 INFO - "pgo_build": "False", 08:33:53 INFO - "basedir": "/builds/slave/test", 08:33:53 INFO - "buildnumber": 28, 08:33:53 INFO - "slavename": "t-yosemite-r7-0327", 08:33:53 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 08:33:53 INFO - "platform": "yosemite_r7", 08:33:53 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 08:33:53 INFO - "branch": "mozilla-central", 08:33:53 INFO - "repo_path": "mozilla-central", 08:33:53 INFO - "revision": "c2526f6786f074888d71c8e166a02aea3e19e75b", 08:33:53 INFO - "stage_platform": "macosx64", 08:33:53 INFO - "builduid": "865d439b197647eeb575deaeee89acc3", 08:33:53 INFO - "slavebuilddir": "test" 08:33:53 INFO - } 08:33:53 INFO - Found installer url https://queue.taskcluster.net/v1/task/JQfZGfM2SzeXKIQuHLz8NA/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg. 08:33:53 INFO - Running post-action listener: _resource_record_post_action 08:33:53 INFO - [mozharness: 2016-12-07 16:33:53.180187Z] Finished read-buildbot-config step (success) 08:33:53 INFO - [mozharness: 2016-12-07 16:33:53.180298Z] Running download-and-extract step. 08:33:53 INFO - Running pre-action listener: _resource_record_pre_action 08:33:53 INFO - Running main action method: download_and_extract 08:33:53 INFO - mkdir: /builds/slave/test/build/tests 08:33:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:33:53 INFO - trying https://queue.taskcluster.net/v1/task/JQfZGfM2SzeXKIQuHLz8NA/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json 08:33:53 INFO - Downloading https://queue.taskcluster.net/v1/task/JQfZGfM2SzeXKIQuHLz8NA/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:33:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/JQfZGfM2SzeXKIQuHLz8NA/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:33:54 INFO - Downloaded 1199 bytes. 08:33:54 INFO - Reading from file /builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json 08:33:54 INFO - Using the following test package requirements: 08:33:54 INFO - {u'common': [u'firefox-53.0a1.en-US.mac.common.tests.zip'], 08:33:54 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 08:33:54 INFO - u'firefox-53.0a1.en-US.mac.cppunittest.tests.zip'], 08:33:54 INFO - u'gtest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 08:33:54 INFO - u'firefox-53.0a1.en-US.mac.gtest.tests.zip'], 08:33:54 INFO - u'jittest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 08:33:54 INFO - u'jsshell-mac.zip'], 08:33:54 INFO - u'mochitest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 08:33:54 INFO - u'firefox-53.0a1.en-US.mac.mochitest.tests.zip'], 08:33:54 INFO - u'mozbase': [u'firefox-53.0a1.en-US.mac.common.tests.zip'], 08:33:54 INFO - u'reftest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 08:33:54 INFO - u'firefox-53.0a1.en-US.mac.reftest.tests.zip'], 08:33:54 INFO - u'talos': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 08:33:54 INFO - u'firefox-53.0a1.en-US.mac.talos.tests.zip'], 08:33:54 INFO - u'web-platform': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 08:33:54 INFO - u'firefox-53.0a1.en-US.mac.web-platform.tests.zip'], 08:33:54 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 08:33:54 INFO - u'firefox-53.0a1.en-US.mac.xpcshell.tests.zip']} 08:33:54 INFO - Downloading packages: [u'firefox-53.0a1.en-US.mac.common.tests.zip'] for test suite category: common 08:33:54 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/JQfZGfM2SzeXKIQuHLz8NA/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip 08:33:54 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/JQfZGfM2SzeXKIQuHLz8NA/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip'}, attempt #1 08:33:54 INFO - Fetch https://queue.taskcluster.net/v1/task/JQfZGfM2SzeXKIQuHLz8NA/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip into memory 08:33:57 INFO - Expected file size: 16284359 08:33:57 INFO - Obtained file size: 16284359 08:34:04 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:34:04 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/JQfZGfM2SzeXKIQuHLz8NA/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip 08:34:04 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/JQfZGfM2SzeXKIQuHLz8NA/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip'}, attempt #1 08:34:04 INFO - Fetch https://queue.taskcluster.net/v1/task/JQfZGfM2SzeXKIQuHLz8NA/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip into memory 08:34:05 INFO - Expected file size: 16284359 08:34:05 INFO - Obtained file size: 16284359 08:34:11 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/JQfZGfM2SzeXKIQuHLz8NA/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip 08:34:11 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/JQfZGfM2SzeXKIQuHLz8NA/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip'}, attempt #1 08:34:11 INFO - Fetch https://queue.taskcluster.net/v1/task/JQfZGfM2SzeXKIQuHLz8NA/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip into memory 08:34:12 INFO - Expected file size: 14409734 08:34:12 INFO - Obtained file size: 14409734 08:34: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:34:12 INFO - trying https://queue.taskcluster.net/v1/task/JQfZGfM2SzeXKIQuHLz8NA/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 08:34:12 INFO - Downloading https://queue.taskcluster.net/v1/task/JQfZGfM2SzeXKIQuHLz8NA/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg 08:34:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/JQfZGfM2SzeXKIQuHLz8NA/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:34:15 INFO - Downloaded 107595036 bytes. 08:34:15 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/JQfZGfM2SzeXKIQuHLz8NA/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 08:34:15 INFO - mkdir: /builds/slave/test/properties 08:34:15 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:34:15 INFO - Writing to file /builds/slave/test/properties/build_url 08:34:15 INFO - Contents: 08:34:15 INFO - build_url:https://queue.taskcluster.net/v1/task/JQfZGfM2SzeXKIQuHLz8NA/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 08:34:16 INFO - Running post-action listener: _resource_record_post_action 08:34:16 INFO - Running post-action listener: set_extra_try_arguments 08:34:16 INFO - [mozharness: 2016-12-07 16:34:16.410770Z] Finished download-and-extract step (success) 08:34:16 INFO - [mozharness: 2016-12-07 16:34:16.410927Z] Running populate-webroot step. 08:34:16 INFO - Running pre-action listener: _resource_record_pre_action 08:34:16 INFO - Running main action method: populate_webroot 08:34:16 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:34:16 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:34:16 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:34:16 INFO - '--tppagecycles', 08:34:16 INFO - '7'], 08:34:16 INFO - 'tests': ['tsvgm']}}, 08:34:16 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:34:16 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:34:16 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:34:16 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:34:16 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:34:16 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:34:16 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 08:34:16 INFO - 'talos_options': ['--disable-e10s'], 08:34:16 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:34:16 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 08:34:16 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:34:16 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 08:34:16 INFO - 'talos_options': ['--disable-e10s'], 08:34:16 INFO - 'tests': ['damp', 'tps']}, 08:34:16 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 08:34:16 INFO - 'tests': ['damp', 'tps']}, 08:34:16 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:34:16 INFO - 'tests': ['dromaeo_dom']}, 08:34:16 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:34:16 INFO - 'g4': {'talos_options': ['--disable-e10s'], 08:34:16 INFO - 'tests': ['basic_compositor_video']}, 08:34:16 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 08:34:16 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:34:16 INFO - 'tests': ['a11yr', 08:34:16 INFO - 'ts_paint', 08:34:16 INFO - 'tpaint', 08:34:16 INFO - 'sessionrestore', 08:34:16 INFO - 'sessionrestore_no_auto_restore', 08:34:16 INFO - 'tabpaint']}, 08:34:16 INFO - 'other-e10s': {'tests': ['a11yr', 08:34:16 INFO - 'ts_paint', 08:34:16 INFO - 'tpaint', 08:34:16 INFO - 'sessionrestore', 08:34:16 INFO - 'sessionrestore_no_auto_restore', 08:34:16 INFO - 'tabpaint']}, 08:34:16 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:34:16 INFO - 'ts_paint', 08:34:16 INFO - 'tpaint', 08:34:16 INFO - 'sessionrestore', 08:34:16 INFO - 'sessionrestore_no_auto_restore', 08:34:16 INFO - 'tabpaint']}, 08:34:16 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:34:16 INFO - 'ts_paint', 08:34:16 INFO - 'tpaint', 08:34:16 INFO - 'sessionrestore', 08:34:16 INFO - 'sessionrestore_no_auto_restore', 08:34:16 INFO - 'tabpaint']}, 08:34:16 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:34:16 INFO - 'tests': ['a11yr', 08:34:16 INFO - 'ts_paint', 08:34:16 INFO - 'tpaint', 08:34:16 INFO - 'sessionrestore', 08:34:16 INFO - 'sessionrestore_no_auto_restore', 08:34:16 INFO - 'tabpaint']}, 08:34:16 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:34:16 INFO - 'tests': ['a11yr', 08:34:16 INFO - 'ts_paint', 08:34:16 INFO - 'tpaint', 08:34:16 INFO - 'sessionrestore', 08:34:16 INFO - 'sessionrestore_no_auto_restore', 08:34:16 INFO - 'tabpaint']}, 08:34:16 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:34:16 INFO - 'tests': ['tsvgx', 08:34:16 INFO - 'tsvgr_opacity', 08:34:16 INFO - 'tart', 08:34:16 INFO - 'tscrollx', 08:34:16 INFO - 'cart', 08:34:16 INFO - 'tsvg_static']}, 08:34:16 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:34:16 INFO - 'tsvgr_opacity', 08:34:16 INFO - 'tart', 08:34:16 INFO - 'tscrollx', 08:34:16 INFO - 'cart', 08:34:16 INFO - 'tsvg_static']}, 08:34:16 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 08:34:16 INFO - 'talos_options': ['--disable-e10s'], 08:34:16 INFO - 'tests': ['tp5o']}, 08:34:16 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 08:34:16 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 08:34:16 INFO - 'talos_options': ['--disable-e10s', 08:34:16 INFO - '--xperf_path', 08:34:16 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:34:16 INFO - 'tests': ['tp5n']}, 08:34:16 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 08:34:16 INFO - 'talos_options': ['--xperf_path', 08:34:16 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:34:16 INFO - 'tests': ['tp5n']}}, 08:34:16 INFO - 'talos.zip': {'path': '', 08:34:16 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:34:16 INFO - Running post-action listener: _resource_record_post_action 08:34:16 INFO - [mozharness: 2016-12-07 16:34:16.429410Z] Finished populate-webroot step (success) 08:34:16 INFO - [mozharness: 2016-12-07 16:34:16.429550Z] Running create-virtualenv step. 08:34:16 INFO - Running pre-action listener: _resource_record_pre_action 08:34:16 INFO - Running main action method: create_virtualenv 08:34:16 INFO - Creating virtualenv /builds/slave/test/build/venv 08:34:16 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:34:16 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:34:16 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:34:16 INFO - Using real prefix '/tools/python27' 08:34:16 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:34:17 INFO - Installing distribute.............................................................................................................................................................................................done. 08:34:20 INFO - Installing pip.................done. 08:34:20 INFO - Return code: 0 08:34:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 08:34:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 08:34:20 INFO - Reading from file tmpfile_stdout 08:34:20 INFO - Output received: 08:34:20 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:34:20 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:34:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:34:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:34:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:34:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:34:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:34:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:34:20 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 0x1099683f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1098de570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff35bca7f40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10977dd30>, '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 0x1095e4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109775b20>, '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.8QzykyWzVk/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.N1jdOs0C78/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/1b/b370xjvx7_vbkyyr8hgyjzcm00000w/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:34:20 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:34:20 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:34:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8QzykyWzVk/Render', 08:34:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:34:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:34:20 INFO - 'HOME': '/Users/cltbld', 08:34:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:34:20 INFO - 'LOGNAME': 'cltbld', 08:34:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:34:20 INFO - 'MOZ_NO_REMOTE': '1', 08:34:20 INFO - 'NO_EM_RESTART': '1', 08:34:20 INFO - 'PAGER': '/bin/cat', 08:34:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:34:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:34:20 INFO - 'PWD': '/builds/slave/test', 08:34:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:34:20 INFO - 'SHELL': '/bin/bash', 08:34:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.N1jdOs0C78/Listeners', 08:34:20 INFO - 'TMPDIR': '/var/folders/1b/b370xjvx7_vbkyyr8hgyjzcm00000w/T/', 08:34:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:34:20 INFO - 'USER': 'cltbld', 08:34:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:34:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:34:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:34:20 INFO - 'XPC_FLAGS': '0x0', 08:34:20 INFO - 'XPC_SERVICE_NAME': '0', 08:34:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:34:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:34:20 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:34:20 INFO - Cleaning up... 08:34:20 INFO - Return code: 0 08:34:20 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:34:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:34:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:34:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:34:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:34:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:34:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:34:20 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 0x1099683f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1098de570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff35bca7f40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10977dd30>, '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 0x1095e4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109775b20>, '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.8QzykyWzVk/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.N1jdOs0C78/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/1b/b370xjvx7_vbkyyr8hgyjzcm00000w/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:34:20 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:34:20 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:34:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8QzykyWzVk/Render', 08:34:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:34:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:34:20 INFO - 'HOME': '/Users/cltbld', 08:34:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:34:20 INFO - 'LOGNAME': 'cltbld', 08:34:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:34:20 INFO - 'MOZ_NO_REMOTE': '1', 08:34:20 INFO - 'NO_EM_RESTART': '1', 08:34:20 INFO - 'PAGER': '/bin/cat', 08:34:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:34:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:34:20 INFO - 'PWD': '/builds/slave/test', 08:34:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:34:20 INFO - 'SHELL': '/bin/bash', 08:34:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.N1jdOs0C78/Listeners', 08:34:20 INFO - 'TMPDIR': '/var/folders/1b/b370xjvx7_vbkyyr8hgyjzcm00000w/T/', 08:34:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:34:20 INFO - 'USER': 'cltbld', 08:34:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:34:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:34:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:34:20 INFO - 'XPC_FLAGS': '0x0', 08:34:20 INFO - 'XPC_SERVICE_NAME': '0', 08:34:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:34:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:34:20 INFO - Downloading/unpacking psutil>=3.1.1 08:34:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:34:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:34:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:34:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:34:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:34:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:34:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:34:24 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:34:24 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:34:24 INFO - Installing collected packages: psutil 08:34:24 INFO - Running setup.py install for psutil 08:34:25 INFO - building 'psutil._psutil_osx' extension 08:34:25 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:34:25 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:34:25 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:34:25 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:34:25 INFO - building 'psutil._psutil_posix' extension 08:34:25 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:34:25 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 08:34:25 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 08:34:25 INFO - ^ 08:34:25 INFO - 1 warning generated. 08:34:25 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:34:26 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:34:26 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:34:26 INFO - Successfully installed psutil 08:34:26 INFO - Cleaning up... 08:34:26 INFO - Return code: 0 08:34:26 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:34:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:34:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:34:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:34:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:34:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:34:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:34:26 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1099683f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1098de570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff35bca7f40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10977dd30>, '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 0x1095e4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109775b20>, '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.8QzykyWzVk/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.N1jdOs0C78/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/1b/b370xjvx7_vbkyyr8hgyjzcm00000w/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:34:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 08:34:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 08:34:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8QzykyWzVk/Render', 08:34:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:34:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:34:26 INFO - 'HOME': '/Users/cltbld', 08:34:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:34:26 INFO - 'LOGNAME': 'cltbld', 08:34:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:34:26 INFO - 'MOZ_NO_REMOTE': '1', 08:34:26 INFO - 'NO_EM_RESTART': '1', 08:34:26 INFO - 'PAGER': '/bin/cat', 08:34:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:34:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:34:26 INFO - 'PWD': '/builds/slave/test', 08:34:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:34:26 INFO - 'SHELL': '/bin/bash', 08:34:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.N1jdOs0C78/Listeners', 08:34:26 INFO - 'TMPDIR': '/var/folders/1b/b370xjvx7_vbkyyr8hgyjzcm00000w/T/', 08:34:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:34:26 INFO - 'USER': 'cltbld', 08:34:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:34:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:34:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:34:26 INFO - 'XPC_FLAGS': '0x0', 08:34:26 INFO - 'XPC_SERVICE_NAME': '0', 08:34:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:34:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:34:26 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:34:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:34:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:34:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:34:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:34:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:34:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:34:28 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:34:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:34:29 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:34:29 INFO - Installing collected packages: mozsystemmonitor 08:34:29 INFO - Running setup.py install for mozsystemmonitor 08:34:29 INFO - Successfully installed mozsystemmonitor 08:34:29 INFO - Cleaning up... 08:34:29 INFO - Return code: 0 08:34:29 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:34:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:34:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:34:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:34:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:34:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:34:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:34:29 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 0x1099683f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1098de570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff35bca7f40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10977dd30>, '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 0x1095e4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109775b20>, '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.8QzykyWzVk/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.N1jdOs0C78/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/1b/b370xjvx7_vbkyyr8hgyjzcm00000w/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:34:29 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:34:29 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:34:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8QzykyWzVk/Render', 08:34:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:34:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:34:29 INFO - 'HOME': '/Users/cltbld', 08:34:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:34:29 INFO - 'LOGNAME': 'cltbld', 08:34:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:34:29 INFO - 'MOZ_NO_REMOTE': '1', 08:34:29 INFO - 'NO_EM_RESTART': '1', 08:34:29 INFO - 'PAGER': '/bin/cat', 08:34:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:34:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:34:29 INFO - 'PWD': '/builds/slave/test', 08:34:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:34:29 INFO - 'SHELL': '/bin/bash', 08:34:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.N1jdOs0C78/Listeners', 08:34:29 INFO - 'TMPDIR': '/var/folders/1b/b370xjvx7_vbkyyr8hgyjzcm00000w/T/', 08:34:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:34:29 INFO - 'USER': 'cltbld', 08:34:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:34:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:34:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:34:29 INFO - 'XPC_FLAGS': '0x0', 08:34:29 INFO - 'XPC_SERVICE_NAME': '0', 08:34:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:34:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:34:29 INFO - Downloading/unpacking jsonschema==2.5.1 08:34:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:34:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:34:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:34:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:34:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:34:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:34:32 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:34:32 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:34:32 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:34:32 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:34:32 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:34:32 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:34:32 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:34:32 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:34:32 INFO - Downloading functools32-3.2.3-2.tar.gz 08:34:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:34:32 INFO - warning: no files found matching '*.txt' 08:34:32 INFO - no previously-included directories found matching 'build' 08:34:32 INFO - no previously-included directories found matching 'dist' 08:34:32 INFO - no previously-included directories found matching '.git*' 08:34:32 INFO - Installing collected packages: jsonschema, functools32 08:34:32 INFO - Running setup.py install for functools32 08:34:32 INFO - warning: no files found matching '*.txt' 08:34:32 INFO - no previously-included directories found matching 'build' 08:34:32 INFO - no previously-included directories found matching 'dist' 08:34:32 INFO - no previously-included directories found matching '.git*' 08:34:32 INFO - Successfully installed jsonschema functools32 08:34:32 INFO - Cleaning up... 08:34:32 INFO - Return code: 0 08:34:32 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 08:34:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:34:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:34:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:34:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:34:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:34:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:34:32 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 0x1099683f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1098de570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff35bca7f40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10977dd30>, '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 0x1095e4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109775b20>, '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.8QzykyWzVk/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.N1jdOs0C78/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/1b/b370xjvx7_vbkyyr8hgyjzcm00000w/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:34:32 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:34:32 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:34:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8QzykyWzVk/Render', 08:34:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:34:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:34:32 INFO - 'HOME': '/Users/cltbld', 08:34:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:34:32 INFO - 'LOGNAME': 'cltbld', 08:34:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:34:32 INFO - 'MOZ_NO_REMOTE': '1', 08:34:32 INFO - 'NO_EM_RESTART': '1', 08:34:32 INFO - 'PAGER': '/bin/cat', 08:34:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:34:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:34:32 INFO - 'PWD': '/builds/slave/test', 08:34:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:34:32 INFO - 'SHELL': '/bin/bash', 08:34:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.N1jdOs0C78/Listeners', 08:34:32 INFO - 'TMPDIR': '/var/folders/1b/b370xjvx7_vbkyyr8hgyjzcm00000w/T/', 08:34:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:34:32 INFO - 'USER': 'cltbld', 08:34:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:34:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:34:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:34:32 INFO - 'XPC_FLAGS': '0x0', 08:34:32 INFO - 'XPC_SERVICE_NAME': '0', 08:34:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:34:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:34:33 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 08:34:33 INFO - Cleaning up... 08:34:33 INFO - Return code: 0 08:34:33 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:34:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:34:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:34:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:34:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:34:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:34:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:34:33 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 0x1099683f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1098de570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff35bca7f40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10977dd30>, '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 0x1095e4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109775b20>, '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.8QzykyWzVk/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.N1jdOs0C78/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/1b/b370xjvx7_vbkyyr8hgyjzcm00000w/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:34:33 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:34:33 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:34:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8QzykyWzVk/Render', 08:34:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:34:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:34:33 INFO - 'HOME': '/Users/cltbld', 08:34:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:34:33 INFO - 'LOGNAME': 'cltbld', 08:34:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:34:33 INFO - 'MOZ_NO_REMOTE': '1', 08:34:33 INFO - 'NO_EM_RESTART': '1', 08:34:33 INFO - 'PAGER': '/bin/cat', 08:34:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:34:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:34:33 INFO - 'PWD': '/builds/slave/test', 08:34:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:34:33 INFO - 'SHELL': '/bin/bash', 08:34:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.N1jdOs0C78/Listeners', 08:34:33 INFO - 'TMPDIR': '/var/folders/1b/b370xjvx7_vbkyyr8hgyjzcm00000w/T/', 08:34:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:34:33 INFO - 'USER': 'cltbld', 08:34:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:34:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:34:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:34:33 INFO - 'XPC_FLAGS': '0x0', 08:34:33 INFO - 'XPC_SERVICE_NAME': '0', 08:34:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:34:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:34:33 INFO - Downloading/unpacking blobuploader==1.2.4 08:34:33 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:34:33 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:34:33 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:34:33 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:34:33 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:34:33 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:34:36 INFO - Downloading blobuploader-1.2.4.tar.gz 08:34:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:34:36 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:34:36 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:34:36 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:34:36 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:34:36 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:34:36 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:34:36 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:34:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:34:36 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:34:36 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:34:36 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:34:36 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:34:36 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:34:36 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:34:36 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:34:37 INFO - Downloading docopt-0.6.1.tar.gz 08:34:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:34:37 INFO - Installing collected packages: blobuploader, requests, docopt 08:34:37 INFO - Running setup.py install for blobuploader 08:34:37 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:34:37 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:34:37 INFO - Running setup.py install for requests 08:34:38 INFO - Running setup.py install for docopt 08:34:38 INFO - Successfully installed blobuploader requests docopt 08:34:38 INFO - Cleaning up... 08:34:38 INFO - Return code: 0 08:34:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:34:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:34:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:34:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:34:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:34:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:34:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:34:38 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 0x1099683f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1098de570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff35bca7f40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10977dd30>, '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 0x1095e4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109775b20>, '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.8QzykyWzVk/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.N1jdOs0C78/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/1b/b370xjvx7_vbkyyr8hgyjzcm00000w/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:34:38 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:34:38 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:34:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8QzykyWzVk/Render', 08:34:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:34:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:34:38 INFO - 'HOME': '/Users/cltbld', 08:34:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:34:38 INFO - 'LOGNAME': 'cltbld', 08:34:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:34:38 INFO - 'MOZ_NO_REMOTE': '1', 08:34:38 INFO - 'NO_EM_RESTART': '1', 08:34:38 INFO - 'PAGER': '/bin/cat', 08:34:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:34:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:34:38 INFO - 'PWD': '/builds/slave/test', 08:34:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:34:38 INFO - 'SHELL': '/bin/bash', 08:34:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.N1jdOs0C78/Listeners', 08:34:38 INFO - 'TMPDIR': '/var/folders/1b/b370xjvx7_vbkyyr8hgyjzcm00000w/T/', 08:34:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:34:38 INFO - 'USER': 'cltbld', 08:34:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:34:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:34:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:34:38 INFO - 'XPC_FLAGS': '0x0', 08:34:38 INFO - 'XPC_SERVICE_NAME': '0', 08:34:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:34:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:34:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:34:38 INFO - Running setup.py (path:/var/folders/1b/b370xjvx7_vbkyyr8hgyjzcm00000w/T/pip-09_iIi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:34:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:34:38 INFO - Running setup.py (path:/var/folders/1b/b370xjvx7_vbkyyr8hgyjzcm00000w/T/pip-DiMe0E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:34:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:34:38 INFO - Running setup.py (path:/var/folders/1b/b370xjvx7_vbkyyr8hgyjzcm00000w/T/pip-Z44ZKY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:34:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:34:38 INFO - Running setup.py (path:/var/folders/1b/b370xjvx7_vbkyyr8hgyjzcm00000w/T/pip-_YIknZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:34:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:34:38 INFO - Running setup.py (path:/var/folders/1b/b370xjvx7_vbkyyr8hgyjzcm00000w/T/pip-cIG8Hy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:34:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:34:39 INFO - Running setup.py (path:/var/folders/1b/b370xjvx7_vbkyyr8hgyjzcm00000w/T/pip-qVuRy1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:34:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:34:39 INFO - Running setup.py (path:/var/folders/1b/b370xjvx7_vbkyyr8hgyjzcm00000w/T/pip-2xGf2v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:34:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:34:39 INFO - Running setup.py (path:/var/folders/1b/b370xjvx7_vbkyyr8hgyjzcm00000w/T/pip-tyj7cm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:34:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:34:39 INFO - Running setup.py (path:/var/folders/1b/b370xjvx7_vbkyyr8hgyjzcm00000w/T/pip-X5ohmm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:34:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:34:39 INFO - Running setup.py (path:/var/folders/1b/b370xjvx7_vbkyyr8hgyjzcm00000w/T/pip-7Pq5bs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:34:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:34:39 INFO - Running setup.py (path:/var/folders/1b/b370xjvx7_vbkyyr8hgyjzcm00000w/T/pip-uElcYY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:34:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:34:39 INFO - Running setup.py (path:/var/folders/1b/b370xjvx7_vbkyyr8hgyjzcm00000w/T/pip-kZ05F6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:34:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:34:39 INFO - Running setup.py (path:/var/folders/1b/b370xjvx7_vbkyyr8hgyjzcm00000w/T/pip-D1jJU3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:34:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:34:39 INFO - Running setup.py (path:/var/folders/1b/b370xjvx7_vbkyyr8hgyjzcm00000w/T/pip-0zZuTl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:34:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:34:40 INFO - Running setup.py (path:/var/folders/1b/b370xjvx7_vbkyyr8hgyjzcm00000w/T/pip-BJttN_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:34:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:34:40 INFO - Running setup.py (path:/var/folders/1b/b370xjvx7_vbkyyr8hgyjzcm00000w/T/pip-xPdJZJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:34:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:34:40 INFO - Running setup.py (path:/var/folders/1b/b370xjvx7_vbkyyr8hgyjzcm00000w/T/pip-bdK_TS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:34:40 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:34:40 INFO - Running setup.py install for manifestparser 08:34:40 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:34:40 INFO - Running setup.py install for mozcrash 08:34:40 INFO - Running setup.py install for mozdebug 08:34:40 INFO - Running setup.py install for mozdevice 08:34:40 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:34:40 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:34:40 INFO - Running setup.py install for mozfile 08:34:41 INFO - Running setup.py install for mozhttpd 08:34:41 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:34:41 INFO - Running setup.py install for mozinfo 08:34:41 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:34:41 INFO - Running setup.py install for mozInstall 08:34:41 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:34:41 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:34:41 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:34:41 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:34:41 INFO - Running setup.py install for mozleak 08:34:41 INFO - Running setup.py install for mozlog 08:34:41 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:34:41 INFO - Running setup.py install for moznetwork 08:34:41 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:34:41 INFO - Running setup.py install for mozprocess 08:34:42 INFO - Running setup.py install for mozprofile 08:34:42 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:34:42 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:34:42 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:34:42 INFO - Running setup.py install for mozrunner 08:34:42 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:34:42 INFO - Running setup.py install for mozscreenshot 08:34:42 INFO - Running setup.py install for moztest 08:34:42 INFO - Running setup.py install for mozversion 08:34:42 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:34:42 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:34:42 INFO - Cleaning up... 08:34:42 INFO - Return code: 0 08:34:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:34:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:34:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:34:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:34:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:34:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:34:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:34:42 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 0x1099683f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1098de570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff35bca7f40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10977dd30>, '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 0x1095e4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109775b20>, '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.8QzykyWzVk/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.N1jdOs0C78/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/1b/b370xjvx7_vbkyyr8hgyjzcm00000w/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:34:42 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:34:42 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:34:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8QzykyWzVk/Render', 08:34:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:34:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:34:42 INFO - 'HOME': '/Users/cltbld', 08:34:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:34:42 INFO - 'LOGNAME': 'cltbld', 08:34:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:34:42 INFO - 'MOZ_NO_REMOTE': '1', 08:34:42 INFO - 'NO_EM_RESTART': '1', 08:34:42 INFO - 'PAGER': '/bin/cat', 08:34:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:34:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:34:42 INFO - 'PWD': '/builds/slave/test', 08:34:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:34:42 INFO - 'SHELL': '/bin/bash', 08:34:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.N1jdOs0C78/Listeners', 08:34:42 INFO - 'TMPDIR': '/var/folders/1b/b370xjvx7_vbkyyr8hgyjzcm00000w/T/', 08:34:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:34:42 INFO - 'USER': 'cltbld', 08:34:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:34:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:34:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:34:42 INFO - 'XPC_FLAGS': '0x0', 08:34:42 INFO - 'XPC_SERVICE_NAME': '0', 08:34:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:34:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:34:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:34:43 INFO - Running setup.py (path:/var/folders/1b/b370xjvx7_vbkyyr8hgyjzcm00000w/T/pip-Nnztap-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:34:43 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:34:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:34:43 INFO - Running setup.py (path:/var/folders/1b/b370xjvx7_vbkyyr8hgyjzcm00000w/T/pip-hv_m6x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:34:43 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:34:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:34:43 INFO - Running setup.py (path:/var/folders/1b/b370xjvx7_vbkyyr8hgyjzcm00000w/T/pip-k3sCWF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:34:43 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:34:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:34:43 INFO - Running setup.py (path:/var/folders/1b/b370xjvx7_vbkyyr8hgyjzcm00000w/T/pip-XspKwF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:34:43 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:34:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:34:43 INFO - Running setup.py (path:/var/folders/1b/b370xjvx7_vbkyyr8hgyjzcm00000w/T/pip-6gBOj4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:34:43 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:34:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:34:43 INFO - Running setup.py (path:/var/folders/1b/b370xjvx7_vbkyyr8hgyjzcm00000w/T/pip-pY7AXU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:34:43 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:34:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:34:43 INFO - Running setup.py (path:/var/folders/1b/b370xjvx7_vbkyyr8hgyjzcm00000w/T/pip-IYmbsX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:34:43 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:34:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:34:43 INFO - Running setup.py (path:/var/folders/1b/b370xjvx7_vbkyyr8hgyjzcm00000w/T/pip-eHqYXS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:34:44 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:34:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:34:44 INFO - Running setup.py (path:/var/folders/1b/b370xjvx7_vbkyyr8hgyjzcm00000w/T/pip-xmciee-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:34:44 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:34:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:34:44 INFO - Running setup.py (path:/var/folders/1b/b370xjvx7_vbkyyr8hgyjzcm00000w/T/pip-H5ROl8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:34:44 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:34:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:34:44 INFO - Running setup.py (path:/var/folders/1b/b370xjvx7_vbkyyr8hgyjzcm00000w/T/pip-dkdhgc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:34:44 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:34:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:34:44 INFO - Running setup.py (path:/var/folders/1b/b370xjvx7_vbkyyr8hgyjzcm00000w/T/pip-5TCNJ5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:34:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 08:34:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:34:44 INFO - Running setup.py (path:/var/folders/1b/b370xjvx7_vbkyyr8hgyjzcm00000w/T/pip-tSry1B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:34:44 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:34:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:34:44 INFO - Running setup.py (path:/var/folders/1b/b370xjvx7_vbkyyr8hgyjzcm00000w/T/pip-0e2rhB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:34:44 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:34:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:34:44 INFO - Running setup.py (path:/var/folders/1b/b370xjvx7_vbkyyr8hgyjzcm00000w/T/pip-epSsHN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:34:44 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:34:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:34:44 INFO - Running setup.py (path:/var/folders/1b/b370xjvx7_vbkyyr8hgyjzcm00000w/T/pip-TxeQ8M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:34:44 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 08:34:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:34:44 INFO - Running setup.py (path:/var/folders/1b/b370xjvx7_vbkyyr8hgyjzcm00000w/T/pip-cQIuzq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:34:44 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:34:44 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:34:44 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:34:44 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:34:44 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:34:44 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:34:44 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:34:44 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:34:44 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:34:44 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:34:44 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:34:44 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:34:44 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:34:47 INFO - Downloading blessings-1.6.tar.gz 08:34:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:34:47 INFO - Installing collected packages: blessings 08:34:47 INFO - Running setup.py install for blessings 08:34:47 INFO - Successfully installed blessings 08:34:47 INFO - Cleaning up... 08:34:47 INFO - Return code: 0 08:34:47 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:34:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:34:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:34:48 INFO - Reading from file tmpfile_stdout 08:34:48 INFO - Current package versions: 08:34:48 INFO - blessings == 1.6 08:34:48 INFO - blobuploader == 1.2.4 08:34:48 INFO - docopt == 0.6.1 08:34:48 INFO - functools32 == 3.2.3-2 08:34:48 INFO - jsonschema == 2.5.1 08:34:48 INFO - manifestparser == 1.1 08:34:48 INFO - mozInstall == 1.12 08:34:48 INFO - mozcrash == 1.0 08:34:48 INFO - mozdebug == 0.1 08:34:48 INFO - mozdevice == 0.49 08:34:48 INFO - mozfile == 1.2 08:34:48 INFO - mozhttpd == 0.7 08:34:48 INFO - mozinfo == 0.9 08:34:48 INFO - mozleak == 0.1 08:34:48 INFO - mozlog == 3.4 08:34:48 INFO - moznetwork == 0.27 08:34:48 INFO - mozprocess == 0.23 08:34:48 INFO - mozprofile == 0.28 08:34:48 INFO - mozrunner == 6.13 08:34:48 INFO - mozscreenshot == 0.1 08:34:48 INFO - mozsystemmonitor == 0.3 08:34:48 INFO - moztest == 0.7 08:34:48 INFO - mozversion == 1.4 08:34:48 INFO - psutil == 3.1.1 08:34:48 INFO - requests == 1.2.3 08:34:48 INFO - wsgiref == 0.1.2 08:34:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:34: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:34:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:34:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:34: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:34:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:34:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:34:48 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 0x1099683f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1098de570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff35bca7f40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10977dd30>, '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 0x1095e4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109775b20>, '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.8QzykyWzVk/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.N1jdOs0C78/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/1b/b370xjvx7_vbkyyr8hgyjzcm00000w/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:34:48 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:34:48 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:34:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8QzykyWzVk/Render', 08:34:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:34:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:34:48 INFO - 'HOME': '/Users/cltbld', 08:34:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:34:48 INFO - 'LOGNAME': 'cltbld', 08:34:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:34:48 INFO - 'MOZ_NO_REMOTE': '1', 08:34:48 INFO - 'NO_EM_RESTART': '1', 08:34:48 INFO - 'PAGER': '/bin/cat', 08:34:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:34:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:34:48 INFO - 'PWD': '/builds/slave/test', 08:34:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:34:48 INFO - 'SHELL': '/bin/bash', 08:34:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.N1jdOs0C78/Listeners', 08:34:48 INFO - 'TMPDIR': '/var/folders/1b/b370xjvx7_vbkyyr8hgyjzcm00000w/T/', 08:34:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:34:48 INFO - 'USER': 'cltbld', 08:34:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:34:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:34:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:34:48 INFO - 'XPC_FLAGS': '0x0', 08:34:48 INFO - 'XPC_SERVICE_NAME': '0', 08:34:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:34:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:34:48 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:34:48 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:34:48 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:34:48 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:34:48 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:34:48 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:34:48 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:34:48 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:34:48 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:34:48 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:34:48 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:34:48 INFO - Cleaning up... 08:34:48 INFO - Return code: 0 08:34:48 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:34: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:34:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:34:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:34: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:34:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:34:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:34:48 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 0x1099683f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1098de570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff35bca7f40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10977dd30>, '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 0x1095e4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109775b20>, '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.8QzykyWzVk/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.N1jdOs0C78/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/1b/b370xjvx7_vbkyyr8hgyjzcm00000w/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:34:48 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:34:48 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:34:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8QzykyWzVk/Render', 08:34:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:34:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:34:48 INFO - 'HOME': '/Users/cltbld', 08:34:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:34:48 INFO - 'LOGNAME': 'cltbld', 08:34:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:34:48 INFO - 'MOZ_NO_REMOTE': '1', 08:34:48 INFO - 'NO_EM_RESTART': '1', 08:34:48 INFO - 'PAGER': '/bin/cat', 08:34:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:34:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:34:48 INFO - 'PWD': '/builds/slave/test', 08:34:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:34:48 INFO - 'SHELL': '/bin/bash', 08:34:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.N1jdOs0C78/Listeners', 08:34:48 INFO - 'TMPDIR': '/var/folders/1b/b370xjvx7_vbkyyr8hgyjzcm00000w/T/', 08:34:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:34:48 INFO - 'USER': 'cltbld', 08:34:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:34:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:34:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:34:48 INFO - 'XPC_FLAGS': '0x0', 08:34:48 INFO - 'XPC_SERVICE_NAME': '0', 08:34:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:34:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:34:48 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:34:48 INFO - Cleaning up... 08:34:48 INFO - Return code: 0 08:34:48 INFO - Running post-action listener: _resource_record_post_action 08:34:48 INFO - Running post-action listener: _start_resource_monitoring 08:34:48 INFO - Starting resource monitoring. 08:34:48 INFO - [mozharness: 2016-12-07 16:34:48.838661Z] Finished create-virtualenv step (success) 08:34:48 INFO - [mozharness: 2016-12-07 16:34:48.839681Z] Running install step. 08:34:48 INFO - Running pre-action listener: _resource_record_pre_action 08:34:48 INFO - Running main action method: install 08:34:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:34:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:34:49 INFO - Reading from file tmpfile_stdout 08:34:49 INFO - Detecting whether we're running mozinstall >=1.0... 08:34:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:34:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:34:49 INFO - Reading from file tmpfile_stdout 08:34:49 INFO - Output received: 08:34:49 INFO - Usage: mozinstall [options] installer 08:34:49 INFO - Options: 08:34:49 INFO - -h, --help show this help message and exit 08:34:49 INFO - -d DEST, --destination=DEST 08:34:49 INFO - Directory to install application into. [default: 08:34:49 INFO - "/builds/slave/test"] 08:34:49 INFO - --app=APP Application being installed. [default: firefox] 08:34:49 INFO - mkdir: /builds/slave/test/build/application 08:34:49 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:34:49 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:35:21 INFO - Reading from file tmpfile_stdout 08:35:21 INFO - Output received: 08:35:21 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 08:35:21 INFO - Running post-action listener: _resource_record_post_action 08:35:21 INFO - [mozharness: 2016-12-07 16:35:21.892982Z] Finished install step (success) 08:35:21 INFO - [mozharness: 2016-12-07 16:35:21.893112Z] Running run-tests step. 08:35:21 INFO - Running pre-action listener: _resource_record_pre_action 08:35:21 INFO - Running main action method: run_tests 08:35:21 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 08:35:21 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 08:35:21 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 08:35:21 INFO - 2016-12-07 08:35:21.907 screenresolution[1635:8094] starting screenresolution argv=screenresolution get 08:35:21 INFO - 2016-12-07 08:35:21.910 screenresolution[1635:8094] Display 0: 1600x1200x32@60 08:35:21 INFO - 2016-12-07 08:35:21.916 screenresolution[1636:8096] starting screenresolution argv=screenresolution list 08:35:21 INFO - Available Modes on Display 0 08:35:21 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 08:35:21 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 08:35:21 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 08:35:21 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 08:35:22 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 08:35:22 INFO - Intel Iris: 08:35:22 INFO - Chipset Model: Intel Iris 08:35:22 INFO - Type: GPU 08:35:22 INFO - Bus: Built-In 08:35:22 INFO - VRAM (Dynamic, Max): 1536 MB 08:35:22 INFO - Vendor: Intel (0x8086) 08:35:22 INFO - Device ID: 0x0a2e 08:35:22 INFO - Revision ID: 0x0009 08:35:22 INFO - Displays: 08:35:22 INFO - Display: 08:35:22 INFO - Resolution: 1600 x 1200 @ 60 Hz 08:35:22 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 08:35:22 INFO - Display Serial Number: 1600x1200 60 08:35:22 INFO - Main Display: Yes 08:35:22 INFO - Mirror: Off 08:35:22 INFO - Online: Yes 08:35:22 INFO - Rotation: Supported 08:35:22 INFO - Return code: 0 08:35:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:35:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:35:22 INFO - Python 2.7.3 08:35:22 INFO - Return code: 0 08:35:22 INFO - grabbing minidump binary from tooltool 08:35:22 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:35:22 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 0x10977dd30>, '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 0x1095e4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109775b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:35:22 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:35:22 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:35:22 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:35:22 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:35:22 INFO - Return code: 0 08:35:22 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 08:35:22 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:35:22 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:35:22 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 08:35:22 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:35:22 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/JQfZGfM2SzeXKIQuHLz8NA/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0327', '--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:35:22 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/JQfZGfM2SzeXKIQuHLz8NA/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0327 --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:35:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8QzykyWzVk/Render', 08:35:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:35:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:35:22 INFO - 'HOME': '/Users/cltbld', 08:35:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:35:22 INFO - 'LOGNAME': 'cltbld', 08:35:22 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:35:22 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 08:35:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:35:22 INFO - 'MOZ_NO_REMOTE': '1', 08:35:22 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:35:22 INFO - 'NO_EM_RESTART': '1', 08:35:22 INFO - 'PAGER': '/bin/cat', 08:35:22 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:35:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:35:22 INFO - 'PWD': '/builds/slave/test', 08:35:22 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:35:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:35:22 INFO - 'SHELL': '/bin/bash', 08:35:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.N1jdOs0C78/Listeners', 08:35:22 INFO - 'TMPDIR': '/var/folders/1b/b370xjvx7_vbkyyr8hgyjzcm00000w/T/', 08:35:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:35:22 INFO - 'USER': 'cltbld', 08:35:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:35:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:35:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:35:22 INFO - 'XPC_FLAGS': '0x0', 08:35:22 INFO - 'XPC_SERVICE_NAME': '0', 08:35:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:35:22 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/JQfZGfM2SzeXKIQuHLz8NA/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0327', '--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:35:22 INFO - mozversion application_buildid: 20161207062738 08:35:22 INFO - mozversion application_changeset: c2526f6786f074888d71c8e166a02aea3e19e75b 08:35:22 INFO - mozversion application_display_name: Nightly 08:35:22 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:35:22 INFO - mozversion application_name: Firefox 08:35:22 INFO - mozversion application_remotingname: firefox 08:35:22 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 08:35:22 INFO - mozversion application_vendor: Mozilla 08:35:22 INFO - mozversion application_version: 53.0a1 08:35:22 INFO - mozversion platform_buildid: 20161207062738 08:35:22 INFO - mozversion platform_changeset: c2526f6786f074888d71c8e166a02aea3e19e75b 08:35:22 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 08:35:22 INFO - mozversion platform_version: 53.0a1 08:35:22 INFO - using testdate: 1481128522 08:35:22 INFO - actual date: 1481128522 08:35:22 INFO - starting webserver on 'localhost:49243' 08:35:22 INFO - SUITE-START | Running 2 tests 08:35:22 INFO - TEST-START | dromaeo_css 08:35:22 INFO - operating with platform_type : mac_ 08:35:22 INFO - Initialising browser for dromaeo_css test... 08:35:22 INFO - TEST-INFO | started process 1646 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/1b/b370xjvx7_vbkyyr8hgyjzcm00000w/T/tmp1s0_nw/profile http://localhost:49243/getInfo.html) 08:35:25 INFO - PROCESS | 1646 | __metrics Screen width/height:1600/1200 08:35:25 INFO - PROCESS | 1646 | colorDepth:24 08:35:25 INFO - PROCESS | 1646 | Browser inner width/height: 1024/689 08:35:25 INFO - PROCESS | 1646 | __metrics 08:35:25 INFO - PROCESS | 1646 | 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:35:25 INFO - PROCESS | 1646 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:35:26 INFO - TEST-INFO | 1646: exit 0 08:35:26 INFO - Browser initialized. 08:35:26 INFO - Running cycle 1/1 for dromaeo_css test... 08:35:26 INFO - TEST-INFO | started process 1649 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/1b/b370xjvx7_vbkyyr8hgyjzcm00000w/T/tmp1s0_nw/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:35:38 INFO - PROCESS | 1649 | RSS: Main: 244432896 08:35:38 INFO - PROCESS | 1649 | 08:36:29 INFO - PROCESS | 1649 | 1481128589829 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 08:38:42 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49243/tests/dromaeo/cssquery-ext.html) 08:38:44 INFO - PROCESS | 1649 | RSS: Main: 425648128 08:38:44 INFO - PROCESS | 1649 | 08:41:47 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-ext.html (next: http://localhost:49243/tests/dromaeo/cssquery-jquery.html) 08:41:48 INFO - PROCESS | 1649 | RSS: Main: 372256768 08:41:48 INFO - PROCESS | 1649 | 08:44:50 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49243/tests/dromaeo/cssquery-mootools.html) 08:44:51 INFO - PROCESS | 1649 | RSS: Main: 340008960 08:44:51 INFO - PROCESS | 1649 | 08:47:53 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49243/tests/dromaeo/cssquery-prototype.html) 08:47:54 INFO - PROCESS | 1649 | RSS: Main: 343941120 08:47:54 INFO - PROCESS | 1649 | 08:50:57 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49243/tests/dromaeo/cssquery-yui.html) 08:50:58 INFO - PROCESS | 1649 | RSS: Main: 329113600 08:50:58 INFO - PROCESS | 1649 | 08:54:01 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-yui.html (next: http://localhost:49243/tests/dromaeo/cssquery-dojo.html) 08:54:02 INFO - PROCESS | 1649 | RSS: Main: 474476544 08:54:02 INFO - PROCESS | 1649 | 08:54:02 INFO - PROCESS | 1649 | __start_tp_report 08:54:02 INFO - PROCESS | 1649 | _x_x_mozilla_page_load 08:54:02 INFO - PROCESS | 1649 | _x_x_mozilla_page_load_details 08:54:02 INFO - PROCESS | 1649 | |i|pagename|runs| 08:54:02 INFO - PROCESS | 1649 | |0;dojo.html;2714.2264454630426;3337.916552086199;3357.9160520986966;3388.542546756187;3413.8634454621815;5550.972245138779;5604.99110160171;5664.660120392769;5680.9999999999945;5720.742566584503;5628.212050312959;5656.547476201904;5695.373508914026;5701.600887937846;5738.340090889538;5092.134337162673;5107.565856902168;5107.948920510785;5125.948740512585;5201.583873290147;5295.629305948566;5314.043472175007;5328.9874923764555;5338.439463856278;5368.8389348319615;5122.3853137623355;5248.265242866002;5270.183121616155;5283.445238249986;5353.732313384335;5157.535821776059;5195.844124676266;5201.895962080737;5204.063268611649;5206.869828254286;5097.745112744348;5168.3797944246935;5178.974105129488;5183.118869792107;5194.740262986873;5629.8592535186535;5632.436756324335;5641.71791410432;5645.32256129263;5660.122680984454;6126.853582554517;6127.80043271483;6144.787876364505;6149.077638354238;6192.628442293477;6300.4329610334835;6319.14691516644;6321.620702757849;6322.083297921776;6340.651264180468;5683.914741278884;5773.711314434261;5786.594938354359;5795.710214489259;5835.912461313083;6252.406021427957;6294.716737746812;6298.71655775482;6364.713587888464;6373.71318290678;6067.2112625359305;6112.572119951649;6133.754649814046;6140.504248697391;6148.415900489446;6275.6862156892885;6275.96862015687;6277.278113016971;6282.842928926722;6301.873962520724;5644.774209031675;6197.907031394533;6206.503479721611;6209.565330426917;6209.658468784261;5666.886662266732;5719.056355701346;5720.799772007959;5724.026915424388;5726.055200891889;3753.9249215015548;4903.239997800347;4923.163062279421;4973.030259099513;4974.751262436864;4396.164728701537;4420.3590479380955;4430.756308403069;4455.309427038814;4481.529439408815;5632.098864181711;5730.856728581819;5736.196932429463;5736.77052917887;5747.798827041033;6099.733521241345;6132.355508992456;6150.200473938449;6287.434130928147;6291.905621415683;5669.121286200645;5707.600467967285;5716.085426331767;5738.655680659173;5785.103308987113;5325.653832500875;5368.275282836845;5377.489138531833;5377.973110134424;5387.784488620411;6268.27914789805;6310.9368906311265;6329.7468101275435;6339.936600634119;6346.777862774781;6126.059675755388;6201.007838745779;6205.906911396242;6294.3076261612105;6305.716242769178;6324.588901721373;6325.462335701517;6336.904946425715;6347.587406818542;6351.936480635134;5124.205748109049;5963.3142188647125;6132.5707200495535;6185.134081228722;6199.56603037783;4839.927401089057;6155.569110162246;6157.599756015845;6166.969165154145;6209.565330427007;5057.266696329085;6051.3948605140895;6057.303410107894;6059.09113632941;6121.938780612137;6047.516198704181;6059.121427392915;6065.302490213506;6074;6076.240469941257;5764.13537969308;5812;5857.092150716646;5865.501432378295;5912.615679980788;6006.249218847644;6095.512359011357;6105.520399749632;6109.7861574844665;6117.357677443804;5718.971405142947;5778.422157784188;5929.762809487572;5934.732937017931;5937.9406205937385 08:54:02 INFO - PROCESS | 1649 | |1;ext.html;466.71763583032265;510.57622173595905;524.2817340243867;524.6484855147052;579.9971000145001;29943;31365.059048228562;37730.24539509212;38722.838314850596;38809;40141.59858401415;40380.19239615206;40461.797691011576;40588.79705601475;40623.984400389934;9015.684451044232;9206.49364284964;9220.400673956205;9226.907730922672;9248.53757312135;8375.95812020939;8596.441231319975;8606.56967151643;8714.433561818461;8715.694950676727;10949.45252737364;11193.216474846764;11198.160137989642;11382.829257561143;11390.08879289659;11065.50205240762;11153.330800151936;11158.442077896154;11161.38612376323;11168.776624467466;8243.422960392774;8467.915320846774;11034.944825275823;11102.55589776408;11127.998480136746;30722;31052.37895242105;31103.22241943947;37716.62283377159;38328.61671383278;3278.065751260879;3344.9832750836335;3360.663933606644;3748.475213470116;3838.9040273993096;28766;29042;29533.70466295331;29626.407471850656;30097.699023009707;3132.37352529495;3160.8261545614982;3161.2571045804216;3239.222586579204;3267.3628642414737;336590;425212.8739356314;426393;426826;429439.85280073714;55422.44577554253;55702.442975570535;55808.72095639577;55840;56021.879562408525;57624;58121.128183077286;58134.418655813744;58205;58324.70837645869;13098.148620339647;13386.866131338562;13390.598282051555;13421.865781342061;13422.664433389244;10632.94683526593;10918.672439826818;11010.229283950206;11018.44907754609;11027.724306892393;13906.887449004056;14215.715685686228;14232.28838558068;15085.170315632746;15775.684486310209;6755.763548275787;6970.372666460043;6975.651217439209;7033.2966703330285;7086.964565177244;832.6960659359412;866.6316815353449;950.7575568230195;966.5022513405602;991.8264303746815;28628.85685571559;28646.28384290368;29138.56292155577;29501.409971800444;29519.704802951695;992.4095163377779;999.7950420163849;1036.3988886445993;1060.4697651174413;1072.5763323487179;13105.541306054241;14063.718725625431;14769.04001239916;15159;15208;616429;622053;622076;622086;622169;38831.80584097118;48007.27989080166;53153;54073.459265407626;54386.45613543893;1304.315234501894;1323.7484877873173;1345.5761435148092;1355.6949686320697;1357.8438479574975;29387.412251754417;29572;29740.553891692074;29849.850750746107;30298;39723;51480.22779658233;52772.472275276756;52917.7354113227;55956.44043559513;556127.2193639006;580681;585013;589953;773641;24107.15624953118;24252.90861911183;24281.75718242795;24652.013919443023;24658.506829862945;41901.79049104735;42395;42748.358774619024;42901.57098429101;42976.78511607422;35254.64745352514;35743;36027.459588105674;36054.8197259012;36251.912442626766;34126;35149.64850351464;35173.47239791354;35299.47050794292;35879.282414351044;26782.330441739112;34809;35255.76604818819;35810.8209458951;36061.45907811332;30202.24494387658;31325.843370783;31481.68518314879;31556;31590;20831.791682082985;22699.09203631836;23718.881405592863;23817.642735358637;24279.393015174763 08:54:02 INFO - PROCESS | 1649 | |2;jquery.html;350.2399792450382;366.71029886389755;367.9153794627236;379.0826200594561;397.7971234670317;14722.631934201638;14995.825605287228;15545.689086218283;19202.807971920312;20197.39407817764;19133.234670613158;19450.41648750536;20061.297854575092;20108.195672173133;20310.18759249632;5579.581531385142;5881.617694849821;5882.323532793741;5895.705214739267;5896.734646940877;4082.203970225807;4310.267254566716;4415.324885789142;5765.394633563478;5829;4300.526942036374;5973.731182096816;6259.749610015594;6277.497800175998;6359.777407790728;6070.6357618543025;6296.685165741695;6316.3683631636695;6339.1442155308905;6374.745010199586;5543.833684989457;5551.472610102074;5555.972220138873;5556;5560.972195139039;23918.76081239183;24010.79946002693;24600.753992460206;24980.875095624586;25162.370940726447;1995.760508738946;2194.473326401668;2419.22584772871;2551.413174969749;2567.6276939843806;5680.176374425727;5734.856628584277;9503.477308748015;9941.409374500117;10233.846492302622;1748.3968031029274;1793.1213705284447;1872.7003679411364;1876.859235557325;1882.3223639489772;107407;112489.43755281252;113059;113746.72506549905;114240.99999999917;10979.780404392028;11107.611233606947;11157.330560166416;11286.065622938095;11488.080953523699;13842.238676872666;14192.574222773334;14209.005369624027;14215.289235538388;14222.573322800332;7618.4667073305445;7691.153973062958;7808;7905.407094467938;7990.320822730133;7599.810004749815;7610.809729756689;7764.145943946161;7775.377969762406;7785.416093792988;4334.523202447728;4500.054988452396;4503.54964503547;4508.413906192174;4582.816687332536;1591.4270862489495;1631.2740830330627;1718.269735362466;1873.594803897077;1891.7514440469224;660.3660485933461;698.8392669686001;856.8286342731478;862.9180227878342;929.8837645294338;19643.803561964483;20547.8972605136;20622.79377206239;20920.37238882836;22239.44401389978;918.779492921694;922.3359181389388;923.6490133749132;936.765808547863;952.623713633111;10663.89336106629;11017.228793984345;11099.112071034298;11108.666739997652;11133.832992505118;562833;569998.0500682456;576031;576311.4847832494;585409;102774.97225027654;130545.69454305335;132446.33776831054;135548.99999999802;136371;867.6702852915978;975.190591808797;979.7550612346913;998.6804222648683;1000.6947880896397;16425.589360266087;18197.818021819614;18230.635387292445;18238.635227295115;18608.3252507275;48815;52030.479695202564;55933;56594;56627;63701.362986369546;73294.53410931645;73439.26560734538;76685.61657191678;78749.60625196838;6562.639054851838;7075.469339799432;7136.3220494052985;7273.0908636420445;7885.881711774443;9794.412335259907;11529.538818447169;11642.592509262475;12043.217190882564;12524.37378131108;10126.44304563256;10304.381737095799;10603.8939610606;10818.459077046273;10823.051850666956;10137.23970702215;10364.792704146026;10433.373997560171;10753.46232688378;10777.407242601732;10460.215483838894;10867.673969780919;11073.889261107286;11110.777814440244;11247.662570122582;7136.3934065602925;7243.963780181065;7321.524100933422;7421.888671669822;7487.737929172453;9825.754356141153;10508.684739457829;10813.189010824377;10837.187210959051;10858.457077145953 08:54:02 INFO - PROCESS | 1649 | |3;mootools.html;1260.7919693250615;1431.6420894776302;1538.2923855026688;1743.389813565253;1775.7957834848987;7965.482243654165;8374.371922105836;8406.873896891551;8411.200935911087;8421.789455263613;7188.173360063594;7468.551886886777;7476.9252307477045;7583.810404739885;7630.351420129296;2058.8558800883907;2100.71640328556;2209.569134018867;2282.3837563857746;2284.1434462076722;2274.37454699958;2279.099755596538;2281.4638559938403;2283.7830406111393;2289.473421113145;2250.1449449209276;2265.784750448705;2281.0191617604423;2282.805961493275;2283.6460348645987;2229.9665505017274;2231.6206244938317;2249.044156233594;2253.504229069602;2255.1768604459253;2255.154317131076;2255.909763609454;2283.235116236063;2285.8857057147243;2287.588234117858;8079.353651707849;8259.174082591693;8287.41988060836;8290.544020078893;8299.336053115736;4954.801807927679;5122.359705036871;5124;5132.486751324837;5134.845954621367;3271.9018429447156;3363.2006876321298;3431.739847145197;3454.654534546525;3460.809655468948;1009.7425156585098;1021.3820638513666;1026.1021606094666;1037.968860934173;1043.3635482355758;10785.029347358697;10794.136469082454;10829.133669306437;10867.945660271727;10895.346279223271;4111.527174374925;4271.124419493996;4276.465441819772;4387.473503179575;4390.165868484977;8371.916280837235;8387.287080598095;8398.454100483448;8565.05784363732;8575.356848236408;5009.499050094962;5011.899762004739;5016.949830501721;5020;5023.8492845214705;4474.172278128557;4625.283081122431;4699.78850951708;4704.200285951328;4713.858584242478;3363.983180084084;3446.276281980762;3558.62634423387;3603.6036036036016;3651.1784848408897;1122.0238392598328;1124.8256520239377;1133.348324713293;1133.7619099988929;1140.4696815980608;744.0996394362882;823.3618945317307;889.8175873945955;891.0732837848694;902.2105657549644;4565.373474288787;5220.309862250089;5372.247885296062;5698.1737648041635;5714.771409143671;777.9260970207821;879.3053487744738;913.4245425381966;949.093615597103;957.4781743949565;3328.5839270091237;3587.1749497615174;3680.190358121209;3690.2988432197794;3817.541894972621;9403.717888463358;9756.975517570552;9922;10060.849087263698;10068.993100690019;9799.216062715108;10002;10009.949950250348;10022.398656080659;10029.448380339152;7209.423246140296;7663.923360766321;7681.769546913713;7744.845103097907;7757.844843103219;4647.488776234679;5354.571634269171;5395.947790180877;5419.485148910847;5666.660000399989;9305.581248843953;9441.073267287164;9443.527823608929;9453.716388508356;9455.007224241355;9292.535373231176;9341.719748407559;9519.143277105093;9543.47510886908;9562.426254424758;6589.5387322888855;6672.499562532732;6674.799756007327;6675.7997260082275;6676.566023208476;6953.513254072166;7062.1878483975;7208.495405321787;7669.884951725617;7776.300132987832;6642.402183803288;6815.114035175594;7053.224145344111;7140.428765698628;7171.605561694157;6391.552591318563;6401.647909364843;6495.935040649533;6563.507736919845;6602.504812139013;6453.645049522133;6464.773732919325;6558;6599.175103112111;6624.6025238485845;4662.184117779308;4709.3502535535235;4802.27965805132;4810.037992401603;4830.7101573905675;4764.094821983812;4766.475687674284;4875.414950205998;4918.491569299611;4922.4339200992345 08:54:02 INFO - PROCESS | 1649 | |4;prototype.html;291.740351087532;294.89383821824146;301.52509797069615;306.2542708504791;306.8404429696559;4673.789679464424;4872.293517439969;5150.171689050389;5213.715359323621;5220.399654039787;4128.958710412902;4223;4235.366961940619;4729.054189162172;5087.2608632654965;3409.6419875913043;3422.8288585570745;3911.4523966644692;3961.5642279349395;3992.860249891254;3960.7623542587394;3969.166475040245;3969.5435024972066;3973.3443981742976;3973.9801300993454;3211.710946014858;3512.7189824813954;3596.568411790589;3868.1490072184074;3942.172143849795;3364.680355366236;3732.440133979911;3904.472896159039;3918.74528155669;3922.0783115967724;2692.932676683079;2788.9023884163958;2909.941801163986;3378.577677790276;3393.117789374756;4889.828855990023;4963.379577552806;5026.396832380101;5053.9241911371355;5058.8870448501275;4116.773577453238;4323.200207961537;4413.558644135593;4439.734675617434;4441.912870554966;5072.112380333427;5330.227117068042;5336.226247194174;5342.252084708144;5361.731913404315;3201.9199520011953;3676.7242456815848;3680.3191409589044;3681.0490440066806;3693.5567731872347;5357.000079955199;5513.2005859150195;5544.417836127229;5556.611037227396;5642.069058605366;3712.9628703713156;3716.2567486502808;3734.7572407793405;3737.1404576947452;3744.26986737589;3547.4324108142573;3698.556173259226;3763.3414152523746;3771.47255361579;3774.47157397959;4404.537523560044;4407.977960110243;4410.184115938561;4421.673497950602;4434.689571729948;4586.2661974083985;5154.118746657443;5437.891242175135;5441.972790136024;5479.643823151562;1074.301703892476;1075.6074032977906;1114.587602587048;1244.6328333141746;1246.9251844889336;768.2202564397141;785.6346798738614;788.5623478969112;803.7869964459423;839.2572573272697;3941.4825292262685;4197.412362269285;4798.632389768899;4856.236416777026;4858.80564777412;4757.976210118996;5232.843014709565;5263.3947096083675;5272.420033796279;5285.339332583427;4323.870283891489;4583.175028494903;4591.212249893851;4839.749516474856;4875.780589873464;2538.2639034680105;2583.687599598349;2757.972889925903;2786.3312804926672;2823.317848044366;4985.55130038291;5583.4137415571595;5595.580331475156;5612.494875461228;5613.522850557748;4537.912560222268;5267.578593712494;5433.809816656477;5475.808346707846;5503.724813759376;4420.38070216618;4808.3027960945465;4996.6752161110135;5230.372355317386;5407.918881216785;4988.650794444354;5027.371578552681;5236.764345604381;5262.710890624129;5347.5721942243745;4537.574131530673;4931;4962.131626965339;5622.522085622604;5667.603267771216;4863.908519336719;5825.883482330414;5908.822735317947;5910;5918.822435326947;3055.601352937933;3534.505169276355;3694.796786176786;3732.42147467143;3814.6757525610633;4539.863804085882;5245.554127899019;5578.884223155466;5631.577631677558;5668.433156684298;4905.926411103765;5209.817656382009;5370.382406023357;5496;5539.642787517084;4695.309688512201;5214.869628259324;5272.6309158358545;5495.972520137374;5504.4770746778995;5321.946780532146;5347.358317001985;5386.730663466733;5388.407275199804;5391.7304134793885;4498.875281179705;4539.477960034506;4910.82812101589;5360.303160589098;5404.378496472956;5356.732163391737;5378.757955891916;5396.0556902542685;5398.64908780928;5400.891982160256 08:54:02 INFO - PROCESS | 1649 | |5;yui.html;644.8130042287737;727.2872584866834;752.6575408189275;775.4638846858327;783.9412044096695;13832.58502244933;15407.76888346673;15632.609184770357;15657.217139143055;15683.372665093397;11462.770744585103;13173.341332933363;13490.258035808027;13669.453221871114;13932.233727145029;779.9766007019798;796.080526991323;796.8565658181525;797.9481333713319;798.9760307190764;629.7638385605399;653.0824192010233;654.5679851298145;774.6320497763573;780.1730166024005;801.7795106345743;805.118395357083;833.9666413343459;838.4005436113177;840.6385254340631;814.9837003259931;827.8302947895697;832.3216578488513;833.0336809301242;835.419383528448;481.49683580658296;493.59525189344754;605.6093819486407;607.4017093163275;608.8325710429623;12562.74874502514;12713.491460341575;12745.299008554526;12745.980321574252;14150.36323365451;13890.374933128034;14434.422623095168;14468.421263149461;14478.276086195649;14534.34595443197;11742.823857642143;11921.463534140985;12065.034797216202;12070.275783452933;12344.691382715415;3071.385722855438;3440.569928758905;3610.277944411102;3814.0846196912817;3832.9808350958347;102938;113997;115854.42072789666;117685;118296.40851795772;11138.164637652046;11241.943790280997;11252.943735281271;11274.210805243718;11459.598914038135;22646.66030009551;22663.546729065656;22679.88660056722;22682.773172268066;22684.206052788075;7822.374210063182;7906.446548741533;7991.720289789946;8067.273945344947;8175.918240817635;4222.978885105555;4271.273883439822;4363.040131171138;4428.202923473741;4494.37078808967;3387.4410722230555;3495.07380544156;3495.2310491691787;3497.5453191085503;3500.824958752103;546.2325432766969;602.6504627316234;602.8944934636421;628.214731585518;637.528229110455;601.5338112962402;639.6705149695915;650.830783996155;664.8836453620597;668.201499208451;9123.635054597742;9164.587593558306;9410.95294523523;9416.340856140005;9586.281028922858;633.1642232253473;669.3908543225641;669.5112567825514;671.5097978475642;673.1451057157383;4039.8788036358956;4399.714018588781;4578.748168850679;4602.815887364468;4608.331791890158;84361;98931.51602725965;107865.92134078716;112459.43770281096;114906;97570.51214744023;98022.50988745011;99626.50186749165;100758.49620751996;101178.25769765001;69533;86077;86157.13842861616;87409;89882.55058724796;7451.888221676788;8766.693165739169;8933.240674542476;9088.63645454201;9088.772780680536;39537.80231098826;51115.233271501704;54233.18650220171;55220.34338969837;56468.7176564131;65610.67194663997;73051.63474182595;73843.26156738364;82781.17218827734;85324;12654;13359.666008349868;14092.859071409155;14178.929105354408;14240.287985600471;14753.316440602517;15111.058308706066;15225.838633246041;15412.46056388021;15698;13737;14058.789118163031;14192.574222773334;14211.147331160164;14564.708705826037;14120.293985300488;14198.29008549589;14237.422552664188;14378.784318235445;14390.28048597545;13576.728465430439;13727.245001524612;13772.793408098687;13931.58205253844;14531;10935.28920620157;11304.773904522028;11541.192116551762;11669.990178279102;12065.758684826429;11362.502245554015;11608;11617.244879082833;11681.532738690357;11707.88292117068 08:54:02 INFO - PROCESS | 1649 | __end_tp_report 08:54:02 INFO - PROCESS | 1649 | __start_cc_report 08:54:02 INFO - PROCESS | 1649 | _x_x_mozilla_cycle_collect,2084 08:54:02 INFO - PROCESS | 1649 | __end_cc_report 08:54:02 INFO - PROCESS | 1649 | __startTimestamp1481129642060__endTimestamp 08:54:02 INFO - PROCESS | 1649 | 08:54:02 INFO - PROCESS | 1649 | ------- Summary: start ------- 08:54:02 INFO - PROCESS | 1649 | Number of tests: 6 08:54:02 INFO - PROCESS | 1649 | 08:54:02 INFO - PROCESS | 1649 | [#0] dojo.html Cycles:165 Average:5685.67 Median:5778.42 stddev:661.62 (11.4%) stddev-sans-first:621.23 08:54:02 INFO - PROCESS | 1649 | Values: 2714.2 3337.9 3357.9 3388.5 3413.9 5551.0 5605.0 5664.7 5681.0 5720.7 5628.2 5656.5 5695.4 5701.6 5738.3 5092.1 5107.6 5107.9 5125.9 5201.6 5295.6 5314.0 5329.0 5338.4 5368.8 5122.4 5248.3 5270.2 5283.4 5353.7 5157.5 5195.8 5201.9 5204.1 5206.9 5097.7 5168.4 5179.0 5183.1 5194.7 5629.9 5632.4 5641.7 5645.3 5660.1 6126.9 6127.8 6144.8 6149.1 6192.6 6300.4 6319.1 6321.6 6322.1 6340.7 5683.9 5773.7 5786.6 5795.7 5835.9 6252.4 6294.7 6298.7 6364.7 6373.7 6067.2 6112.6 6133.8 6140.5 6148.4 6275.7 6276.0 6277.3 6282.8 6301.9 5644.8 6197.9 6206.5 6209.6 6209.7 5666.9 5719.1 5720.8 5724.0 5726.1 3753.9 4903.2 4923.2 4973.0 4974.8 4396.2 4420.4 4430.8 4455.3 4481.5 5632.1 5730.9 5736.2 5736.8 5747.8 6099.7 6132.4 6150.2 6287.4 6291.9 5669.1 5707.6 5716.1 5738.7 5785.1 5325.7 5368.3 5377.5 5378.0 5387.8 6268.3 6310.9 6329.7 6339.9 6346.8 6126.1 6201.0 6205.9 6294.3 6305.7 6324.6 6325.5 6336.9 6347.6 6351.9 5124.2 5963.3 6132.6 6185.1 6199.6 4839.9 6155.6 6157.6 6167.0 6209.6 5057.3 6051.4 6057.3 6059.1 6121.9 6047.5 6059.1 6065.3 6074.0 6076.2 5764.1 5812.0 5857.1 5865.5 5912.6 6006.2 6095.5 6105.5 6109.8 6117.4 5719.0 5778.4 5929.8 5934.7 5937.9 08:54:02 INFO - PROCESS | 1649 | 08:54:02 INFO - PROCESS | 1649 | [#1] ext.html Cycles:180 Average:66829.35 Median:35255.21 stddev:150185.65 (426.0%) stddev-sans-first:150524.31 08:54:02 INFO - PROCESS | 1649 | Values: 466.7 510.6 524.3 524.6 580.0 29943.0 31365.1 37730.2 38722.8 38809.0 40141.6 40380.2 40461.8 40588.8 40624.0 9015.7 9206.5 9220.4 9226.9 9248.5 8376.0 8596.4 8606.6 8714.4 8715.7 10949.5 11193.2 11198.2 11382.8 11390.1 11065.5 11153.3 11158.4 11161.4 11168.8 8243.4 8467.9 11034.9 11102.6 11128.0 30722.0 31052.4 31103.2 37716.6 38328.6 3278.1 3345.0 3360.7 3748.5 3838.9 28766.0 29042.0 29533.7 29626.4 30097.7 3132.4 3160.8 3161.3 3239.2 3267.4 336590.0 425212.9 426393.0 426826.0 429439.9 55422.4 55702.4 55808.7 55840.0 56021.9 57624.0 58121.1 58134.4 58205.0 58324.7 13098.1 13386.9 13390.6 13421.9 13422.7 10632.9 10918.7 11010.2 11018.4 11027.7 13906.9 14215.7 14232.3 15085.2 15775.7 6755.8 6970.4 6975.7 7033.3 7087.0 832.7 866.6 950.8 966.5 991.8 28628.9 28646.3 29138.6 29501.4 29519.7 992.4 999.8 1036.4 1060.5 1072.6 13105.5 14063.7 14769.0 15159.0 15208.0 616429.0 622053.0 622076.0 622086.0 622169.0 38831.8 48007.3 53153.0 54073.5 54386.5 1304.3 1323.7 1345.6 1355.7 1357.8 29387.4 29572.0 29740.6 29849.9 30298.0 39723.0 51480.2 52772.5 52917.7 55956.4 556127.2 580681.0 585013.0 589953.0 773641.0 24107.2 24252.9 24281.8 24652.0 24658.5 41901.8 42395.0 42748.4 42901.6 42976.8 35254.6 35743.0 36027.5 36054.8 36251.9 34126.0 35149.6 35173.5 35299.5 35879.3 26782.3 34809.0 35255.8 35810.8 36061.5 30202.2 31325.8 31481.7 31556.0 31590.0 20831.8 22699.1 23718.9 23817.6 24279.4 08:54:02 INFO - PROCESS | 1649 | 08:54:02 INFO - PROCESS | 1649 | [#2] jquery.html Cycles:180 Average:33653.39 Median:358.48 stddev:95978.87 (26774.2%) stddev-sans-first:96215.54 08:54:02 INFO - PROCESS | 1649 | Values: 350.2 366.7 367.9 379.1 397.8 14722.6 14995.8 15545.7 19202.8 20197.4 19133.2 19450.4 20061.3 20108.2 20310.2 5579.6 5881.6 5882.3 5895.7 5896.7 4082.2 4310.3 4415.3 5765.4 5829.0 4300.5 5973.7 6259.7 6277.5 6359.8 6070.6 6296.7 6316.4 6339.1 6374.7 5543.8 5551.5 5556.0 5556.0 5561.0 23918.8 24010.8 24600.8 24980.9 25162.4 1995.8 2194.5 2419.2 2551.4 2567.6 5680.2 5734.9 9503.5 9941.4 10233.8 1748.4 1793.1 1872.7 1876.9 1882.3 107407.0 112489.4 113059.0 113746.7 114241.0 10979.8 11107.6 11157.3 11286.1 11488.1 13842.2 14192.6 14209.0 14215.3 14222.6 7618.5 7691.2 7808.0 7905.4 7990.3 7599.8 7610.8 7764.1 7775.4 7785.4 4334.5 4500.1 4503.5 4508.4 4582.8 1591.4 1631.3 1718.3 1873.6 1891.8 660.4 698.8 856.8 862.9 929.9 19643.8 20547.9 20622.8 20920.4 22239.4 918.8 922.3 923.6 936.8 952.6 10663.9 11017.2 11099.1 11108.7 11133.8 562833.0 569998.1 576031.0 576311.5 585409.0 102775.0 130545.7 132446.3 135549.0 136371.0 867.7 975.2 979.8 998.7 1000.7 16425.6 18197.8 18230.6 18238.6 18608.3 48815.0 52030.5 55933.0 56594.0 56627.0 63701.4 73294.5 73439.3 76685.6 78749.6 6562.6 7075.5 7136.3 7273.1 7885.9 9794.4 11529.5 11642.6 12043.2 12524.4 10126.4 10304.4 10603.9 10818.5 10823.1 10137.2 10364.8 10433.4 10753.5 10777.4 10460.2 10867.7 11073.9 11110.8 11247.7 7136.4 7244.0 7321.5 7421.9 7487.7 9825.8 10508.7 10813.2 10837.2 10858.5 08:54:02 INFO - PROCESS | 1649 | 08:54:02 INFO - PROCESS | 1649 | [#3] mootools.html Cycles:180 Average:5281.32 Median:5014.42 stddev:2916.95 (58.2%) stddev-sans-first:2909.48 08:54:02 INFO - PROCESS | 1649 | Values: 1260.8 1431.6 1538.3 1743.4 1775.8 7965.5 8374.4 8406.9 8411.2 8421.8 7188.2 7468.6 7476.9 7583.8 7630.4 2058.9 2100.7 2209.6 2282.4 2284.1 2274.4 2279.1 2281.5 2283.8 2289.5 2250.1 2265.8 2281.0 2282.8 2283.6 2230.0 2231.6 2249.0 2253.5 2255.2 2255.2 2255.9 2283.2 2285.9 2287.6 8079.4 8259.2 8287.4 8290.5 8299.3 4954.8 5122.4 5124.0 5132.5 5134.8 3271.9 3363.2 3431.7 3454.7 3460.8 1009.7 1021.4 1026.1 1038.0 1043.4 10785.0 10794.1 10829.1 10867.9 10895.3 4111.5 4271.1 4276.5 4387.5 4390.2 8371.9 8387.3 8398.5 8565.1 8575.4 5009.5 5011.9 5016.9 5020.0 5023.8 4474.2 4625.3 4699.8 4704.2 4713.9 3364.0 3446.3 3558.6 3603.6 3651.2 1122.0 1124.8 1133.3 1133.8 1140.5 744.1 823.4 889.8 891.1 902.2 4565.4 5220.3 5372.2 5698.2 5714.8 777.9 879.3 913.4 949.1 957.5 3328.6 3587.2 3680.2 3690.3 3817.5 9403.7 9757.0 9922.0 10060.8 10069.0 9799.2 10002.0 10009.9 10022.4 10029.4 7209.4 7663.9 7681.8 7744.8 7757.8 4647.5 5354.6 5395.9 5419.5 5666.7 9305.6 9441.1 9443.5 9453.7 9455.0 9292.5 9341.7 9519.1 9543.5 9562.4 6589.5 6672.5 6674.8 6675.8 6676.6 6953.5 7062.2 7208.5 7669.9 7776.3 6642.4 6815.1 7053.2 7140.4 7171.6 6391.6 6401.6 6495.9 6563.5 6602.5 6453.6 6464.8 6558.0 6599.2 6624.6 4662.2 4709.4 4802.3 4810.0 4830.7 4764.1 4766.5 4875.4 4918.5 4922.4 08:54:02 INFO - PROCESS | 1649 | 08:54:02 INFO - PROCESS | 1649 | [#4] prototype.html Cycles:180 Average:4293.84 Median:4824.03 stddev:1342.03 (27.8%) stddev-sans-first:1311.74 08:54:02 INFO - PROCESS | 1649 | Values: 291.7 294.9 301.5 306.3 306.8 4673.8 4872.3 5150.2 5213.7 5220.4 4129.0 4223.0 4235.4 4729.1 5087.3 3409.6 3422.8 3911.5 3961.6 3992.9 3960.8 3969.2 3969.5 3973.3 3974.0 3211.7 3512.7 3596.6 3868.1 3942.2 3364.7 3732.4 3904.5 3918.7 3922.1 2692.9 2788.9 2909.9 3378.6 3393.1 4889.8 4963.4 5026.4 5053.9 5058.9 4116.8 4323.2 4413.6 4439.7 4441.9 5072.1 5330.2 5336.2 5342.3 5361.7 3201.9 3676.7 3680.3 3681.0 3693.6 5357.0 5513.2 5544.4 5556.6 5642.1 3713.0 3716.3 3734.8 3737.1 3744.3 3547.4 3698.6 3763.3 3771.5 3774.5 4404.5 4408.0 4410.2 4421.7 4434.7 4586.3 5154.1 5437.9 5442.0 5479.6 1074.3 1075.6 1114.6 1244.6 1246.9 768.2 785.6 788.6 803.8 839.3 3941.5 4197.4 4798.6 4856.2 4858.8 4758.0 5232.8 5263.4 5272.4 5285.3 4323.9 4583.2 4591.2 4839.7 4875.8 2538.3 2583.7 2758.0 2786.3 2823.3 4985.6 5583.4 5595.6 5612.5 5613.5 4537.9 5267.6 5433.8 5475.8 5503.7 4420.4 4808.3 4996.7 5230.4 5407.9 4988.7 5027.4 5236.8 5262.7 5347.6 4537.6 4931.0 4962.1 5622.5 5667.6 4863.9 5825.9 5908.8 5910.0 5918.8 3055.6 3534.5 3694.8 3732.4 3814.7 4539.9 5245.6 5578.9 5631.6 5668.4 4905.9 5209.8 5370.4 5496.0 5539.6 4695.3 5214.9 5272.6 5496.0 5504.5 5321.9 5347.4 5386.7 5388.4 5391.7 4498.9 4539.5 4910.8 5360.3 5404.4 5356.7 5378.8 5396.1 5398.6 5400.9 08:54:02 INFO - PROCESS | 1649 | 08:54:02 INFO - PROCESS | 1649 | [#5] yui.html Cycles:180 Average:21455.52 Median:21788.84 stddev:31669.92 (145.3%) stddev-sans-first:31720.21 08:54:02 INFO - PROCESS | 1649 | Values: 644.8 727.3 752.7 775.5 783.9 13832.6 15407.8 15632.6 15657.2 15683.4 11462.8 13173.3 13490.3 13669.5 13932.2 780.0 796.1 796.9 797.9 799.0 629.8 653.1 654.6 774.6 780.2 801.8 805.1 834.0 838.4 840.6 815.0 827.8 832.3 833.0 835.4 481.5 493.6 605.6 607.4 608.8 12562.7 12713.5 12745.3 12746.0 14150.4 13890.4 14434.4 14468.4 14478.3 14534.3 11742.8 11921.5 12065.0 12070.3 12344.7 3071.4 3440.6 3610.3 3814.1 3833.0 102938.0 113997.0 115854.4 117685.0 118296.4 11138.2 11241.9 11252.9 11274.2 11459.6 22646.7 22663.5 22679.9 22682.8 22684.2 7822.4 7906.4 7991.7 8067.3 8175.9 4223.0 4271.3 4363.0 4428.2 4494.4 3387.4 3495.1 3495.2 3497.5 3500.8 546.2 602.7 602.9 628.2 637.5 601.5 639.7 650.8 664.9 668.2 9123.6 9164.6 9411.0 9416.3 9586.3 633.2 669.4 669.5 671.5 673.1 4039.9 4399.7 4578.7 4602.8 4608.3 84361.0 98931.5 107865.9 112459.4 114906.0 97570.5 98022.5 99626.5 100758.5 101178.3 69533.0 86077.0 86157.1 87409.0 89882.6 7451.9 8766.7 8933.2 9088.6 9088.8 39537.8 51115.2 54233.2 55220.3 56468.7 65610.7 73051.6 73843.3 82781.2 85324.0 12654.0 13359.7 14092.9 14178.9 14240.3 14753.3 15111.1 15225.8 15412.5 15698.0 13737.0 14058.8 14192.6 14211.1 14564.7 14120.3 14198.3 14237.4 14378.8 14390.3 13576.7 13727.2 13772.8 13931.6 14531.0 10935.3 11304.8 11541.2 11670.0 12065.8 11362.5 11608.0 11617.2 11681.5 11707.9 08:54:02 INFO - PROCESS | 1649 | -------- Summary: end -------- 08:54:02 INFO - PROCESS | 1649 | 08:54:02 INFO - TEST-INFO | 1649: exit 0 08:54:02 INFO - TEST-OK | dromaeo_css | took 1120232ms 08:54:02 INFO - TEST-START | kraken 08:54:02 INFO - operating with platform_type : mac_ 08:54:02 INFO - Initialising browser for kraken test... 08:54:02 INFO - TEST-INFO | started process 1654 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/1b/b370xjvx7_vbkyyr8hgyjzcm00000w/T/tmpRLabtn/profile http://localhost:49243/getInfo.html) 08:54:05 INFO - PROCESS | 1654 | __metrics Screen width/height:1600/1200 08:54:05 INFO - PROCESS | 1654 | colorDepth:24 08:54:05 INFO - PROCESS | 1654 | Browser inner width/height: 1024/689 08:54:05 INFO - PROCESS | 1654 | __metrics 08:54:05 INFO - PROCESS | 1654 | 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:54:05 INFO - PROCESS | 1654 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:54:06 INFO - TEST-INFO | 1654: exit 0 08:54:06 INFO - Browser initialized. 08:54:06 INFO - Running cycle 1/1 for kraken test... 08:54:06 INFO - TEST-INFO | started process 1655 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/1b/b370xjvx7_vbkyyr8hgyjzcm00000w/T/tmpRLabtn/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:54:18 INFO - PROCESS | 1655 | RSS: Main: 243097600 08:54:18 INFO - PROCESS | 1655 | 08:54:21 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49243/tests/kraken/driver.html?testName=audio-beat-detection) 08:54:22 INFO - PROCESS | 1655 | RSS: Main: 293548032 08:54:22 INFO - PROCESS | 1655 | 08:54:24 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49243/tests/kraken/driver.html?testName=audio-dft) 08:54:25 INFO - PROCESS | 1655 | RSS: Main: 295948288 08:54:25 INFO - PROCESS | 1655 | 08:54:28 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49243/tests/kraken/driver.html?testName=audio-fft) 08:54:29 INFO - PROCESS | 1655 | RSS: Main: 386625536 08:54:29 INFO - PROCESS | 1655 | 08:54:31 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49243/tests/kraken/driver.html?testName=audio-oscillator) 08:54:31 INFO - PROCESS | 1655 | RSS: Main: 290238464 08:54:31 INFO - PROCESS | 1655 | 08:54:34 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49243/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:54:34 INFO - PROCESS | 1655 | RSS: Main: 293965824 08:54:34 INFO - PROCESS | 1655 | 08:54:37 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49243/tests/kraken/driver.html?testName=imaging-darkroom) 08:54:38 INFO - PROCESS | 1655 | RSS: Main: 336760832 08:54:38 INFO - PROCESS | 1655 | 08:54:40 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49243/tests/kraken/driver.html?testName=imaging-desaturate) 08:54:41 INFO - PROCESS | 1655 | RSS: Main: 339144704 08:54:41 INFO - PROCESS | 1655 | 08:54:44 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49243/tests/kraken/driver.html?testName=json-parse-financial) 08:54:45 INFO - PROCESS | 1655 | RSS: Main: 335802368 08:54:45 INFO - PROCESS | 1655 | 08:54:46 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49243/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:54:47 INFO - PROCESS | 1655 | RSS: Main: 309235712 08:54:47 INFO - PROCESS | 1655 | 08:54:49 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:54:49 INFO - PROCESS | 1655 | RSS: Main: 315465728 08:54:49 INFO - PROCESS | 1655 | 08:54:51 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:54:52 INFO - PROCESS | 1655 | RSS: Main: 315998208 08:54:52 INFO - PROCESS | 1655 | 08:54:55 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:54:56 INFO - PROCESS | 1655 | RSS: Main: 330743808 08:54:56 INFO - PROCESS | 1655 | 08:54:59 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:55:00 INFO - PROCESS | 1655 | RSS: Main: 328929280 08:55:00 INFO - PROCESS | 1655 | 08:55:01 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49243/tests/kraken/driver.html?testName=ai-astar) 08:55:02 INFO - PROCESS | 1655 | RSS: Main: 373252096 08:55:02 INFO - PROCESS | 1655 | 08:55:02 INFO - PROCESS | 1655 | __start_tp_report 08:55:02 INFO - PROCESS | 1655 | _x_x_mozilla_page_load 08:55:02 INFO - PROCESS | 1655 | _x_x_mozilla_page_load_details 08:55:02 INFO - PROCESS | 1655 | |i|pagename|runs| 08:55:02 INFO - PROCESS | 1655 | |0;ai-astar;115;115;115;113;114;126;171;152;113;113 08:55:02 INFO - PROCESS | 1655 | |1;audio-beat-detection;142;112;111;145;97;127;140;140;132;112 08:55:02 INFO - PROCESS | 1655 | |2;audio-dft;190;183;180;182;182;181;185;261;182;182 08:55:02 INFO - PROCESS | 1655 | |3;audio-fft;79;59;57;86;62;60;62;67;65;66 08:55:02 INFO - PROCESS | 1655 | |4;audio-oscillator;87;73;86;70;70;94;101;67;69;84 08:55:02 INFO - PROCESS | 1655 | |5;imaging-gaussian-blur;88;85;88;86;88;84;89;85;93;132 08:55:02 INFO - PROCESS | 1655 | |6;imaging-darkroom;94;94;95;100;93;94;94;98;94;94 08:55:02 INFO - PROCESS | 1655 | |7;imaging-desaturate;86;84;84;86;87;83;87;87;87;84 08:55:02 INFO - PROCESS | 1655 | |8;json-parse-financial;56;56;53;53;53;55;54;54;53;54 08:55:02 INFO - PROCESS | 1655 | |9;json-stringify-tinderbox;64;67;69;77;76;74;69;72;71;70 08:55:02 INFO - PROCESS | 1655 | |10;stanford-crypto-aes;89;88;88;87;86;86;78;99;98;105 08:55:02 INFO - PROCESS | 1655 | |11;stanford-crypto-ccm;148;154;159;147;134;178;160;154;238;157 08:55:02 INFO - PROCESS | 1655 | |12;stanford-crypto-pbkdf2;213;226;173;173;175;174;171;171;177;172 08:55:02 INFO - PROCESS | 1655 | |13;stanford-crypto-sha256-iterative;68;68;69;69;67;69;69;68;66;66 08:55:02 INFO - PROCESS | 1655 | __end_tp_report 08:55:02 INFO - PROCESS | 1655 | __start_cc_report 08:55:02 INFO - PROCESS | 1655 | _x_x_mozilla_cycle_collect,1983 08:55:02 INFO - PROCESS | 1655 | __end_cc_report 08:55:02 INFO - PROCESS | 1655 | __startTimestamp1481129702021__endTimestamp 08:55:02 INFO - PROCESS | 1655 | 08:55:02 INFO - PROCESS | 1655 | ------- Summary: start ------- 08:55:02 INFO - PROCESS | 1655 | Number of tests: 14 08:55:02 INFO - PROCESS | 1655 | 08:55:02 INFO - PROCESS | 1655 | [#0] ai-astar Cycles:10 Average:124.70 Median:115.00 stddev:20.27 (17.6%) stddev-sans-first:21.19 08:55:02 INFO - PROCESS | 1655 | Values: 115.0 115.0 115.0 113.0 114.0 126.0 171.0 152.0 113.0 113.0 08:55:02 INFO - PROCESS | 1655 | 08:55:02 INFO - PROCESS | 1655 | [#1] audio-beat-detection Cycles:10 Average:125.80 Median:140.00 stddev:16.68 (11.9%) stddev-sans-first:16.63 08:55:02 INFO - PROCESS | 1655 | Values: 142.0 112.0 111.0 145.0 97.0 127.0 140.0 140.0 132.0 112.0 08:55:02 INFO - PROCESS | 1655 | 08:55:02 INFO - PROCESS | 1655 | [#2] audio-dft Cycles:10 Average:190.80 Median:182.50 stddev:24.82 (13.6%) stddev-sans-first:26.33 08:55:02 INFO - PROCESS | 1655 | Values: 190.0 183.0 180.0 182.0 182.0 181.0 185.0 261.0 182.0 182.0 08:55:02 INFO - PROCESS | 1655 | 08:55:02 INFO - PROCESS | 1655 | [#3] audio-fft Cycles:10 Average:66.30 Median:65.50 stddev:9.24 (14.1%) stddev-sans-first:8.58 08:55:02 INFO - PROCESS | 1655 | Values: 79.0 59.0 57.0 86.0 62.0 60.0 62.0 67.0 65.0 66.0 08:55:02 INFO - PROCESS | 1655 | 08:55:02 INFO - PROCESS | 1655 | [#4] audio-oscillator Cycles:10 Average:80.10 Median:78.50 stddev:11.91 (15.2%) stddev-sans-first:12.37 08:55:02 INFO - PROCESS | 1655 | Values: 87.0 73.0 86.0 70.0 70.0 94.0 101.0 67.0 69.0 84.0 08:55:02 INFO - PROCESS | 1655 | 08:55:02 INFO - PROCESS | 1655 | [#5] imaging-gaussian-blur Cycles:10 Average:91.80 Median:88.00 stddev:14.36 (16.3%) stddev-sans-first:15.16 08:55:02 INFO - PROCESS | 1655 | Values: 88.0 85.0 88.0 86.0 88.0 84.0 89.0 85.0 93.0 132.0 08:55:02 INFO - PROCESS | 1655 | 08:55:02 INFO - PROCESS | 1655 | [#6] imaging-darkroom Cycles:10 Average:95.00 Median:94.00 stddev:2.21 (2.4%) stddev-sans-first:2.32 08:55:02 INFO - PROCESS | 1655 | Values: 94.0 94.0 95.0 100.0 93.0 94.0 94.0 98.0 94.0 94.0 08:55:02 INFO - PROCESS | 1655 | 08:55:02 INFO - PROCESS | 1655 | [#7] imaging-desaturate Cycles:10 Average:85.50 Median:86.50 stddev:1.58 (1.8%) stddev-sans-first:1.67 08:55:02 INFO - PROCESS | 1655 | Values: 86.0 84.0 84.0 86.0 87.0 83.0 87.0 87.0 87.0 84.0 08:55:02 INFO - PROCESS | 1655 | 08:55:02 INFO - PROCESS | 1655 | [#8] json-parse-financial Cycles:10 Average:54.10 Median:54.00 stddev:1.20 (2.2%) stddev-sans-first:1.05 08:55:02 INFO - PROCESS | 1655 | Values: 56.0 56.0 53.0 53.0 53.0 55.0 54.0 54.0 53.0 54.0 08:55:02 INFO - PROCESS | 1655 | 08:55:02 INFO - PROCESS | 1655 | [#9] json-stringify-tinderbox Cycles:10 Average:70.90 Median:71.50 stddev:4.01 (5.6%) stddev-sans-first:3.39 08:55:02 INFO - PROCESS | 1655 | Values: 64.0 67.0 69.0 77.0 76.0 74.0 69.0 72.0 71.0 70.0 08:55:02 INFO - PROCESS | 1655 | 08:55:02 INFO - PROCESS | 1655 | [#10] stanford-crypto-aes Cycles:10 Average:90.40 Median:88.00 stddev:7.90 (9.0%) stddev-sans-first:8.37 08:55:02 INFO - PROCESS | 1655 | Values: 89.0 88.0 88.0 87.0 86.0 86.0 78.0 99.0 98.0 105.0 08:55:02 INFO - PROCESS | 1655 | 08:55:02 INFO - PROCESS | 1655 | [#11] stanford-crypto-ccm Cycles:10 Average:162.90 Median:158.00 stddev:28.66 (18.1%) stddev-sans-first:29.89 08:55:02 INFO - PROCESS | 1655 | Values: 148.0 154.0 159.0 147.0 134.0 178.0 160.0 154.0 238.0 157.0 08:55:02 INFO - PROCESS | 1655 | 08:55:02 INFO - PROCESS | 1655 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:182.50 Median:174.50 stddev:19.82 (11.4%) stddev-sans-first:17.69 08:55:02 INFO - PROCESS | 1655 | Values: 213.0 226.0 173.0 173.0 175.0 174.0 171.0 171.0 177.0 172.0 08:55:02 INFO - PROCESS | 1655 | 08:55:02 INFO - PROCESS | 1655 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.90 Median:68.50 stddev:1.20 (1.7%) stddev-sans-first:1.27 08:55:02 INFO - PROCESS | 1655 | Values: 68.0 68.0 69.0 69.0 67.0 69.0 69.0 68.0 66.0 66.0 08:55:02 INFO - PROCESS | 1655 | -------- Summary: end -------- 08:55:02 INFO - PROCESS | 1655 | 08:55:03 INFO - TEST-INFO | 1655: exit 0 08:55:03 INFO - TEST-OK | kraken | took 60361ms 08:55:03 INFO - SUITE-END | took 1180s 08:55:03 INFO - Completed test suite (00:19:40) 08:55:03 INFO - javascript benchmark 08:55:03 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2714.2264454630426, 3337.916552086199, 3357.9160520986966, 3388.542546756187, 3413.8634454621815, 5550.972245138779, 5604.99110160171, 5664.660120392769, 5680.9999999999945, 5720.742566584503, 5628.212050312959, 5656.547476201904, 5695.373508914026, 5701.600887937846, 5738.340090889538, 5092.134337162673, 5107.565856902168, 5107.948920510785, 5125.948740512585, 5201.583873290147, 5295.629305948566, 5314.043472175007, 5328.9874923764555, 5338.439463856278, 5368.8389348319615, 5122.3853137623355, 5248.265242866002, 5270.183121616155, 5283.445238249986, 5353.732313384335, 5157.535821776059, 5195.844124676266, 5201.895962080737, 5204.063268611649, 5206.869828254286, 5097.745112744348, 5168.3797944246935, 5178.974105129488, 5183.118869792107, 5194.740262986873, 5629.8592535186535, 5632.436756324335, 5641.71791410432, 5645.32256129263, 5660.122680984454, 6126.853582554517, 6127.80043271483, 6144.787876364505, 6149.077638354238, 6192.628442293477, 6300.4329610334835, 6319.14691516644, 6321.620702757849, 6322.083297921776, 6340.651264180468, 5683.914741278884, 5773.711314434261, 5786.594938354359, 5795.710214489259, 5835.912461313083, 6252.406021427957, 6294.716737746812, 6298.71655775482, 6364.713587888464, 6373.71318290678, 6067.2112625359305, 6112.572119951649, 6133.754649814046, 6140.504248697391, 6148.415900489446, 6275.6862156892885, 6275.96862015687, 6277.278113016971, 6282.842928926722, 6301.873962520724, 5644.774209031675, 6197.907031394533, 6206.503479721611, 6209.565330426917, 6209.658468784261, 5666.886662266732, 5719.056355701346, 5720.799772007959, 5724.026915424388, 5726.055200891889, 3753.9249215015548, 4903.239997800347, 4923.163062279421, 4973.030259099513, 4974.751262436864, 4396.164728701537, 4420.3590479380955, 4430.756308403069, 4455.309427038814, 4481.529439408815, 5632.098864181711, 5730.856728581819, 5736.196932429463, 5736.77052917887, 5747.798827041033, 6099.733521241345, 6132.355508992456, 6150.200473938449, 6287.434130928147, 6291.905621415683, 5669.121286200645, 5707.600467967285, 5716.085426331767, 5738.655680659173, 5785.103308987113, 5325.653832500875, 5368.275282836845, 5377.489138531833, 5377.973110134424, 5387.784488620411, 6268.27914789805, 6310.9368906311265, 6329.7468101275435, 6339.936600634119, 6346.777862774781, 6126.059675755388, 6201.007838745779, 6205.906911396242, 6294.3076261612105, 6305.716242769178, 6324.588901721373, 6325.462335701517, 6336.904946425715, 6347.587406818542, 6351.936480635134, 5124.205748109049, 5963.3142188647125, 6132.5707200495535, 6185.134081228722, 6199.56603037783, 4839.927401089057, 6155.569110162246, 6157.599756015845, 6166.969165154145, 6209.565330427007, 5057.266696329085, 6051.3948605140895, 6057.303410107894, 6059.09113632941, 6121.938780612137, 6047.516198704181, 6059.121427392915, 6065.302490213506, 6074.0, 6076.240469941257, 5764.13537969308, 5812.0, 5857.092150716646, 5865.501432378295, 5912.615679980788, 6006.249218847644, 6095.512359011357, 6105.520399749632, 6109.7861574844665, 6117.357677443804, 5718.971405142947, 5778.422157784188, 5929.762809487572, 5934.732937017931, 5937.9406205937385], "value": 5642.761720522117, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [466.71763583032265, 510.57622173595905, 524.2817340243867, 524.6484855147052, 579.9971000145001, 29943.0, 31365.059048228562, 37730.24539509212, 38722.838314850596, 38809.0, 40141.59858401415, 40380.19239615206, 40461.797691011576, 40588.79705601475, 40623.984400389934, 9015.684451044232, 9206.49364284964, 9220.400673956205, 9226.907730922672, 9248.53757312135, 8375.95812020939, 8596.441231319975, 8606.56967151643, 8714.433561818461, 8715.694950676727, 10949.45252737364, 11193.216474846764, 11198.160137989642, 11382.829257561143, 11390.08879289659, 11065.50205240762, 11153.330800151936, 11158.442077896154, 11161.38612376323, 11168.776624467466, 8243.422960392774, 8467.915320846774, 11034.944825275823, 11102.55589776408, 11127.998480136746, 30722.0, 31052.37895242105, 31103.22241943947, 37716.62283377159, 38328.61671383278, 3278.065751260879, 3344.9832750836335, 3360.663933606644, 3748.475213470116, 3838.9040273993096, 28766.0, 29042.0, 29533.70466295331, 29626.407471850656, 30097.699023009707, 3132.37352529495, 3160.8261545614982, 3161.2571045804216, 3239.222586579204, 3267.3628642414737, 336590.0, 425212.8739356314, 426393.0, 426826.0, 429439.85280073714, 55422.44577554253, 55702.442975570535, 55808.72095639577, 55840.0, 56021.879562408525, 57624.0, 58121.128183077286, 58134.418655813744, 58205.0, 58324.70837645869, 13098.148620339647, 13386.866131338562, 13390.598282051555, 13421.865781342061, 13422.664433389244, 10632.94683526593, 10918.672439826818, 11010.229283950206, 11018.44907754609, 11027.724306892393, 13906.887449004056, 14215.715685686228, 14232.28838558068, 15085.170315632746, 15775.684486310209, 6755.763548275787, 6970.372666460043, 6975.651217439209, 7033.2966703330285, 7086.964565177244, 832.6960659359412, 866.6316815353449, 950.7575568230195, 966.5022513405602, 991.8264303746815, 28628.85685571559, 28646.28384290368, 29138.56292155577, 29501.409971800444, 29519.704802951695, 992.4095163377779, 999.7950420163849, 1036.3988886445993, 1060.4697651174413, 1072.5763323487179, 13105.541306054241, 14063.718725625431, 14769.04001239916, 15159.0, 15208.0, 616429.0, 622053.0, 622076.0, 622086.0, 622169.0, 38831.80584097118, 48007.27989080166, 53153.0, 54073.459265407626, 54386.45613543893, 1304.315234501894, 1323.7484877873173, 1345.5761435148092, 1355.6949686320697, 1357.8438479574975, 29387.412251754417, 29572.0, 29740.553891692074, 29849.850750746107, 30298.0, 39723.0, 51480.22779658233, 52772.472275276756, 52917.7354113227, 55956.44043559513, 556127.2193639006, 580681.0, 585013.0, 589953.0, 773641.0, 24107.15624953118, 24252.90861911183, 24281.75718242795, 24652.013919443023, 24658.506829862945, 41901.79049104735, 42395.0, 42748.358774619024, 42901.57098429101, 42976.78511607422, 35254.64745352514, 35743.0, 36027.459588105674, 36054.8197259012, 36251.912442626766, 34126.0, 35149.64850351464, 35173.47239791354, 35299.47050794292, 35879.282414351044, 26782.330441739112, 34809.0, 35255.76604818819, 35810.8209458951, 36061.45907811332, 30202.24494387658, 31325.843370783, 31481.68518314879, 31556.0, 31590.0, 20831.791682082985, 22699.09203631836, 23718.881405592863, 23817.642735358637, 24279.393015174763], "value": 18834.20176152309, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [350.2399792450382, 366.71029886389755, 367.9153794627236, 379.0826200594561, 397.7971234670317, 14722.631934201638, 14995.825605287228, 15545.689086218283, 19202.807971920312, 20197.39407817764, 19133.234670613158, 19450.41648750536, 20061.297854575092, 20108.195672173133, 20310.18759249632, 5579.581531385142, 5881.617694849821, 5882.323532793741, 5895.705214739267, 5896.734646940877, 4082.203970225807, 4310.267254566716, 4415.324885789142, 5765.394633563478, 5829.0, 4300.526942036374, 5973.731182096816, 6259.749610015594, 6277.497800175998, 6359.777407790728, 6070.6357618543025, 6296.685165741695, 6316.3683631636695, 6339.1442155308905, 6374.745010199586, 5543.833684989457, 5551.472610102074, 5555.972220138873, 5556.0, 5560.972195139039, 23918.76081239183, 24010.79946002693, 24600.753992460206, 24980.875095624586, 25162.370940726447, 1995.760508738946, 2194.473326401668, 2419.22584772871, 2551.413174969749, 2567.6276939843806, 5680.176374425727, 5734.856628584277, 9503.477308748015, 9941.409374500117, 10233.846492302622, 1748.3968031029274, 1793.1213705284447, 1872.7003679411364, 1876.859235557325, 1882.3223639489772, 107407.0, 112489.43755281252, 113059.0, 113746.72506549905, 114240.99999999917, 10979.780404392028, 11107.611233606947, 11157.330560166416, 11286.065622938095, 11488.080953523699, 13842.238676872666, 14192.574222773334, 14209.005369624027, 14215.289235538388, 14222.573322800332, 7618.4667073305445, 7691.153973062958, 7808.0, 7905.407094467938, 7990.320822730133, 7599.810004749815, 7610.809729756689, 7764.145943946161, 7775.377969762406, 7785.416093792988, 4334.523202447728, 4500.054988452396, 4503.54964503547, 4508.413906192174, 4582.816687332536, 1591.4270862489495, 1631.2740830330627, 1718.269735362466, 1873.594803897077, 1891.7514440469224, 660.3660485933461, 698.8392669686001, 856.8286342731478, 862.9180227878342, 929.8837645294338, 19643.803561964483, 20547.8972605136, 20622.79377206239, 20920.37238882836, 22239.44401389978, 918.779492921694, 922.3359181389388, 923.6490133749132, 936.765808547863, 952.623713633111, 10663.89336106629, 11017.228793984345, 11099.112071034298, 11108.666739997652, 11133.832992505118, 562833.0, 569998.0500682456, 576031.0, 576311.4847832494, 585409.0, 102774.97225027654, 130545.69454305335, 132446.33776831054, 135548.99999999802, 136371.0, 867.6702852915978, 975.190591808797, 979.7550612346913, 998.6804222648683, 1000.6947880896397, 16425.589360266087, 18197.818021819614, 18230.635387292445, 18238.635227295115, 18608.3252507275, 48815.0, 52030.479695202564, 55933.0, 56594.0, 56627.0, 63701.362986369546, 73294.53410931645, 73439.26560734538, 76685.61657191678, 78749.60625196838, 6562.639054851838, 7075.469339799432, 7136.3220494052985, 7273.0908636420445, 7885.881711774443, 9794.412335259907, 11529.538818447169, 11642.592509262475, 12043.217190882564, 12524.37378131108, 10126.44304563256, 10304.381737095799, 10603.8939610606, 10818.459077046273, 10823.051850666956, 10137.23970702215, 10364.792704146026, 10433.373997560171, 10753.46232688378, 10777.407242601732, 10460.215483838894, 10867.673969780919, 11073.889261107286, 11110.777814440244, 11247.662570122582, 7136.3934065602925, 7243.963780181065, 7321.524100933422, 7421.888671669822, 7487.737929172453, 9825.754356141153, 10508.684739457829, 10813.189010824377, 10837.187210959051, 10858.457077145953], "value": 9110.112573105198, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1260.7919693250615, 1431.6420894776302, 1538.2923855026688, 1743.389813565253, 1775.7957834848987, 7965.482243654165, 8374.371922105836, 8406.873896891551, 8411.200935911087, 8421.789455263613, 7188.173360063594, 7468.551886886777, 7476.9252307477045, 7583.810404739885, 7630.351420129296, 2058.8558800883907, 2100.71640328556, 2209.569134018867, 2282.3837563857746, 2284.1434462076722, 2274.37454699958, 2279.099755596538, 2281.4638559938403, 2283.7830406111393, 2289.473421113145, 2250.1449449209276, 2265.784750448705, 2281.0191617604423, 2282.805961493275, 2283.6460348645987, 2229.9665505017274, 2231.6206244938317, 2249.044156233594, 2253.504229069602, 2255.1768604459253, 2255.154317131076, 2255.909763609454, 2283.235116236063, 2285.8857057147243, 2287.588234117858, 8079.353651707849, 8259.174082591693, 8287.41988060836, 8290.544020078893, 8299.336053115736, 4954.801807927679, 5122.359705036871, 5124.0, 5132.486751324837, 5134.845954621367, 3271.9018429447156, 3363.2006876321298, 3431.739847145197, 3454.654534546525, 3460.809655468948, 1009.7425156585098, 1021.3820638513666, 1026.1021606094666, 1037.968860934173, 1043.3635482355758, 10785.029347358697, 10794.136469082454, 10829.133669306437, 10867.945660271727, 10895.346279223271, 4111.527174374925, 4271.124419493996, 4276.465441819772, 4387.473503179575, 4390.165868484977, 8371.916280837235, 8387.287080598095, 8398.454100483448, 8565.05784363732, 8575.356848236408, 5009.499050094962, 5011.899762004739, 5016.949830501721, 5020.0, 5023.8492845214705, 4474.172278128557, 4625.283081122431, 4699.78850951708, 4704.200285951328, 4713.858584242478, 3363.983180084084, 3446.276281980762, 3558.62634423387, 3603.6036036036016, 3651.1784848408897, 1122.0238392598328, 1124.8256520239377, 1133.348324713293, 1133.7619099988929, 1140.4696815980608, 744.0996394362882, 823.3618945317307, 889.8175873945955, 891.0732837848694, 902.2105657549644, 4565.373474288787, 5220.309862250089, 5372.247885296062, 5698.1737648041635, 5714.771409143671, 777.9260970207821, 879.3053487744738, 913.4245425381966, 949.093615597103, 957.4781743949565, 3328.5839270091237, 3587.1749497615174, 3680.190358121209, 3690.2988432197794, 3817.541894972621, 9403.717888463358, 9756.975517570552, 9922.0, 10060.849087263698, 10068.993100690019, 9799.216062715108, 10002.0, 10009.949950250348, 10022.398656080659, 10029.448380339152, 7209.423246140296, 7663.923360766321, 7681.769546913713, 7744.845103097907, 7757.844843103219, 4647.488776234679, 5354.571634269171, 5395.947790180877, 5419.485148910847, 5666.660000399989, 9305.581248843953, 9441.073267287164, 9443.527823608929, 9453.716388508356, 9455.007224241355, 9292.535373231176, 9341.719748407559, 9519.143277105093, 9543.47510886908, 9562.426254424758, 6589.5387322888855, 6672.499562532732, 6674.799756007327, 6675.7997260082275, 6676.566023208476, 6953.513254072166, 7062.1878483975, 7208.495405321787, 7669.884951725617, 7776.300132987832, 6642.402183803288, 6815.114035175594, 7053.224145344111, 7140.428765698628, 7171.605561694157, 6391.552591318563, 6401.647909364843, 6495.935040649533, 6563.507736919845, 6602.504812139013, 6453.645049522133, 6464.773732919325, 6558.0, 6599.175103112111, 6624.6025238485845, 4662.184117779308, 4709.3502535535235, 4802.27965805132, 4810.037992401603, 4830.7101573905675, 4764.094821983812, 4766.475687674284, 4875.414950205998, 4918.491569299611, 4922.4339200992345], "value": 4274.279467154663, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [291.740351087532, 294.89383821824146, 301.52509797069615, 306.2542708504791, 306.8404429696559, 4673.789679464424, 4872.293517439969, 5150.171689050389, 5213.715359323621, 5220.399654039787, 4128.958710412902, 4223.0, 4235.366961940619, 4729.054189162172, 5087.2608632654965, 3409.6419875913043, 3422.8288585570745, 3911.4523966644692, 3961.5642279349395, 3992.860249891254, 3960.7623542587394, 3969.166475040245, 3969.5435024972066, 3973.3443981742976, 3973.9801300993454, 3211.710946014858, 3512.7189824813954, 3596.568411790589, 3868.1490072184074, 3942.172143849795, 3364.680355366236, 3732.440133979911, 3904.472896159039, 3918.74528155669, 3922.0783115967724, 2692.932676683079, 2788.9023884163958, 2909.941801163986, 3378.577677790276, 3393.117789374756, 4889.828855990023, 4963.379577552806, 5026.396832380101, 5053.9241911371355, 5058.8870448501275, 4116.773577453238, 4323.200207961537, 4413.558644135593, 4439.734675617434, 4441.912870554966, 5072.112380333427, 5330.227117068042, 5336.226247194174, 5342.252084708144, 5361.731913404315, 3201.9199520011953, 3676.7242456815848, 3680.3191409589044, 3681.0490440066806, 3693.5567731872347, 5357.000079955199, 5513.2005859150195, 5544.417836127229, 5556.611037227396, 5642.069058605366, 3712.9628703713156, 3716.2567486502808, 3734.7572407793405, 3737.1404576947452, 3744.26986737589, 3547.4324108142573, 3698.556173259226, 3763.3414152523746, 3771.47255361579, 3774.47157397959, 4404.537523560044, 4407.977960110243, 4410.184115938561, 4421.673497950602, 4434.689571729948, 4586.2661974083985, 5154.118746657443, 5437.891242175135, 5441.972790136024, 5479.643823151562, 1074.301703892476, 1075.6074032977906, 1114.587602587048, 1244.6328333141746, 1246.9251844889336, 768.2202564397141, 785.6346798738614, 788.5623478969112, 803.7869964459423, 839.2572573272697, 3941.4825292262685, 4197.412362269285, 4798.632389768899, 4856.236416777026, 4858.80564777412, 4757.976210118996, 5232.843014709565, 5263.3947096083675, 5272.420033796279, 5285.339332583427, 4323.870283891489, 4583.175028494903, 4591.212249893851, 4839.749516474856, 4875.780589873464, 2538.2639034680105, 2583.687599598349, 2757.972889925903, 2786.3312804926672, 2823.317848044366, 4985.55130038291, 5583.4137415571595, 5595.580331475156, 5612.494875461228, 5613.522850557748, 4537.912560222268, 5267.578593712494, 5433.809816656477, 5475.808346707846, 5503.724813759376, 4420.38070216618, 4808.3027960945465, 4996.6752161110135, 5230.372355317386, 5407.918881216785, 4988.650794444354, 5027.371578552681, 5236.764345604381, 5262.710890624129, 5347.5721942243745, 4537.574131530673, 4931.0, 4962.131626965339, 5622.522085622604, 5667.603267771216, 4863.908519336719, 5825.883482330414, 5908.822735317947, 5910.0, 5918.822435326947, 3055.601352937933, 3534.505169276355, 3694.796786176786, 3732.42147467143, 3814.6757525610633, 4539.863804085882, 5245.554127899019, 5578.884223155466, 5631.577631677558, 5668.433156684298, 4905.926411103765, 5209.817656382009, 5370.382406023357, 5496.0, 5539.642787517084, 4695.309688512201, 5214.869628259324, 5272.6309158358545, 5495.972520137374, 5504.4770746778995, 5321.946780532146, 5347.358317001985, 5386.730663466733, 5388.407275199804, 5391.7304134793885, 4498.875281179705, 4539.477960034506, 4910.82812101589, 5360.303160589098, 5404.378496472956, 5356.732163391737, 5378.757955891916, 5396.0556902542685, 5398.64908780928, 5400.891982160256], "value": 3861.594982361157, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [644.8130042287737, 727.2872584866834, 752.6575408189275, 775.4638846858327, 783.9412044096695, 13832.58502244933, 15407.76888346673, 15632.609184770357, 15657.217139143055, 15683.372665093397, 11462.770744585103, 13173.341332933363, 13490.258035808027, 13669.453221871114, 13932.233727145029, 779.9766007019798, 796.080526991323, 796.8565658181525, 797.9481333713319, 798.9760307190764, 629.7638385605399, 653.0824192010233, 654.5679851298145, 774.6320497763573, 780.1730166024005, 801.7795106345743, 805.118395357083, 833.9666413343459, 838.4005436113177, 840.6385254340631, 814.9837003259931, 827.8302947895697, 832.3216578488513, 833.0336809301242, 835.419383528448, 481.49683580658296, 493.59525189344754, 605.6093819486407, 607.4017093163275, 608.8325710429623, 12562.74874502514, 12713.491460341575, 12745.299008554526, 12745.980321574252, 14150.36323365451, 13890.374933128034, 14434.422623095168, 14468.421263149461, 14478.276086195649, 14534.34595443197, 11742.823857642143, 11921.463534140985, 12065.034797216202, 12070.275783452933, 12344.691382715415, 3071.385722855438, 3440.569928758905, 3610.277944411102, 3814.0846196912817, 3832.9808350958347, 102938.0, 113997.0, 115854.42072789666, 117685.0, 118296.40851795772, 11138.164637652046, 11241.943790280997, 11252.943735281271, 11274.210805243718, 11459.598914038135, 22646.66030009551, 22663.546729065656, 22679.88660056722, 22682.773172268066, 22684.206052788075, 7822.374210063182, 7906.446548741533, 7991.720289789946, 8067.273945344947, 8175.918240817635, 4222.978885105555, 4271.273883439822, 4363.040131171138, 4428.202923473741, 4494.37078808967, 3387.4410722230555, 3495.07380544156, 3495.2310491691787, 3497.5453191085503, 3500.824958752103, 546.2325432766969, 602.6504627316234, 602.8944934636421, 628.214731585518, 637.528229110455, 601.5338112962402, 639.6705149695915, 650.830783996155, 664.8836453620597, 668.201499208451, 9123.635054597742, 9164.587593558306, 9410.95294523523, 9416.340856140005, 9586.281028922858, 633.1642232253473, 669.3908543225641, 669.5112567825514, 671.5097978475642, 673.1451057157383, 4039.8788036358956, 4399.714018588781, 4578.748168850679, 4602.815887364468, 4608.331791890158, 84361.0, 98931.51602725965, 107865.92134078716, 112459.43770281096, 114906.0, 97570.51214744023, 98022.50988745011, 99626.50186749165, 100758.49620751996, 101178.25769765001, 69533.0, 86077.0, 86157.13842861616, 87409.0, 89882.55058724796, 7451.888221676788, 8766.693165739169, 8933.240674542476, 9088.63645454201, 9088.772780680536, 39537.80231098826, 51115.233271501704, 54233.18650220171, 55220.34338969837, 56468.7176564131, 65610.67194663997, 73051.63474182595, 73843.26156738364, 82781.17218827734, 85324.0, 12654.0, 13359.666008349868, 14092.859071409155, 14178.929105354408, 14240.287985600471, 14753.316440602517, 15111.058308706066, 15225.838633246041, 15412.46056388021, 15698.0, 13737.0, 14058.789118163031, 14192.574222773334, 14211.147331160164, 14564.708705826037, 14120.293985300488, 14198.29008549589, 14237.422552664188, 14378.784318235445, 14390.28048597545, 13576.728465430439, 13727.245001524612, 13772.793408098687, 13931.58205253844, 14531.0, 10935.28920620157, 11304.773904522028, 11541.192116551762, 11669.990178279102, 12065.758684826429, 11362.502245554015, 11608.0, 11617.244879082833, 11681.532738690357, 11707.88292117068], "value": 7421.369105952339, "unit": "score"}], "name": "dromaeo_css", "value": 7009.5070637926665, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 115.0, 115.0, 113.0, 114.0, 126.0, 171.0, 152.0, 113.0, 113.0], "value": 124.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 112.0, 111.0, 145.0, 97.0, 127.0, 140.0, 140.0, 132.0, 112.0], "value": 125.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [190.0, 183.0, 180.0, 182.0, 182.0, 181.0, 185.0, 261.0, 182.0, 182.0], "value": 190.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 59.0, 57.0, 86.0, 62.0, 60.0, 62.0, 67.0, 65.0, 66.0], "value": 66.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 73.0, 86.0, 70.0, 70.0, 94.0, 101.0, 67.0, 69.0, 84.0], "value": 80.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 85.0, 88.0, 86.0, 88.0, 84.0, 89.0, 85.0, 93.0, 132.0], "value": 91.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 95.0, 100.0, 93.0, 94.0, 94.0, 98.0, 94.0, 94.0], "value": 95.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 84.0, 84.0, 86.0, 87.0, 83.0, 87.0, 87.0, 87.0, 84.0], "value": 85.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 56.0, 53.0, 53.0, 53.0, 55.0, 54.0, 54.0, 53.0, 54.0], "value": 54.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 67.0, 69.0, 77.0, 76.0, 74.0, 69.0, 72.0, 71.0, 70.0], "value": 70.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 88.0, 88.0, 87.0, 86.0, 86.0, 78.0, 99.0, 98.0, 105.0], "value": 90.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 154.0, 159.0, 147.0, 134.0, 178.0, 160.0, 154.0, 238.0, 157.0], "value": 162.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [213.0, 226.0, 173.0, 173.0, 175.0, 174.0, 171.0, 171.0, 177.0, 172.0], "value": 182.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 68.0, 69.0, 69.0, 67.0, 69.0, 69.0, 68.0, 66.0, 66.0], "value": 67.9, "unit": "score"}], "name": "kraken", "value": 1488.7000000000003, "alertThreshold": 2.0}]} 08:55:03 INFO - Return code: 0 08:55:03 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 08:55:03 INFO - # TBPL SUCCESS # 08:55:03 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 08:55:03 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 08:55:03 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 08:55:03 INFO - 2016-12-07 08:55:03.337 screenresolution[1659:10340] starting screenresolution argv=screenresolution get 08:55:03 INFO - 2016-12-07 08:55:03.340 screenresolution[1659:10340] Display 0: 1600x1200x32@60 08:55:03 INFO - 2016-12-07 08:55:03.347 screenresolution[1660:10344] starting screenresolution argv=screenresolution list 08:55:03 INFO - Available Modes on Display 0 08:55:03 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 08:55:03 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 08:55:03 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 08:55:03 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 08:55:03 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 08:55:03 INFO - Intel Iris: 08:55:03 INFO - Chipset Model: Intel Iris 08:55:03 INFO - Type: GPU 08:55:03 INFO - Bus: Built-In 08:55:03 INFO - VRAM (Dynamic, Max): 1536 MB 08:55:03 INFO - Vendor: Intel (0x8086) 08:55:03 INFO - Device ID: 0x0a2e 08:55:03 INFO - Revision ID: 0x0009 08:55:03 INFO - Displays: 08:55:03 INFO - Display: 08:55:03 INFO - Resolution: 1600 x 1200 @ 60 Hz 08:55:03 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 08:55:03 INFO - Display Serial Number: 1600x1200 60 08:55:03 INFO - Main Display: Yes 08:55:03 INFO - Mirror: Off 08:55:03 INFO - Online: Yes 08:55:03 INFO - Rotation: Supported 08:55:03 INFO - Return code: 0 08:55:03 INFO - Running post-action listener: _resource_record_post_action 08:55:03 INFO - [mozharness: 2016-12-07 16:55:03.592428Z] Finished run-tests step (success) 08:55:03 INFO - Running post-run listener: _resource_record_post_run 08:55:03 INFO - Total resource usage - Wall time: 1214s; CPU: 53.0%; Read bytes: 31919104; Write bytes: 696240128; Read time: 197; Write time: 1966 08:55:03 INFO - TinderboxPrint: CPU usage
53.5% 08:55:03 INFO - TinderboxPrint: I/O read bytes / time
31,919,104 / 197 08:55:03 INFO - TinderboxPrint: I/O write bytes / time
696,240,128 / 1,966 08:55:03 INFO - TinderboxPrint: CPU idle
2,260.6 (46.5%) 08:55:03 INFO - TinderboxPrint: CPU system
969.3 (20.0%) 08:55:03 INFO - TinderboxPrint: CPU user
1,627.8 (33.5%) 08:55:03 INFO - TinderboxPrint: Swap in / out
412,041,216 / 0 08:55:03 INFO - install - Wall time: 33s; CPU: 54.0%; Read bytes: 384901632; Write bytes: 386185216; Read time: 28881; Write time: 820 08:55:03 INFO - run-tests - Wall time: 1182s; CPU: 53.0%; Read bytes: 28724224; Write bytes: 308719616; Read time: 169; Write time: 1140 08:55:04 INFO - Running post-run listener: _upload_blobber_files 08:55:04 INFO - Blob upload gear active. 08:55:04 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:55:04 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:55:04 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:55:04 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:55:04 INFO - (blobuploader) - INFO - Open directory for files ... 08:55:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 08:55:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:55:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:55:05 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 08:55:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:55:05 INFO - (blobuploader) - INFO - Done attempting. 08:55:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 08:55:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:55:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:55:06 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 08:55:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:55:06 INFO - (blobuploader) - INFO - Done attempting. 08:55:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 08:55:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:55:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:55:09 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 08:55:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:55:09 INFO - (blobuploader) - INFO - Done attempting. 08:55:09 INFO - (blobuploader) - INFO - Iteration through files over. 08:55:09 INFO - Return code: 0 08:55:09 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:55:09 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:55:09 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/874ba39c72af6003f147f83fe4154a51c0c333f29976acd195e510e0789274493938e920b0ca9b6940798dda84fc9392d4c313c5a91609808fc939f3bb056c92", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/285d3dc20bb0864ca4b4475d99847e4209daf74cc7cb83c4e25b1479c1bbe12c8bce89a7379b5db8ec155a729fc9ade04cdf0d3bfdde5d17d0b48cee9827cb36", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f4e30ed61cb3a8dbcd5d34e306791a2f9943f6dee69d6a60d83d0747e04345f7114d70fbd92de0c543c1d40da0153fef4b2af624791d7bfda5094479adae3db7"} 08:55:09 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:55:09 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:55:09 INFO - Contents: 08:55:09 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/874ba39c72af6003f147f83fe4154a51c0c333f29976acd195e510e0789274493938e920b0ca9b6940798dda84fc9392d4c313c5a91609808fc939f3bb056c92", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/285d3dc20bb0864ca4b4475d99847e4209daf74cc7cb83c4e25b1479c1bbe12c8bce89a7379b5db8ec155a729fc9ade04cdf0d3bfdde5d17d0b48cee9827cb36", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f4e30ed61cb3a8dbcd5d34e306791a2f9943f6dee69d6a60d83d0747e04345f7114d70fbd92de0c543c1d40da0153fef4b2af624791d7bfda5094479adae3db7"} 08:55:09 INFO - Running post-run listener: copy_logs_to_upload_dir 08:55:09 INFO - Copying logs to upload dir... 08:55:09 INFO - mkdir: /builds/slave/test/build/upload/logs 08:55:09 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1278.564208 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 18 secs) (at 2016-12-07 08:55:09.328408) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-07 08:55:09.331773) ========= 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.8QzykyWzVk/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.N1jdOs0C78/Listeners TMPDIR=/var/folders/1b/b370xjvx7_vbkyyr8hgyjzcm00000w/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/874ba39c72af6003f147f83fe4154a51c0c333f29976acd195e510e0789274493938e920b0ca9b6940798dda84fc9392d4c313c5a91609808fc939f3bb056c92", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/285d3dc20bb0864ca4b4475d99847e4209daf74cc7cb83c4e25b1479c1bbe12c8bce89a7379b5db8ec155a729fc9ade04cdf0d3bfdde5d17d0b48cee9827cb36", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f4e30ed61cb3a8dbcd5d34e306791a2f9943f6dee69d6a60d83d0747e04345f7114d70fbd92de0c543c1d40da0153fef4b2af624791d7bfda5094479adae3db7"} build_url:https://queue.taskcluster.net/v1/task/JQfZGfM2SzeXKIQuHLz8NA/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011143 build_url: 'https://queue.taskcluster.net/v1/task/JQfZGfM2SzeXKIQuHLz8NA/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/874ba39c72af6003f147f83fe4154a51c0c333f29976acd195e510e0789274493938e920b0ca9b6940798dda84fc9392d4c313c5a91609808fc939f3bb056c92", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/285d3dc20bb0864ca4b4475d99847e4209daf74cc7cb83c4e25b1479c1bbe12c8bce89a7379b5db8ec155a729fc9ade04cdf0d3bfdde5d17d0b48cee9827cb36", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f4e30ed61cb3a8dbcd5d34e306791a2f9943f6dee69d6a60d83d0747e04345f7114d70fbd92de0c543c1d40da0153fef4b2af624791d7bfda5094479adae3db7"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-07 08:55:09.366090) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-07 08:55:09.366402) ========= 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.8QzykyWzVk/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.N1jdOs0C78/Listeners TMPDIR=/var/folders/1b/b370xjvx7_vbkyyr8hgyjzcm00000w/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.004917 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-07 08:55:09.415294) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-07 08:55:09.415666) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-07 08:55:09.416020) ========= ========= Total master_lag: 0.18 =========