builder: mozilla-beta_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0015 starttime: 1483013432.19 results: success (0) buildid: 20161229014137 builduid: 6691e6e4d9e64dbd97d7a90648586461 revision: d843dc104a2e124539e43aeff6fa8a89aa1cc430 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-12-29 04:10:32.189806) ========= master: http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-12-29 04:10:32.190196) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-29 04:10:32.190463) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-29 04:10:32.325628) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-29 04:10:32.326101) ========= 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.Ej6Y6nvngP/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.iX0ux7Fnyr/Listeners TMPDIR=/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/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-29 04:10:32-- 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% 31.8M=0s 2016-12-29 04:10:32 (31.8 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.203164 ========= master_lag: 0.06 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-29 04:10:32.585077) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-29 04:10:32.585546) ========= 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.Ej6Y6nvngP/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.iX0ux7Fnyr/Listeners TMPDIR=/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/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.019501 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-29 04:10:32.646262) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-12-29 04:10:32.646803) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev d843dc104a2e124539e43aeff6fa8a89aa1cc430 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-beta --rev d843dc104a2e124539e43aeff6fa8a89aa1cc430 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.Ej6Y6nvngP/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.iX0ux7Fnyr/Listeners TMPDIR=/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/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-29 04:10:32,905 truncating revision to first 12 chars 2016-12-29 04:10:32,905 Setting DEBUG logging. 2016-12-29 04:10:32,905 attempt 1/10 2016-12-29 04:10:32,905 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/d843dc104a2e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-12-29 04:10:34,923 unpacking tar archive at: mozilla-beta-d843dc104a2e/testing/mozharness/ program finished with exit code 0 elapsedTime=2.292923 ========= master_lag: 0.20 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-12-29 04:10:35.137220) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-29 04:10:35.137504) ========= script_repo_revision: d843dc104a2e124539e43aeff6fa8a89aa1cc430 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-29 04:10:35.137852) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-29 04:10:35.138112) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-29 04:10:35.159705) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 20 mins, 59 secs) (at 2016-12-29 04:10:35.159976) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 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', 'Mozilla-Beta', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.Ej6Y6nvngP/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.iX0ux7Fnyr/Listeners TMPDIR=/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/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 04:10:35 INFO - MultiFileLogger online at 20161229 04:10:35 in /builds/slave/test 04:10:35 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 04:10:35 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:10:35 INFO - {'append_to_log': False, 04:10:35 INFO - 'base_work_dir': '/builds/slave/test', 04:10:35 INFO - 'blob_upload_branch': 'Mozilla-Beta', 04:10:35 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:10:35 INFO - 'branch': 'Mozilla-Beta', 04:10:35 INFO - 'buildbot_json_path': 'buildprops.json', 04:10:35 INFO - 'config_files': ('talos/mac_config.py',), 04:10:35 INFO - 'default_actions': ('clobber', 04:10:35 INFO - 'read-buildbot-config', 04:10:35 INFO - 'download-and-extract', 04:10:35 INFO - 'populate-webroot', 04:10:35 INFO - 'create-virtualenv', 04:10:35 INFO - 'install', 04:10:35 INFO - 'run-tests'), 04:10:35 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:10:35 INFO - 'download_minidump_stackwalk': True, 04:10:35 INFO - 'download_symbols': 'ondemand', 04:10:35 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:10:35 INFO - 'tooltool.py': '/tools/tooltool.py', 04:10:35 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:10:35 INFO - '/tools/misc-python/virtualenv.py')}, 04:10:35 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:10:35 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:10:35 INFO - 'installer_path': 'installer.exe', 04:10:35 INFO - 'log_level': 'info', 04:10:35 INFO - 'log_name': 'talos', 04:10:35 INFO - 'log_to_console': True, 04:10:35 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 04:10:35 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 04:10:35 INFO - 'opt_config_files': (), 04:10:35 INFO - 'pip_index': False, 04:10:35 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:10:35 INFO - 'cmd': ('bash', 04:10:35 INFO - '-c', 04:10:35 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:10:35 INFO - 'enabled': True, 04:10:35 INFO - 'halt_on_failure': False, 04:10:35 INFO - 'name': 'check_screen_resolution'},), 04:10:35 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:10:35 INFO - 'cmd': ('bash', 04:10:35 INFO - '-c', 04:10:35 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:10:35 INFO - 'enabled': True, 04:10:35 INFO - 'halt_on_failure': False, 04:10:35 INFO - 'name': 'check_screen_resolution'},), 04:10:35 INFO - 'run_cmd_checks_enabled': True, 04:10:35 INFO - 'sps_profile': False, 04:10:35 INFO - 'sps_profile_interval': 0, 04:10:35 INFO - 'suite': 'dromaeojs', 04:10:35 INFO - 'system_bits': '32', 04:10:35 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:10:35 INFO - 'title': 't-yosemite-r7-0015', 04:10:35 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:10:35 INFO - 'use_talos_json': True, 04:10:35 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:10:35 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:10:35 INFO - 'work_dir': 'build'} 04:10:35 INFO - [mozharness: 2016-12-29 12:10:35.375329Z] Running clobber step. 04:10:35 INFO - Running pre-action listener: _resource_record_pre_action 04:10:35 INFO - Running main action method: clobber 04:10:35 INFO - rmtree: /builds/slave/test/build 04:10:35 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:10:37 INFO - Running post-action listener: _resource_record_post_action 04:10:37 INFO - [mozharness: 2016-12-29 12:10:37.443612Z] Finished clobber step (success) 04:10:37 INFO - [mozharness: 2016-12-29 12:10:37.443737Z] Running read-buildbot-config step. 04:10:37 INFO - Running pre-action listener: _resource_record_pre_action 04:10:37 INFO - Running main action method: read_buildbot_config 04:10:37 INFO - Using buildbot properties: 04:10:37 INFO - { 04:10:37 INFO - "project": "", 04:10:37 INFO - "product": "firefox", 04:10:37 INFO - "script_repo_revision": "production", 04:10:37 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs", 04:10:37 INFO - "repository": "", 04:10:37 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs", 04:10:37 INFO - "buildid": "20161229014137", 04:10:37 INFO - "pgo_build": "False", 04:10:37 INFO - "basedir": "/builds/slave/test", 04:10:37 INFO - "buildnumber": 14, 04:10:37 INFO - "slavename": "t-yosemite-r7-0015", 04:10:37 INFO - "master": "http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/", 04:10:37 INFO - "platform": "yosemite_r7", 04:10:37 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 04:10:37 INFO - "branch": "mozilla-beta", 04:10:37 INFO - "repo_path": "releases/mozilla-beta", 04:10:37 INFO - "revision": "d843dc104a2e124539e43aeff6fa8a89aa1cc430", 04:10:37 INFO - "stage_platform": "macosx64", 04:10:37 INFO - "builduid": "6691e6e4d9e64dbd97d7a90648586461", 04:10:37 INFO - "slavebuilddir": "test" 04:10:37 INFO - } 04:10:37 INFO - Found installer url https://queue.taskcluster.net/v1/task/c56tdNxOS9usCrrt9dwM6g/artifacts/public/build/firefox-51.0.en-US.mac.dmg. 04:10:37 INFO - Running post-action listener: _resource_record_post_action 04:10:37 INFO - [mozharness: 2016-12-29 12:10:37.447063Z] Finished read-buildbot-config step (success) 04:10:37 INFO - [mozharness: 2016-12-29 12:10:37.447183Z] Running download-and-extract step. 04:10:37 INFO - Running pre-action listener: _resource_record_pre_action 04:10:37 INFO - Running main action method: download_and_extract 04:10:37 INFO - mkdir: /builds/slave/test/build/tests 04:10:37 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')]} 04:10:37 INFO - trying https://queue.taskcluster.net/v1/task/c56tdNxOS9usCrrt9dwM6g/artifacts/public/build/firefox-51.0.en-US.mac.test_packages.json 04:10:37 INFO - Downloading https://queue.taskcluster.net/v1/task/c56tdNxOS9usCrrt9dwM6g/artifacts/public/build/firefox-51.0.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-51.0.en-US.mac.test_packages.json 04:10:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/c56tdNxOS9usCrrt9dwM6g/artifacts/public/build/firefox-51.0.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0.en-US.mac.test_packages.json'}, attempt #1 04:10:38 INFO - Downloaded 1165 bytes. 04:10:38 INFO - Reading from file /builds/slave/test/build/firefox-51.0.en-US.mac.test_packages.json 04:10:38 INFO - Using the following test package requirements: 04:10:38 INFO - {u'common': [u'firefox-51.0.en-US.mac.common.tests.zip'], 04:10:38 INFO - u'cppunittest': [u'firefox-51.0.en-US.mac.common.tests.zip', 04:10:38 INFO - u'firefox-51.0.en-US.mac.cppunittest.tests.zip'], 04:10:38 INFO - u'gtest': [u'firefox-51.0.en-US.mac.common.tests.zip', 04:10:38 INFO - u'firefox-51.0.en-US.mac.gtest.tests.zip'], 04:10:38 INFO - u'jittest': [u'firefox-51.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 04:10:38 INFO - u'mochitest': [u'firefox-51.0.en-US.mac.common.tests.zip', 04:10:38 INFO - u'firefox-51.0.en-US.mac.mochitest.tests.zip'], 04:10:38 INFO - u'mozbase': [u'firefox-51.0.en-US.mac.common.tests.zip'], 04:10:38 INFO - u'reftest': [u'firefox-51.0.en-US.mac.common.tests.zip', 04:10:38 INFO - u'firefox-51.0.en-US.mac.reftest.tests.zip'], 04:10:38 INFO - u'talos': [u'firefox-51.0.en-US.mac.common.tests.zip', 04:10:38 INFO - u'firefox-51.0.en-US.mac.talos.tests.zip'], 04:10:38 INFO - u'web-platform': [u'firefox-51.0.en-US.mac.common.tests.zip', 04:10:38 INFO - u'firefox-51.0.en-US.mac.web-platform.tests.zip'], 04:10:38 INFO - u'xpcshell': [u'firefox-51.0.en-US.mac.common.tests.zip', 04:10:38 INFO - u'firefox-51.0.en-US.mac.xpcshell.tests.zip']} 04:10:38 INFO - Downloading packages: [u'firefox-51.0.en-US.mac.common.tests.zip'] for test suite category: common 04:10:38 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/c56tdNxOS9usCrrt9dwM6g/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip 04:10:38 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/c56tdNxOS9usCrrt9dwM6g/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip'}, attempt #1 04:10:38 INFO - Fetch https://queue.taskcluster.net/v1/task/c56tdNxOS9usCrrt9dwM6g/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip into memory 04:10:38 INFO - Expected file size: 16232868 04:10:45 INFO - Downloading packages: [u'firefox-51.0.en-US.mac.common.tests.zip', u'firefox-51.0.en-US.mac.talos.tests.zip'] for test suite category: talos 04:10:45 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/c56tdNxOS9usCrrt9dwM6g/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip 04:10:45 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/c56tdNxOS9usCrrt9dwM6g/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip'}, attempt #1 04:10:45 INFO - Fetch https://queue.taskcluster.net/v1/task/c56tdNxOS9usCrrt9dwM6g/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip into memory 04:10:46 INFO - Expected file size: 16232868 04:10:53 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/c56tdNxOS9usCrrt9dwM6g/artifacts/public/build/firefox-51.0.en-US.mac.talos.tests.zip 04:10:53 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/c56tdNxOS9usCrrt9dwM6g/artifacts/public/build/firefox-51.0.en-US.mac.talos.tests.zip'}, attempt #1 04:10:53 INFO - Fetch https://queue.taskcluster.net/v1/task/c56tdNxOS9usCrrt9dwM6g/artifacts/public/build/firefox-51.0.en-US.mac.talos.tests.zip into memory 04:10:54 INFO - Expected file size: 14414089 04:10:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:10:55 INFO - trying https://queue.taskcluster.net/v1/task/c56tdNxOS9usCrrt9dwM6g/artifacts/public/build/firefox-51.0.en-US.mac.dmg 04:10:55 INFO - Downloading https://queue.taskcluster.net/v1/task/c56tdNxOS9usCrrt9dwM6g/artifacts/public/build/firefox-51.0.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0.en-US.mac.dmg 04:10:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/c56tdNxOS9usCrrt9dwM6g/artifacts/public/build/firefox-51.0.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-51.0.en-US.mac.dmg'}, attempt #1 04:10:58 INFO - Downloaded 85962835 bytes. 04:10:58 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/c56tdNxOS9usCrrt9dwM6g/artifacts/public/build/firefox-51.0.en-US.mac.dmg 04:10:58 INFO - mkdir: /builds/slave/test/properties 04:10:58 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:10:58 INFO - Writing to file /builds/slave/test/properties/build_url 04:10:58 INFO - Contents: 04:10:58 INFO - build_url:https://queue.taskcluster.net/v1/task/c56tdNxOS9usCrrt9dwM6g/artifacts/public/build/firefox-51.0.en-US.mac.dmg 04:10:58 INFO - Running post-action listener: _resource_record_post_action 04:10:58 INFO - Running post-action listener: set_extra_try_arguments 04:10:58 INFO - [mozharness: 2016-12-29 12:10:58.893232Z] Finished download-and-extract step (success) 04:10:58 INFO - [mozharness: 2016-12-29 12:10:58.893352Z] Running populate-webroot step. 04:10:58 INFO - Running pre-action listener: _resource_record_pre_action 04:10:58 INFO - Running main action method: populate_webroot 04:10:58 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:10:58 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:10:58 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:10:58 INFO - '--tppagecycles', 04:10:58 INFO - '7'], 04:10:58 INFO - 'tests': ['tsvgm']}}, 04:10:58 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:10:58 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:10:58 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:10:58 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:10:58 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:10:58 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:10:58 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:10:58 INFO - 'talos_options': ['--disable-e10s'], 04:10:58 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:10:58 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:10:58 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:10:58 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:10:58 INFO - 'talos_options': ['--disable-e10s'], 04:10:58 INFO - 'tests': ['damp', 'tps']}, 04:10:58 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:10:58 INFO - 'tests': ['damp', 'tps']}, 04:10:58 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:10:58 INFO - 'tests': ['dromaeo_dom']}, 04:10:58 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:10:58 INFO - 'g4': {'talos_options': ['--disable-e10s'], 04:10:58 INFO - 'tests': ['basic_compositor_video']}, 04:10:58 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 04:10:58 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:10:58 INFO - 'tests': ['a11yr', 04:10:58 INFO - 'ts_paint', 04:10:58 INFO - 'tpaint', 04:10:58 INFO - 'sessionrestore', 04:10:58 INFO - 'sessionrestore_no_auto_restore', 04:10:58 INFO - 'tabpaint']}, 04:10:58 INFO - 'other-e10s': {'tests': ['a11yr', 04:10:58 INFO - 'ts_paint', 04:10:58 INFO - 'tpaint', 04:10:58 INFO - 'sessionrestore', 04:10:58 INFO - 'sessionrestore_no_auto_restore', 04:10:58 INFO - 'tabpaint']}, 04:10:58 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:10:58 INFO - 'ts_paint', 04:10:58 INFO - 'tpaint', 04:10:58 INFO - 'sessionrestore', 04:10:58 INFO - 'sessionrestore_no_auto_restore', 04:10:58 INFO - 'tabpaint']}, 04:10:58 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:10:58 INFO - 'ts_paint', 04:10:58 INFO - 'tpaint', 04:10:58 INFO - 'sessionrestore', 04:10:58 INFO - 'sessionrestore_no_auto_restore', 04:10:58 INFO - 'tabpaint']}, 04:10:58 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:10:58 INFO - 'tests': ['a11yr', 04:10:58 INFO - 'ts_paint', 04:10:58 INFO - 'tpaint', 04:10:58 INFO - 'sessionrestore', 04:10:58 INFO - 'sessionrestore_no_auto_restore', 04:10:58 INFO - 'tabpaint']}, 04:10:58 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:10:58 INFO - 'tests': ['a11yr', 04:10:58 INFO - 'ts_paint', 04:10:58 INFO - 'tpaint', 04:10:58 INFO - 'sessionrestore', 04:10:58 INFO - 'sessionrestore_no_auto_restore', 04:10:58 INFO - 'tabpaint']}, 04:10:58 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:10:58 INFO - 'tests': ['tsvgx', 04:10:58 INFO - 'tsvgr_opacity', 04:10:58 INFO - 'tart', 04:10:58 INFO - 'tscrollx', 04:10:58 INFO - 'cart']}, 04:10:58 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:10:58 INFO - 'tsvgr_opacity', 04:10:58 INFO - 'tart', 04:10:58 INFO - 'tscrollx', 04:10:58 INFO - 'cart']}, 04:10:58 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:10:58 INFO - 'talos_options': ['--disable-e10s'], 04:10:58 INFO - 'tests': ['tp5o']}, 04:10:58 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:10:58 INFO - 'tests': ['tp5o']}, 04:10:58 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:10:58 INFO - 'talos_options': ['--disable-e10s', 04:10:58 INFO - '--xperf_path', 04:10:58 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:10:58 INFO - 'tests': ['tp5n']}, 04:10:58 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:10:58 INFO - 'talos_options': ['--xperf_path', 04:10:58 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:10:58 INFO - 'tests': ['tp5n']}}, 04:10:58 INFO - 'talos.zip': {'path': '', 04:10:58 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:10:58 INFO - Running post-action listener: _resource_record_post_action 04:10:58 INFO - [mozharness: 2016-12-29 12:10:58.912595Z] Finished populate-webroot step (success) 04:10:58 INFO - [mozharness: 2016-12-29 12:10:58.912725Z] Running create-virtualenv step. 04:10:58 INFO - Running pre-action listener: _resource_record_pre_action 04:10:58 INFO - Running main action method: create_virtualenv 04:10:58 INFO - Creating virtualenv /builds/slave/test/build/venv 04:10:58 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 04:10:58 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:10:59 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:10:59 INFO - Using real prefix '/tools/python27' 04:10:59 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:10:59 INFO - Installing distribute.............................................................................................................................................................................................done. 04:11:02 INFO - Installing pip.................done. 04:11:02 INFO - Return code: 0 04:11:02 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:11:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:11:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:11:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:11:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:11:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:11:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:11:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10455c490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1044d2570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fee7b4a7050>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104370d30>, '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 0x1041d6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104368b20>, '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.Ej6Y6nvngP/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.iX0ux7Fnyr/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/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 04:11:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 04:11:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 04:11:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Ej6Y6nvngP/Render', 04:11:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:11:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:11:02 INFO - 'HOME': '/Users/cltbld', 04:11:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:11:02 INFO - 'LOGNAME': 'cltbld', 04:11:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:11:02 INFO - 'MOZ_NO_REMOTE': '1', 04:11:02 INFO - 'NO_EM_RESTART': '1', 04:11:02 INFO - 'PAGER': '/bin/cat', 04:11:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:11:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:11:02 INFO - 'PWD': '/builds/slave/test', 04:11:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:11:02 INFO - 'SHELL': '/bin/bash', 04:11:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.iX0ux7Fnyr/Listeners', 04:11:02 INFO - 'TMPDIR': '/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/', 04:11:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:11:02 INFO - 'USER': 'cltbld', 04:11:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:11:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:11:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:11:02 INFO - 'XPC_FLAGS': '0x0', 04:11:02 INFO - 'XPC_SERVICE_NAME': '0', 04:11:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:11:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:11:02 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 04:11:02 INFO - Cleaning up... 04:11:02 INFO - Return code: 0 04:11:02 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 04:11:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:11:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:11:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:11:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:11:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:11:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:11:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10455c490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1044d2570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fee7b4a7050>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104370d30>, '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 0x1041d6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104368b20>, '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.Ej6Y6nvngP/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.iX0ux7Fnyr/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/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 04:11:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 04:11:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 04:11:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Ej6Y6nvngP/Render', 04:11:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:11:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:11:02 INFO - 'HOME': '/Users/cltbld', 04:11:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:11:02 INFO - 'LOGNAME': 'cltbld', 04:11:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:11:02 INFO - 'MOZ_NO_REMOTE': '1', 04:11:02 INFO - 'NO_EM_RESTART': '1', 04:11:02 INFO - 'PAGER': '/bin/cat', 04:11:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:11:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:11:02 INFO - 'PWD': '/builds/slave/test', 04:11:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:11:02 INFO - 'SHELL': '/bin/bash', 04:11:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.iX0ux7Fnyr/Listeners', 04:11:02 INFO - 'TMPDIR': '/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/', 04:11:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:11:02 INFO - 'USER': 'cltbld', 04:11:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:11:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:11:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:11:02 INFO - 'XPC_FLAGS': '0x0', 04:11:02 INFO - 'XPC_SERVICE_NAME': '0', 04:11:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:11:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:11:03 INFO - Downloading/unpacking psutil>=3.1.1 04:11:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:11:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:11:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:11:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:11:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:11:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:11:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:11:06 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:11:06 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:11:06 INFO - Installing collected packages: psutil 04:11:06 INFO - Running setup.py install for psutil 04:11:06 INFO - building 'psutil._psutil_osx' extension 04:11:06 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 04:11:07 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 04:11:07 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 04:11:07 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 04:11:07 INFO - building 'psutil._psutil_posix' extension 04:11:07 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 04:11:07 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 04:11:07 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 04:11:07 INFO - ^ 04:11:07 INFO - 1 warning generated. 04:11:07 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 04:11:07 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:11:07 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:11:07 INFO - Successfully installed psutil 04:11:07 INFO - Cleaning up... 04:11:07 INFO - Return code: 0 04:11:07 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 04:11:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:11:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:11:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:11:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:11:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:11:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:11:07 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 0x10455c490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1044d2570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fee7b4a7050>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104370d30>, '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 0x1041d6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104368b20>, '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.Ej6Y6nvngP/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.iX0ux7Fnyr/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/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 04:11:07 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 04:11:07 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 04:11:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Ej6Y6nvngP/Render', 04:11:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:11:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:11:07 INFO - 'HOME': '/Users/cltbld', 04:11:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:11:07 INFO - 'LOGNAME': 'cltbld', 04:11:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:11:07 INFO - 'MOZ_NO_REMOTE': '1', 04:11:07 INFO - 'NO_EM_RESTART': '1', 04:11:07 INFO - 'PAGER': '/bin/cat', 04:11:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:11:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:11:07 INFO - 'PWD': '/builds/slave/test', 04:11:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:11:07 INFO - 'SHELL': '/bin/bash', 04:11:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.iX0ux7Fnyr/Listeners', 04:11:07 INFO - 'TMPDIR': '/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/', 04:11:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:11:07 INFO - 'USER': 'cltbld', 04:11:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:11:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:11:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:11:07 INFO - 'XPC_FLAGS': '0x0', 04:11:07 INFO - 'XPC_SERVICE_NAME': '0', 04:11:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:11:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:11:07 INFO - Downloading/unpacking mozsystemmonitor==0.3 04:11:07 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 04:11:07 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 04:11:07 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 04:11:07 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 04:11:07 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 04:11:07 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 04:11:10 INFO - Downloading mozsystemmonitor-0.3.tar.gz 04:11:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:11:10 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 04:11:10 INFO - Installing collected packages: mozsystemmonitor 04:11:10 INFO - Running setup.py install for mozsystemmonitor 04:11:10 INFO - Successfully installed mozsystemmonitor 04:11:10 INFO - Cleaning up... 04:11:10 INFO - Return code: 0 04:11:10 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 04:11:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:11:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:11:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:11:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:11:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:11:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:11:10 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10455c490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1044d2570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fee7b4a7050>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104370d30>, '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 0x1041d6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104368b20>, '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.Ej6Y6nvngP/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.iX0ux7Fnyr/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/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 04:11:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 04:11:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 04:11:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Ej6Y6nvngP/Render', 04:11:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:11:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:11:10 INFO - 'HOME': '/Users/cltbld', 04:11:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:11:10 INFO - 'LOGNAME': 'cltbld', 04:11:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:11:10 INFO - 'MOZ_NO_REMOTE': '1', 04:11:10 INFO - 'NO_EM_RESTART': '1', 04:11:10 INFO - 'PAGER': '/bin/cat', 04:11:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:11:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:11:10 INFO - 'PWD': '/builds/slave/test', 04:11:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:11:10 INFO - 'SHELL': '/bin/bash', 04:11:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.iX0ux7Fnyr/Listeners', 04:11:10 INFO - 'TMPDIR': '/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/', 04:11:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:11:10 INFO - 'USER': 'cltbld', 04:11:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:11:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:11:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:11:10 INFO - 'XPC_FLAGS': '0x0', 04:11:10 INFO - 'XPC_SERVICE_NAME': '0', 04:11:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:11:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:11:10 INFO - Downloading/unpacking jsonschema==2.5.1 04:11:10 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 04:11:10 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 04:11:10 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 04:11:10 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 04:11:10 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 04:11:10 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 04:11:13 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:11:13 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 04:11:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:11:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:11:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:11:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:11:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:11:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:11:14 INFO - Downloading functools32-3.2.3-2.tar.gz 04:11:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:11:14 INFO - warning: no files found matching '*.txt' 04:11:14 INFO - no previously-included directories found matching 'build' 04:11:14 INFO - no previously-included directories found matching 'dist' 04:11:14 INFO - no previously-included directories found matching '.git*' 04:11:14 INFO - Installing collected packages: jsonschema, functools32 04:11:14 INFO - Running setup.py install for functools32 04:11:14 INFO - warning: no files found matching '*.txt' 04:11:14 INFO - no previously-included directories found matching 'build' 04:11:14 INFO - no previously-included directories found matching 'dist' 04:11:14 INFO - no previously-included directories found matching '.git*' 04:11:14 INFO - Successfully installed jsonschema functools32 04:11:14 INFO - Cleaning up... 04:11:14 INFO - Return code: 0 04:11:14 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 04:11:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:11:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:11:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:11:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:11:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:11:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:11:14 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10455c490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1044d2570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fee7b4a7050>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104370d30>, '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 0x1041d6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104368b20>, '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.Ej6Y6nvngP/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.iX0ux7Fnyr/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/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 04:11:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 04:11:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 04:11:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Ej6Y6nvngP/Render', 04:11:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:11:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:11:14 INFO - 'HOME': '/Users/cltbld', 04:11:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:11:14 INFO - 'LOGNAME': 'cltbld', 04:11:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:11:14 INFO - 'MOZ_NO_REMOTE': '1', 04:11:14 INFO - 'NO_EM_RESTART': '1', 04:11:14 INFO - 'PAGER': '/bin/cat', 04:11:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:11:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:11:14 INFO - 'PWD': '/builds/slave/test', 04:11:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:11:14 INFO - 'SHELL': '/bin/bash', 04:11:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.iX0ux7Fnyr/Listeners', 04:11:14 INFO - 'TMPDIR': '/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/', 04:11:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:11:14 INFO - 'USER': 'cltbld', 04:11:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:11:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:11:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:11:14 INFO - 'XPC_FLAGS': '0x0', 04:11:14 INFO - 'XPC_SERVICE_NAME': '0', 04:11:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:11:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:11:14 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 04:11:14 INFO - Cleaning up... 04:11:14 INFO - Return code: 0 04:11:14 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:11:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:11:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:11:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:11:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:11:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:11:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:11:14 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10455c490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1044d2570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fee7b4a7050>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104370d30>, '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 0x1041d6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104368b20>, '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.Ej6Y6nvngP/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.iX0ux7Fnyr/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/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 04:11:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 04:11:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 04:11:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Ej6Y6nvngP/Render', 04:11:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:11:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:11:14 INFO - 'HOME': '/Users/cltbld', 04:11:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:11:14 INFO - 'LOGNAME': 'cltbld', 04:11:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:11:14 INFO - 'MOZ_NO_REMOTE': '1', 04:11:14 INFO - 'NO_EM_RESTART': '1', 04:11:14 INFO - 'PAGER': '/bin/cat', 04:11:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:11:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:11:14 INFO - 'PWD': '/builds/slave/test', 04:11:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:11:14 INFO - 'SHELL': '/bin/bash', 04:11:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.iX0ux7Fnyr/Listeners', 04:11:14 INFO - 'TMPDIR': '/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/', 04:11:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:11:14 INFO - 'USER': 'cltbld', 04:11:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:11:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:11:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:11:14 INFO - 'XPC_FLAGS': '0x0', 04:11:14 INFO - 'XPC_SERVICE_NAME': '0', 04:11:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:11:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:11:15 INFO - Downloading/unpacking blobuploader==1.2.4 04:11:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:11:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:11:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:11:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:11:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:11:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:11:17 INFO - Downloading blobuploader-1.2.4.tar.gz 04:11:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:11:17 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:11:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:11:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:11:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:11:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:11:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:11:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:11:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:11:18 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:11:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:11:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:11:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:11:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:11:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:11:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:11:18 INFO - Downloading docopt-0.6.1.tar.gz 04:11:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:11:19 INFO - Installing collected packages: blobuploader, requests, docopt 04:11:19 INFO - Running setup.py install for blobuploader 04:11:19 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:11:19 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:11:19 INFO - Running setup.py install for requests 04:11:19 INFO - Running setup.py install for docopt 04:11:19 INFO - Successfully installed blobuploader requests docopt 04:11:19 INFO - Cleaning up... 04:11:20 INFO - Return code: 0 04:11:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:11: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')]} 04:11:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:11:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:11: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')]} 04:11:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:11:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:11:20 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10455c490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1044d2570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fee7b4a7050>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104370d30>, '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 0x1041d6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104368b20>, '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.Ej6Y6nvngP/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.iX0ux7Fnyr/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/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 04:11:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 04:11:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:11:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Ej6Y6nvngP/Render', 04:11:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:11:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:11:20 INFO - 'HOME': '/Users/cltbld', 04:11:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:11:20 INFO - 'LOGNAME': 'cltbld', 04:11:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:11:20 INFO - 'MOZ_NO_REMOTE': '1', 04:11:20 INFO - 'NO_EM_RESTART': '1', 04:11:20 INFO - 'PAGER': '/bin/cat', 04:11:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:11:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:11:20 INFO - 'PWD': '/builds/slave/test', 04:11:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:11:20 INFO - 'SHELL': '/bin/bash', 04:11:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.iX0ux7Fnyr/Listeners', 04:11:20 INFO - 'TMPDIR': '/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/', 04:11:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:11:20 INFO - 'USER': 'cltbld', 04:11:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:11:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:11:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:11:20 INFO - 'XPC_FLAGS': '0x0', 04:11:20 INFO - 'XPC_SERVICE_NAME': '0', 04:11:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:11:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:11:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:11:20 INFO - Running setup.py (path:/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/pip-TnZbQy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:11:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:11:20 INFO - Running setup.py (path:/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/pip-dBZsuh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:11:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:11:20 INFO - Running setup.py (path:/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/pip-IErCEz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:11:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:11:20 INFO - Running setup.py (path:/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/pip-CdgSr1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:11:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:11:20 INFO - Running setup.py (path:/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/pip-b86RT7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:11:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:11:20 INFO - Running setup.py (path:/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/pip-DLUDBp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:11:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:11:20 INFO - Running setup.py (path:/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/pip-ws8plZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:11:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:11:20 INFO - Running setup.py (path:/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/pip-BBoqzx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:11:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:11:21 INFO - Running setup.py (path:/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/pip-RGGMJm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:11:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:11:21 INFO - Running setup.py (path:/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/pip-kL5T28-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:11:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:11:21 INFO - Running setup.py (path:/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/pip-ND2Faz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:11:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:11:21 INFO - Running setup.py (path:/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/pip-jM2C6W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:11:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:11:21 INFO - Running setup.py (path:/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/pip-ji0Rs_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:11:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:11:21 INFO - Running setup.py (path:/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/pip-CQVzHQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:11:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:11:21 INFO - Running setup.py (path:/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/pip-6mN09s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:11:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:11:21 INFO - Running setup.py (path:/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/pip-UH_51z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:11:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:11:21 INFO - Running setup.py (path:/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/pip-jsvU5g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:11:22 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:11:22 INFO - Running setup.py install for manifestparser 04:11:22 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:11:22 INFO - Running setup.py install for mozcrash 04:11:22 INFO - Running setup.py install for mozdebug 04:11:22 INFO - Running setup.py install for mozdevice 04:11:22 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:11:22 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:11:22 INFO - Running setup.py install for mozfile 04:11:22 INFO - Running setup.py install for mozhttpd 04:11:22 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:11:22 INFO - Running setup.py install for mozinfo 04:11:23 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:11:23 INFO - Running setup.py install for mozInstall 04:11:23 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:11:23 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:11:23 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:11:23 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:11:23 INFO - Running setup.py install for mozleak 04:11:23 INFO - Running setup.py install for mozlog 04:11:23 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:11:23 INFO - Running setup.py install for moznetwork 04:11:23 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:11:23 INFO - Running setup.py install for mozprocess 04:11:23 INFO - Running setup.py install for mozprofile 04:11:23 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:11:23 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:11:23 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:11:23 INFO - Running setup.py install for mozrunner 04:11:24 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:11:24 INFO - Running setup.py install for mozscreenshot 04:11:24 INFO - Running setup.py install for moztest 04:11:24 INFO - Running setup.py install for mozversion 04:11:24 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:11:24 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:11:24 INFO - Cleaning up... 04:11:24 INFO - Return code: 0 04:11:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:11:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:11:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:11:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:11:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:11:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:11:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:11:24 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10455c490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1044d2570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fee7b4a7050>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104370d30>, '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 0x1041d6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104368b20>, '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.Ej6Y6nvngP/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.iX0ux7Fnyr/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/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 04:11:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 04:11:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:11:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Ej6Y6nvngP/Render', 04:11:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:11:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:11:24 INFO - 'HOME': '/Users/cltbld', 04:11:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:11:24 INFO - 'LOGNAME': 'cltbld', 04:11:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:11:24 INFO - 'MOZ_NO_REMOTE': '1', 04:11:24 INFO - 'NO_EM_RESTART': '1', 04:11:24 INFO - 'PAGER': '/bin/cat', 04:11:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:11:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:11:24 INFO - 'PWD': '/builds/slave/test', 04:11:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:11:24 INFO - 'SHELL': '/bin/bash', 04:11:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.iX0ux7Fnyr/Listeners', 04:11:24 INFO - 'TMPDIR': '/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/', 04:11:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:11:24 INFO - 'USER': 'cltbld', 04:11:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:11:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:11:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:11:24 INFO - 'XPC_FLAGS': '0x0', 04:11:24 INFO - 'XPC_SERVICE_NAME': '0', 04:11:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:11:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:11:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:11:24 INFO - Running setup.py (path:/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/pip-yfKtqV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:11:24 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)) 04:11:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:11:24 INFO - Running setup.py (path:/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/pip-uQx32w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:11:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 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)) 04:11:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:11:25 INFO - Running setup.py (path:/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/pip-0Fle8j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:11:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 04:11:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:11:25 INFO - Running setup.py (path:/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/pip-0sZQQa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:11:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 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)) 04:11:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:11:25 INFO - Running setup.py (path:/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/pip-0dcjQi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:11:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 04:11:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:11:25 INFO - Running setup.py (path:/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/pip-xC6WJY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:11:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 04:11:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:11:25 INFO - Running setup.py (path:/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/pip-DI2pYz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:11:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 04:11:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:11:25 INFO - Running setup.py (path:/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/pip-EdI5aJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:11:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 04:11:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:11:25 INFO - Running setup.py (path:/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/pip-dxmmg_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:11:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 04:11:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:11:25 INFO - Running setup.py (path:/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/pip-s_3f2V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:11:25 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)) 04:11:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:11:25 INFO - Running setup.py (path:/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/pip-KZY1xt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:11:26 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 04:11:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:11:26 INFO - Running setup.py (path:/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/pip-UZjIRN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:11:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 04:11:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:11:26 INFO - Running setup.py (path:/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/pip-tgMIMl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:11:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 04:11:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:11:26 INFO - Running setup.py (path:/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/pip-q9VzOG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:11:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 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)) 04:11:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:11:26 INFO - Running setup.py (path:/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/pip-KTm2_Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:11:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 04:11:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:11:26 INFO - Running setup.py (path:/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/pip-DdUo_D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:11:26 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 04:11:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:11:26 INFO - Running setup.py (path:/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/pip-ruxS3T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:11:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 04:11:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:11:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:11:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 04:11:26 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:11:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:11:26 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:11: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 04:11: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 04:11: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 04:11: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 04:11: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 04:11: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 04:11:29 INFO - Downloading blessings-1.6.tar.gz 04:11:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:11:29 INFO - Installing collected packages: blessings 04:11:29 INFO - Running setup.py install for blessings 04:11:29 INFO - Successfully installed blessings 04:11:29 INFO - Cleaning up... 04:11:29 INFO - Return code: 0 04:11:29 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:11:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:11:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:11:29 INFO - Reading from file tmpfile_stdout 04:11:29 INFO - Current package versions: 04:11:29 INFO - blessings == 1.6 04:11:29 INFO - blobuploader == 1.2.4 04:11:29 INFO - docopt == 0.6.1 04:11:29 INFO - functools32 == 3.2.3-2 04:11:29 INFO - jsonschema == 2.5.1 04:11:29 INFO - manifestparser == 1.1 04:11:29 INFO - mozInstall == 1.12 04:11:29 INFO - mozcrash == 0.17 04:11:29 INFO - mozdebug == 0.1 04:11:29 INFO - mozdevice == 0.48 04:11:29 INFO - mozfile == 1.2 04:11:29 INFO - mozhttpd == 0.7 04:11:29 INFO - mozinfo == 0.9 04:11:29 INFO - mozleak == 0.1 04:11:29 INFO - mozlog == 3.4 04:11:29 INFO - moznetwork == 0.27 04:11:29 INFO - mozprocess == 0.23 04:11:29 INFO - mozprofile == 0.28 04:11:29 INFO - mozrunner == 6.12 04:11:29 INFO - mozscreenshot == 0.1 04:11:29 INFO - mozsystemmonitor == 0.3 04:11:29 INFO - moztest == 0.7 04:11:29 INFO - mozversion == 1.4 04:11:29 INFO - psutil == 3.1.1 04:11:29 INFO - requests == 1.2.3 04:11:29 INFO - wsgiref == 0.1.2 04:11:29 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:11: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')]} 04:11:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:11:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:11: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')]} 04:11:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:11:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:11:29 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 0x10455c490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1044d2570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fee7b4a7050>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104370d30>, '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 0x1041d6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104368b20>, '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.Ej6Y6nvngP/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.iX0ux7Fnyr/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/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 04:11:29 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 04:11:29 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 04:11:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Ej6Y6nvngP/Render', 04:11:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:11:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:11:29 INFO - 'HOME': '/Users/cltbld', 04:11:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:11:29 INFO - 'LOGNAME': 'cltbld', 04:11:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:11:29 INFO - 'MOZ_NO_REMOTE': '1', 04:11:29 INFO - 'NO_EM_RESTART': '1', 04:11:29 INFO - 'PAGER': '/bin/cat', 04:11:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:11:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:11:29 INFO - 'PWD': '/builds/slave/test', 04:11:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:11:29 INFO - 'SHELL': '/bin/bash', 04:11:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.iX0ux7Fnyr/Listeners', 04:11:29 INFO - 'TMPDIR': '/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/', 04:11:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:11:29 INFO - 'USER': 'cltbld', 04:11:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:11:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:11:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:11:29 INFO - 'XPC_FLAGS': '0x0', 04:11:29 INFO - 'XPC_SERVICE_NAME': '0', 04:11:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:11:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:11:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 04:11:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 04:11:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 04:11:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 04:11:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 04:11:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 04:11:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 04:11:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 04:11:30 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 04:11:30 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 04:11:30 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 04:11:30 INFO - Cleaning up... 04:11:30 INFO - Return code: 0 04:11:30 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:11:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:11:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:11:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:11:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:11:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:11:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:11:30 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10455c490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1044d2570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fee7b4a7050>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104370d30>, '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 0x1041d6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104368b20>, '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.Ej6Y6nvngP/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.iX0ux7Fnyr/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/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 04:11:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 04:11:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 04:11:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Ej6Y6nvngP/Render', 04:11:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:11:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:11:30 INFO - 'HOME': '/Users/cltbld', 04:11:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:11:30 INFO - 'LOGNAME': 'cltbld', 04:11:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:11:30 INFO - 'MOZ_NO_REMOTE': '1', 04:11:30 INFO - 'NO_EM_RESTART': '1', 04:11:30 INFO - 'PAGER': '/bin/cat', 04:11:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:11:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:11:30 INFO - 'PWD': '/builds/slave/test', 04:11:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:11:30 INFO - 'SHELL': '/bin/bash', 04:11:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.iX0ux7Fnyr/Listeners', 04:11:30 INFO - 'TMPDIR': '/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/', 04:11:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:11:30 INFO - 'USER': 'cltbld', 04:11:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:11:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:11:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:11:30 INFO - 'XPC_FLAGS': '0x0', 04:11:30 INFO - 'XPC_SERVICE_NAME': '0', 04:11:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:11:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:11:30 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 04:11:30 INFO - Cleaning up... 04:11:30 INFO - Return code: 0 04:11:30 INFO - Running post-action listener: _resource_record_post_action 04:11:30 INFO - Running post-action listener: _start_resource_monitoring 04:11:30 INFO - Starting resource monitoring. 04:11:30 INFO - [mozharness: 2016-12-29 12:11:30.495266Z] Finished create-virtualenv step (success) 04:11:30 INFO - [mozharness: 2016-12-29 12:11:30.496232Z] Running install step. 04:11:30 INFO - Running pre-action listener: _resource_record_pre_action 04:11:30 INFO - Running main action method: install 04:11:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:11:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:11:30 INFO - Reading from file tmpfile_stdout 04:11:30 INFO - Detecting whether we're running mozinstall >=1.0... 04:11:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:11:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:11:30 INFO - Reading from file tmpfile_stdout 04:11:30 INFO - Output received: 04:11:30 INFO - Usage: mozinstall [options] installer 04:11:30 INFO - Options: 04:11:30 INFO - -h, --help show this help message and exit 04:11:30 INFO - -d DEST, --destination=DEST 04:11:30 INFO - Directory to install application into. [default: 04:11:30 INFO - "/builds/slave/test"] 04:11:30 INFO - --app=APP Application being installed. [default: firefox] 04:11:30 INFO - mkdir: /builds/slave/test/build/application 04:11:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 04:11:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0.en-US.mac.dmg --destination /builds/slave/test/build/application 04:11:53 INFO - Reading from file tmpfile_stdout 04:11:53 INFO - Output received: 04:11:53 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 04:11:53 INFO - Running post-action listener: _resource_record_post_action 04:11:53 INFO - [mozharness: 2016-12-29 12:11:53.227919Z] Finished install step (success) 04:11:53 INFO - [mozharness: 2016-12-29 12:11:53.228106Z] Running run-tests step. 04:11:53 INFO - Running pre-action listener: _resource_record_pre_action 04:11:53 INFO - Running main action method: run_tests 04:11:53 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:11:53 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:11:53 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:11:53 INFO - 2016-12-29 04:11:53.242 screenresolution[1950:9878] starting screenresolution argv=screenresolution get 04:11:53 INFO - 2016-12-29 04:11:53.245 screenresolution[1950:9878] Display 0: 1600x1200x32@60 04:11:53 INFO - 2016-12-29 04:11:53.251 screenresolution[1951:9880] starting screenresolution argv=screenresolution list 04:11:53 INFO - Available Modes on Display 0 04:11:53 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:11:53 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:11:53 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:11:53 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:11:53 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:11:53 INFO - Intel Iris: 04:11:53 INFO - Chipset Model: Intel Iris 04:11:53 INFO - Type: GPU 04:11:53 INFO - Bus: Built-In 04:11:53 INFO - VRAM (Dynamic, Max): 1536 MB 04:11:53 INFO - Vendor: Intel (0x8086) 04:11:53 INFO - Device ID: 0x0a2e 04:11:53 INFO - Revision ID: 0x0009 04:11:53 INFO - Displays: 04:11:53 INFO - Display: 04:11:53 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:11:53 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:11:53 INFO - Display Serial Number: 1600x1200 60 04:11:53 INFO - Main Display: Yes 04:11:53 INFO - Mirror: Off 04:11:53 INFO - Online: Yes 04:11:53 INFO - Rotation: Supported 04:11:53 INFO - Return code: 0 04:11:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:11:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:11:53 INFO - Python 2.7.3 04:11:53 INFO - Return code: 0 04:11:53 INFO - grabbing minidump binary from tooltool 04:11: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')]} 04:11:53 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104370d30>, '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 0x1041d6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104368b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:11:53 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 04:11:53 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 04:11:53 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 04:11:53 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:11:53 INFO - Return code: 0 04:11:53 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 04:11:53 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:11:53 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:11:53 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 04:11:53 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:11:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/c56tdNxOS9usCrrt9dwM6g/artifacts/public/build/firefox-51.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0015', '--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 04:11:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs --executablePath /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/c56tdNxOS9usCrrt9dwM6g/artifacts/public/build/firefox-51.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0015 --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 04:11:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Ej6Y6nvngP/Render', 04:11:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:11:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:11:53 INFO - 'HOME': '/Users/cltbld', 04:11:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:11:53 INFO - 'LOGNAME': 'cltbld', 04:11:53 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:11:53 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 04:11:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:11:53 INFO - 'MOZ_NO_REMOTE': '1', 04:11:53 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:11:53 INFO - 'NO_EM_RESTART': '1', 04:11:53 INFO - 'PAGER': '/bin/cat', 04:11:53 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:11:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:11:53 INFO - 'PWD': '/builds/slave/test', 04:11:53 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:11:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:11:53 INFO - 'SHELL': '/bin/bash', 04:11:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.iX0ux7Fnyr/Listeners', 04:11:53 INFO - 'TMPDIR': '/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/', 04:11:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:11:53 INFO - 'USER': 'cltbld', 04:11:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:11:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:11:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:11:53 INFO - 'XPC_FLAGS': '0x0', 04:11:53 INFO - 'XPC_SERVICE_NAME': '0', 04:11:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:11:53 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/c56tdNxOS9usCrrt9dwM6g/artifacts/public/build/firefox-51.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0015', '--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 04:11:53 INFO - mozversion application_buildid: 20161229014137 04:11:53 INFO - mozversion application_changeset: d843dc104a2e124539e43aeff6fa8a89aa1cc430 04:11:53 INFO - mozversion application_display_name: Firefox 04:11:53 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:11:53 INFO - mozversion application_name: Firefox 04:11:53 INFO - mozversion application_remotingname: firefox 04:11:53 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 04:11:53 INFO - mozversion application_vendor: Mozilla 04:11:53 INFO - mozversion application_version: 51.0 04:11:53 INFO - mozversion platform_buildid: 20161229014137 04:11:53 INFO - mozversion platform_changeset: d843dc104a2e124539e43aeff6fa8a89aa1cc430 04:11:53 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 04:11:53 INFO - mozversion platform_version: 51.0 04:11:53 INFO - using testdate: 1483013513 04:11:53 INFO - actual date: 1483013513 04:11:53 INFO - starting webserver on 'localhost:49318' 04:11:53 INFO - SUITE-START | Running 2 tests 04:11:53 INFO - TEST-START | dromaeo_css 04:11:53 INFO - operating with platform_type : mac_ 04:11:53 INFO - Initialising browser for dromaeo_css test... 04:11:53 INFO - TEST-INFO | started process 1961 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/tmp1NgaEZ/profile http://localhost:49318/getInfo.html) 04:11:56 INFO - PROCESS | 1961 | __metrics Screen width/height:1600/1200 04:11:56 INFO - PROCESS | 1961 | colorDepth:24 04:11:56 INFO - PROCESS | 1961 | Browser inner width/height: 1024/689 04:11:56 INFO - PROCESS | 1961 | __metrics 04:11:56 INFO - PROCESS | 1961 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 04:11:56 INFO - PROCESS | 1961 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:11:57 INFO - TEST-INFO | 1961: exit 0 04:11:57 INFO - Browser initialized. 04:11:57 INFO - Running cycle 1/1 for dromaeo_css test... 04:11:57 INFO - TEST-INFO | started process 1964 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/tmp1NgaEZ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:12:09 INFO - PROCESS | 1964 | RSS: Main: 168939520 04:12:09 INFO - PROCESS | 1964 | 04:13:00 INFO - PROCESS | 1964 | 1483013580013 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] 04:15:11 INFO - PROCESS | 1964 | Cycle 1(1): loaded http://localhost:49318/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49318/tests/dromaeo/cssquery-ext.html) 04:15:12 INFO - PROCESS | 1964 | RSS: Main: 306114560 04:15:12 INFO - PROCESS | 1964 | 04:18:15 INFO - PROCESS | 1964 | Cycle 1(1): loaded http://localhost:49318/tests/dromaeo/cssquery-ext.html (next: http://localhost:49318/tests/dromaeo/cssquery-jquery.html) 04:18:16 INFO - PROCESS | 1964 | RSS: Main: 299442176 04:18:16 INFO - PROCESS | 1964 | 04:21:18 INFO - PROCESS | 1964 | Cycle 1(1): loaded http://localhost:49318/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49318/tests/dromaeo/cssquery-mootools.html) 04:21:19 INFO - PROCESS | 1964 | RSS: Main: 285421568 04:21:19 INFO - PROCESS | 1964 | 04:24:21 INFO - PROCESS | 1964 | Cycle 1(1): loaded http://localhost:49318/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49318/tests/dromaeo/cssquery-prototype.html) 04:24:22 INFO - PROCESS | 1964 | RSS: Main: 271314944 04:24:22 INFO - PROCESS | 1964 | 04:27:25 INFO - PROCESS | 1964 | Cycle 1(1): loaded http://localhost:49318/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49318/tests/dromaeo/cssquery-yui.html) 04:27:26 INFO - PROCESS | 1964 | RSS: Main: 267042816 04:27:26 INFO - PROCESS | 1964 | 04:30:29 INFO - PROCESS | 1964 | Cycle 1(1): loaded http://localhost:49318/tests/dromaeo/cssquery-yui.html (next: http://localhost:49318/tests/dromaeo/cssquery-dojo.html) 04:30:29 INFO - PROCESS | 1964 | RSS: Main: 333008896 04:30:29 INFO - PROCESS | 1964 | 04:30:29 INFO - PROCESS | 1964 | __start_tp_report 04:30:29 INFO - PROCESS | 1964 | _x_x_mozilla_page_load 04:30:29 INFO - PROCESS | 1964 | _x_x_mozilla_page_load_details 04:30:29 INFO - PROCESS | 1964 | |i|pagename|runs| 04:30:29 INFO - PROCESS | 1964 | |0;dojo.html;3454.1019334972907;3455.429854074078;3472.548568686072;3501.404761190597;3533.9646603533974;5747.626404283724;5764.769409223636;5782.595218334708;5797.36229014808;5807.506361959238;5707.286589176353;5721.742521586528;5780.971095144529;5816.651000939936;5819.621724587899;5207.817726379587;5235.450277720842;5262;5288.444713305105;5295.126304159809;5220.817271395502;5224.712640804754;5242.8165014224505;5332.120200166968;5353.678779273256;5279.2872962150195;5286.814961476349;5321.148616221405;5323.946760532383;5326.387465441485;5253.212018197263;5261.210818377236;5264.315638966948;5293.338332708411;5327.760250788724;5149.524735578351;5232.372115346145;5254.553362964152;5282.445343238982;5285.920711189336;5680.744366503517;5707.74315155819;5731.742071606787;5782.161586569966;5793.594448388614;6146.815595532141;6229.96885015572;6238.4697300729495;6327.905081423783;6339.96830015847;5177.741112944375;6330.9683451582905;6347.555671103025;6347.968260158716;6381.840453988688;5758.74085666146;5807.274090738658;5851.063829787214;5872.911906321408;5935.614185077956;5221.373435187802;6287.308396076428;6296.811095667137;6318.273398559132;6330.113784070234;6234.064890266405;6234.781782637586;6239.656818874914;6259.6870156492;6266.467350275187;6249.281332646713;6258.405451482102;6323.399277068671;6337.809865703944;6341.556091073673;6120.355709576858;6194.0708893666315;6215.440610345091;6315.463185629181;6324.557280990287;6248.4064013918605;6317.778877739349;6326.841828954221;6335.809925702236;6354.142190804275;5036.597072234213;5042.319286896295;5052.9494705052475;5055.014272216956;5081.212412076134;4462.152191083684;4470.865874023784;4500.257457519473;4544.750038747835;4545.909081818345;5763.423657634203;5827.446392592697;5831.358550559435;5831.854203644943;5913.349531551526;6321.209848768904;6326.557141000178;6349.206349206349;6358.713857876407;6366.6180029198395;5852.7658893643775;5858.47273745365;5860.38465961068;5875;5903.0555111182;5358.705271210121;5394.8921021579345;5438.102713052302;5456.099743542271;5506.063969125258;6305.085762564402;6324.968375158095;6345.206849143857;6364.459020983176;6405.455536279282;6343.968280158754;6345.206849143857;6362.491000720024;6371.203599550056;6371.649559274284;6270.310265870842;6323.747050118128;6397.264314603694;6408.711607977559;6412.871742565216;6177.660228687465;6238.781642642486;6287.71705273273;6317.810465686037;6360.554761166674;6352.428281454691;6368.713407896748;6372.426481616677;6376.808695739135;6394.200724909387;6159.72281247336;6246.843828904313;6296.748130074746;6300.149479820349;6306.495480361652;6131.141640170291;6131.284916201153;6142.959235178615;6151.784687535915;6199.56603037783;6121.755129794758;6146.262448506208;6146.416090471398;6150.815475535741;6156.815295541141;6226.1905952225925;6244.812655620339;6247.250329960434;6255.999040153553;6260;5206.505381988705;5294.338207724035;5891.793787217427;6023.277206735044;6028.668423236764 04:30:29 INFO - PROCESS | 1964 | |1;ext.html;517.7230181852708;520.8828013696918;528.5877015927576;548.9588280878933;573.8522954091817;26043.86978065112;42508.512202072896;43950.461733839285;44186.895327616825;46139.53860461395;45529;45892;45935;46040.539594604044;46143;9373.437593744364;9636;10169.644062457834;10370.066693997538;10385.42880141592;12214.083943704214;12550;12567.245965242115;12679.429425675868;12696.111272210948;12307.38463076847;12388.194767340094;12397.752044959096;12399.752004959895;12409.627711168634;12469.940055095283;12540.686482837911;12541.122121451503;12555.435005424777;12560.874391256062;12389.318587477685;12462.252264864137;12474.313912734797;12474.625761227178;12510.81233781494;42365.788171059256;42583;42624.57375426268;42678;42823;3415.880444184442;3955.7033222508426;4165.895852603679;4181.372794080882;4186.769727664977;26094.608580871303;33185;33348.49977250343;33473.66526334754;33943.81196658105;3336.349411864687;3351.6480769519335;3368.511565822942;3415.2486452980306;3493.266414053052;530208;532809;534139;535358;536404;35122.297554048775;35767.821160894026;35955;63086.68456657687;63664.68167659225;37117.62882371142;37251.62748372536;37388;37430.812845935594;37444.063898402215;15854.524364269091;16051.518454446385;16053.839461605468;16061.437849675205;16071;12350.38248087592;12634.178778379375;13116.278604676834;13368.131071480322;13379.53171638988;8251.422400431911;8258.917410825814;8301.211384918422;8330.8333833323;8367.665293388318;3465.4108801503803;3471.687548120681;3474.4961980512685;3477.9478307824897;3523.6124026357593;934.6728644974205;964.5676170886228;972.6741541583507;990.7126933189294;1034.4724190662816;30975.225619359695;31033;31084.067477975696;31611.683883161335;31730.841345793124;1104.4422566603973;1134.4838098665089;1161.7095726068483;1164.9184557080923;1184.6682928779956;16089.195540223176;16566.337346506003;16837.073960932266;17256;17427.47717568475;727257;732344;734765;735345;737852;63163;63503.364966350666;63559.364406355344;63599.046014309824;63707;1293.9029572782079;1325.840899092115;1414.6251243420295;1427.7358688642635;1448.2324368084933;25942.702864856303;30258;31579.052628421185;32464;32480.35039299248;60243;61182;61288;61459;61603.07595385983;672618;680288;680675;680757;915303;37581.81209093937;47227.76386118047;47554.286685700434;47853.760731197515;48107.03785924192;49522.75238623784;50109;50570;50572.49427505678;50624.240636389746;39865.60134398735;40467.595324046386;41742.79128604338;42100.157996839276;43499;42034.159316814104;42104.78947605242;42640.57359426366;42929.57070429256;43140.352894707234;40640.79679601583;41257.174856503305;41622.583774161874;41683.37474937818;41767.164656707304;35193.29613407769;36475.27049459049;36627.90116296515;37428;37570;27072;27153.59269610918;27214.591781122905;27265;27419.588706169023 04:30:29 INFO - PROCESS | 1964 | |2;jquery.html;342.5136306444848;383.24691980258797;383.9366504526755;395.10311592684604;416.38998866660336;16530.917345413287;17329.48011559652;19737.901310493446;21775.782242177575;22114.999999999978;18202.544936376566;21856.25149988001;22013.459057865955;22471;22609.321720348376;6042.425969532887;6118.265808103034;6216.658083805389;6301.968490157566;6416.839579010515;4373.825046998117;6246.687665616723;6253.562250642457;6289.779857704982;6290.811275661715;4451.977740111295;6631.801045968605;6917.031615573824;6959.721611135574;7055.153381594216;6820.420264277543;6930.468186800725;6961.303869613049;6998.755043573476;7007.019017337526;5952.940470595282;5979.790707325223;5988.431099045583;6122.816315510542;6139.201903752483;21467.67798483024;27533.586996195074;27603;27876;28017;2141.8714877107423;2176.4341271269427;2558.8592627405487;2674.398260391416;2958.778091643114;15643.530694079082;15959.521214363587;16019.199040047952;16920.323187072503;17337.479875603753;1959.8824070555813;1979.633767752956;2004.7594288685304;2040.5918816236813;2055.2806517718827;118248.40875795652;120131;121783.78216217813;123464;125523.11715324187;10936.671899843017;11135.944320278346;11500.88499115015;11513.597024104116;11756.764864702829;12057.638270851889;14448.277586120652;14502.564923052325;14503;14522.49171279;7573.6213189340315;8881.911180888237;9002.05478424769;9018.729438116867;9093.40892841963;9255.76860578491;9266.31681864427;9272.72181834546;9283.953580232192;9445.433274003582;6670.899301615179;6951.860962780817;6966.860662786818;6973.163220413583;6987.510874238857;1555.478914563634;1622.3429511048043;1900.667383207933;1907.818757218062;1912.359359614517;815.2255357410365;843.8481073406723;844.2359664503634;915.771057235691;937.1378331934636;21008.949552522314;21564.274858011322;22288.77711222867;23474.061037558306;23498.295051148492;982.9557669904872;1001.329109496639;1015.5785349080197;1028.8713910761155;1108.2962318927378;11885.5840045598;12216.511339546318;12413.131080824256;12438.875611243953;12536.937315313366;588366.058169715;627853;639995;655516;655958;120903.18645220328;124096.75903241032;126123.3693831525;126674;127075.09387359198;924.0805398628407;977.3744803325877;1006.572206812102;1046.0689985912543;1079.8704155501391;19081.236750529824;20376.123958328113;20450.897745511178;20545.178192872118;20578;58368;59771.1034334494;59833.700831497306;60041.196704264425;61667.69166154141;80118.99702507484;82263;82528;84829.57585212034;88488;5494.670319780826;5766.3368712598585;8089.393295502979;8270.958645206736;8706.259967902546;9441.201661492816;13134.343282836011;13159.342032898508;13179.736405272033;13465.865341346462;11348.092152627934;11376.658700239006;11421.771564568497;11689.649310520697;11847.111466639864;11265.662030139109;11335.433228338385;11348.319100853645;11557.30656160633;11647.708807279885;9610.942796292542;11793;11904.76190476203;12124.939375303067;12127.818082728943;7616.162222155669;8213.096559378344;8373.330133589176;8426.789330266793;8561.743147705578;9902.900970990486;10096.69709908704;11327.490262938352;11438.94280528592;11509.079273658255 04:30:29 INFO - PROCESS | 1964 | |3;mootools.html;1519.9468018619348;1557.4471062772714;1746.3713063297212;1836.3664535735168;1886.6792645250307;8757.43076700014;9299.209567186788;9311.301652376065;9312.255019598433;9312.487813170274;8218.794530136749;8452.281556067726;8469.830603387929;8778.91221087789;9062.501562414065;2390.7250666173395;2438.4147804526874;2438.890249938757;2441.9023239070416;2445.3886528367907;2407.4703565215714;2417.033186725306;2448.1186772761794;2450.0444826517673;2452.2520631207476;2425.5391475619663;2432.3189506937997;2445.938851528717;2450.583400821856;2452.6934133233344;2412.083408304833;2418.141559746291;2427.684401027855;2428.0166532554344;2439.292605144506;2042.9591408171902;2395.413123784684;2421.757824217582;2423.127674037345;2428.86641234732;9148.542572871329;9205.309601779893;9321.860172097424;9330.626774928995;9355.111264429868;5436.673799571999;5597.552195824324;5611.186377975211;5612.466815652507;5613.747381367807;3595.334863050344;3711.962880371189;3716.6283371662616;3780.281746468162;3791.715621328384;1125.2123513540555;1136.7896939066216;1141.8686851012073;1152.3258893547286;1555.992220038904;12255.877441225563;12536.74926501474;12607.936960315139;12625.368731563385;12631.747365052739;4415.227335216325;4466.414422879896;4718.693284936537;4818.084563932842;4818.734969576637;9347.158755712018;9353.298502612195;9369.390989585656;9370.95314523423;9387.530623468936;5410.161424979135;5414.052540805422;5415.6479828811;5419.430959749248;5423.267858839006;4606.95393046072;4792.544708252711;4921.212605983025;5024.773885175176;5103.770330335144;3891.922161556753;3912.315344814646;4004.0390306326854;4029.7783621901076;4038.838446462167;1175.8001139806254;1185.2177562808677;1186.1578279421535;1198.4187668980537;1204.145057009533;761.3604572159413;855.8758979947997;904.9276057915482;913.1735779119907;928.1043792740038;5617.9438205618235;5666.603337766399;5743.913841292384;5954.523638109027;6073.210482637229;856.3277826905849;933.6218831373304;941.2846236860036;962.7015625156084;995.3082607587658;3770.1517158639085;3895.4935858338235;3903.531576210873;3913.2173565287057;4031.5162180538523;11061.834072488919;11563.479643416067;11574.363410012362;11579.073674106052;11591.130665200144;11505.482253298622;11508.712282193012;11533.077353811675;11533.653990380302;11536.942315288537;7523.285287897641;7588.013558237394;8427.367947403969;8476.533790641573;8529.402941794015;5877.884721097825;5917.911231331447;5958.34458209588;5963.194968679173;6020;10345.741356465847;10633.149348051982;10657.14742820557;10657.786844263226;10677.199210059433;9919.355241909252;10236.283460157718;10252;10448.582056717647;10748.97884700952;7162.498625096193;7367.189609143097;7367.742129025459;7741.109772376249;8000.83998320042;8127.878081828659;8206.425550211667;8206.548639824867;8464.873026904725;8735.825283494421;7753.844923101394;7824.413169012233;7872.803179920548;8022.799430014296;8039.15588863161;6593.703283352164;7649.04386951631;7689.50018248812;7746.92253077462;7781.182975787688;7174.928250717635;7322.1579518356075;7332.046833911558;7332.340089391981;7334.96332518334;4803.975980120217;4880.341153944172;4949.232868905326;4950.702957822542;5019.623528235324;4978.6763860348965;5000.324956130876;5083.6187285952965;5147.867469156779;5149.176131818891 04:30:29 INFO - PROCESS | 1964 | |4;prototype.html;278.1447050320265;308.21712849362603;320.1484052420561;322.2025486919875;324.3205484509952;5199.4800519947985;5448.264484294619;5458.26313447685;5480.232767412555;5529.806456774014;4251.6173544381;4342.610364683294;5221.5197781053985;5330.387005494369;5341.759620817063;3765.811709414532;3835.830071828091;4135.58644135587;4142.233686767942;4175.373693945902;4035.616616421435;4131.277026520347;4157.50109986802;4160.916781664365;4189.727667701605;3548.5514994653736;3807.619238076184;3937.448757173998;4118.691098167635;4143.984723742672;3646.8541258349633;4029.3553031514816;4085;4109.856155034589;4115.54728979812;3606;3609.963900360989;3630.3283892479976;3638.108663377463;3652.1782598915297;4376.540463251376;5052.46949070346;5263.157894736823;5265.710385928773;5272.235525848769;3934.5278566572197;4022.155347377054;4111.48606424197;4158.841158841159;4772.188727916227;4875.122477953967;5023.447420783711;5359.490848369399;5524.751386187591;5635.5773317001385;3176.5857947959485;3917.3340532109323;3942.5071866016747;3994.900127496807;3995.10110225197;4915.48387419323;5915.704214789286;5928.851778705523;5932.982785852831;5941.019516923671;3943.842246310173;3952.960470395259;3955.6044395560216;3960.881173564798;3965.1871366369824;3504.7021003215013;4005.0588111793704;4006.25884211416;4012.6388625023887;4029.294873397144;4043.5754245804355;4579.793909274091;4599.379083823641;4616.792244349012;4622;5667.291588551431;5668.542189264545;5670.773169073191;5675.3757086720425;5690.260266165372;1182.39697754146;1227.9991806677529;1283.7111649878702;1324.6820763016806;1329.7539955108336;890.7684002159485;921.9124183202586;923.7413524213231;931.064280398209;931.4039015030386;4985.875353116201;5335.226392173191;5355.86610334737;5362.892742145135;5421.376541697677;5198.596378977655;5797.246357973437;5895.911561326584;5896.7936122235515;5930.881382372415;5289.725418070267;5318;5324.3078399808555;5345.701348420217;5407.540359069523;2003.5091402606454;2357.705286839145;2580.6902821974227;2582.728813474596;2583.354161459635;4482.651827727164;4956.603471722254;4965.925511117336;5002.59979201663;5041.773120209526;4461.3416998061275;4761.309610106515;4762.78567464458;4902.842749190345;4920.188168952154;4095.6518695910586;4245.490541135084;4375.846845360461;5002.949970500248;5040.319556859777;4300.569943005675;4795.928061079157;4800.399950006249;4815.977289538472;4831.88866560686;4341.13331267558;4737.905241895074;4762.666613337033;4775.904481910273;4823.131836269506;4700.55344742249;4940.802367905244;4941.690452030143;4988.9501104988485;4999.825041115262;3117.50119980802;3235.9483167970975;3250.6586808384777;3391.576052993376;3425.030607400705;4019.336809426529;4676.251799712029;4697.459792123813;4775.248627615545;4840.056189043103;4310.978445107754;4547.590716835501;4665.32352808834;4693.835715749932;4787.156944576433;4095.413792931923;4168;4300.924838740316;4675.096294593916;4680.274557443602;3985.282649123186;4593.621913425892;4608.608268297232;4608.723476591281;4634.907301854011;3864.6908247339584;4141.943804329997;4413.889652758707;4509.038568222833;4700.435947686299;4036.8385264589087;4352.018867076063;4612.316504475909;4618.468876079294;4628.963256167275 04:30:29 INFO - PROCESS | 1964 | |5;yui.html;662.3178126529676;696.4150113904319;714.3071220915712;738.0700317599823;794.1700922535952;15738;16851.91574042131;16889.1555422229;16892.155392230386;16927.915360423198;10758.73103172421;12790;15168;15221.695566088672;15331.463398781045;707.9893801592967;734.9044624198847;869.699953516036;882.5807741322884;887.5517863478934;887.7958069643986;894.3650008493977;899.6761165980242;900;900.0144841398658;949.5015117063527;954.7326748510428;954.8758661374046;955.1165172215707;955.4506158958592;938.760616042908;946.0397696338222;946.3186505715873;946.711253067814;947.7867479817021;703.0579024107669;705.0235423937831;705.270045502902;705.340506626306;705.92234854166;15734.842651573452;15764;15770.526884193492;15776;15790.210489475596;15115.459765232608;15176.241187940559;15230.466933657379;15342.386304547805;15571.221438928122;11635.825462618068;11948.283103013848;12036;12226.75546489074;12330.568430104993;3963.8414463421427;3996.6121960940673;4004.478298246677;4074.4295798588223;4107.54816970133;96310;97600;99081.0091899079;100389.49805250927;101323.49338253262;11001.724956876142;11181.273217240854;11218.719532011764;11387.943060284646;11391.886081139248;22486.775132248797;22612.321630351114;22616.321510354388;22638.886805565868;22657.660135097987;8155.836883262302;8187.79530511742;8252.504849708917;8312.376571757142;8350.916490835136;3853.402722578005;4452.8218871245435;4556.726596404226;4703.17694403478;4761.142994260997;3708.647678470595;3861.2856621524547;3863.4204869269274;3865.053061999828;3866.4586957825927;676.4317972902687;678.4640134293852;685.2667645619239;693.4902846407887;701.368768108696;555.555555555562;621.0745988477137;705.4321271376591;707.3881092854643;710.4103594016954;8594.742157735152;9021.594028268744;10125.341852779693;10652.62715804943;10963.397013164193;558.5643198305328;606.3088079589272;621.7823761683466;640.8782331357028;732.1799584465326;4631.745254010994;4775.379200703886;4842.15262329091;4847.297141914473;4883.951160488421;164129.17935410247;166253;168220;169740.3025969749;172518;122328;122654;123534;124235;127345.36327318489;115609.4219528897;116499.41750291194;116952.8304716942;117853.41073294579;124087;9328.486933218737;9473.431594104375;9498;9528.571214295234;9568;63972.3602763985;64585.35414645793;64997.67501162653;65357.673211633635;65458;99286.00713992768;99626.50560241747;101162;103980.96019040016;104349.95650043403;11800.173987821114;12440.440180192094;13256.933715331748;13443.529476468277;13759.312034398441;14846;14885.92557037208;14903.776443353141;15230.695386091995;16438.178091095637;13886.166829990232;14890.137662414598;15006.2496875158;15318.617034574225;15348;13994.440222390991;14072.155670659793;14270.446282312467;14563.92718036403;14766.77849832232;11044.889551104387;13862;14465.349059292146;14669.119852808866;15133.924330378277;9671.613135474783;11632.519486701389;11711.88288117142;11944.402779860799;12154.270743755404;11671.88328116708;11990.280583165038;12057.15599908033;12305.753884922073;12327.815082773945 04:30:29 INFO - PROCESS | 1964 | __end_tp_report 04:30:29 INFO - PROCESS | 1964 | __start_cc_report 04:30:29 INFO - PROCESS | 1964 | _x_x_mozilla_cycle_collect,1247 04:30:29 INFO - PROCESS | 1964 | __end_cc_report 04:30:29 INFO - PROCESS | 1964 | __startTimestamp1483014629473__endTimestamp 04:30:29 INFO - PROCESS | 1964 | 04:30:29 INFO - PROCESS | 1964 | ------- Summary: start ------- 04:30:29 INFO - PROCESS | 1964 | Number of tests: 6 04:30:29 INFO - PROCESS | 1964 | 04:30:29 INFO - PROCESS | 1964 | [#0] dojo.html Cycles:165 Average:5811.90 Median:6120.36 stddev:641.15 (10.5%) stddev-sans-first:615.86 04:30:29 INFO - PROCESS | 1964 | Values: 3454.1 3455.4 3472.5 3501.4 3534.0 5747.6 5764.8 5782.6 5797.4 5807.5 5707.3 5721.7 5781.0 5816.7 5819.6 5207.8 5235.5 5262.0 5288.4 5295.1 5220.8 5224.7 5242.8 5332.1 5353.7 5279.3 5286.8 5321.1 5323.9 5326.4 5253.2 5261.2 5264.3 5293.3 5327.8 5149.5 5232.4 5254.6 5282.4 5285.9 5680.7 5707.7 5731.7 5782.2 5793.6 6146.8 6230.0 6238.5 6327.9 6340.0 5177.7 6331.0 6347.6 6348.0 6381.8 5758.7 5807.3 5851.1 5872.9 5935.6 5221.4 6287.3 6296.8 6318.3 6330.1 6234.1 6234.8 6239.7 6259.7 6266.5 6249.3 6258.4 6323.4 6337.8 6341.6 6120.4 6194.1 6215.4 6315.5 6324.6 6248.4 6317.8 6326.8 6335.8 6354.1 5036.6 5042.3 5052.9 5055.0 5081.2 4462.2 4470.9 4500.3 4544.8 4545.9 5763.4 5827.4 5831.4 5831.9 5913.3 6321.2 6326.6 6349.2 6358.7 6366.6 5852.8 5858.5 5860.4 5875.0 5903.1 5358.7 5394.9 5438.1 5456.1 5506.1 6305.1 6325.0 6345.2 6364.5 6405.5 6344.0 6345.2 6362.5 6371.2 6371.6 6270.3 6323.7 6397.3 6408.7 6412.9 6177.7 6238.8 6287.7 6317.8 6360.6 6352.4 6368.7 6372.4 6376.8 6394.2 6159.7 6246.8 6296.7 6300.1 6306.5 6131.1 6131.3 6143.0 6151.8 6199.6 6121.8 6146.3 6146.4 6150.8 6156.8 6226.2 6244.8 6247.3 6256.0 6260.0 5206.5 5294.3 5891.8 6023.3 6028.7 04:30:29 INFO - PROCESS | 1964 | 04:30:29 INFO - PROCESS | 1964 | [#1] ext.html Cycles:180 Average:78864.58 Median:37429.41 stddev:180675.77 (482.7%) stddev-sans-first:181086.86 04:30:29 INFO - PROCESS | 1964 | Values: 517.7 520.9 528.6 549.0 573.9 26043.9 42508.5 43950.5 44186.9 46139.5 45529.0 45892.0 45935.0 46040.5 46143.0 9373.4 9636.0 10169.6 10370.1 10385.4 12214.1 12550.0 12567.2 12679.4 12696.1 12307.4 12388.2 12397.8 12399.8 12409.6 12469.9 12540.7 12541.1 12555.4 12560.9 12389.3 12462.3 12474.3 12474.6 12510.8 42365.8 42583.0 42624.6 42678.0 42823.0 3415.9 3955.7 4165.9 4181.4 4186.8 26094.6 33185.0 33348.5 33473.7 33943.8 3336.3 3351.6 3368.5 3415.2 3493.3 530208.0 532809.0 534139.0 535358.0 536404.0 35122.3 35767.8 35955.0 63086.7 63664.7 37117.6 37251.6 37388.0 37430.8 37444.1 15854.5 16051.5 16053.8 16061.4 16071.0 12350.4 12634.2 13116.3 13368.1 13379.5 8251.4 8258.9 8301.2 8330.8 8367.7 3465.4 3471.7 3474.5 3477.9 3523.6 934.7 964.6 972.7 990.7 1034.5 30975.2 31033.0 31084.1 31611.7 31730.8 1104.4 1134.5 1161.7 1164.9 1184.7 16089.2 16566.3 16837.1 17256.0 17427.5 727257.0 732344.0 734765.0 735345.0 737852.0 63163.0 63503.4 63559.4 63599.0 63707.0 1293.9 1325.8 1414.6 1427.7 1448.2 25942.7 30258.0 31579.1 32464.0 32480.4 60243.0 61182.0 61288.0 61459.0 61603.1 672618.0 680288.0 680675.0 680757.0 915303.0 37581.8 47227.8 47554.3 47853.8 48107.0 49522.8 50109.0 50570.0 50572.5 50624.2 39865.6 40467.6 41742.8 42100.2 43499.0 42034.2 42104.8 42640.6 42929.6 43140.4 40640.8 41257.2 41622.6 41683.4 41767.2 35193.3 36475.3 36627.9 37428.0 37570.0 27072.0 27153.6 27214.6 27265.0 27419.6 04:30:29 INFO - PROCESS | 1964 | 04:30:29 INFO - PROCESS | 1964 | [#2] jquery.html Cycles:180 Average:36869.20 Median:23486.18 stddev:105512.94 (449.3%) stddev-sans-first:105773.29 04:30:29 INFO - PROCESS | 1964 | Values: 342.5 383.2 383.9 395.1 416.4 16530.9 17329.5 19737.9 21775.8 22115.0 18202.5 21856.3 22013.5 22471.0 22609.3 6042.4 6118.3 6216.7 6302.0 6416.8 4373.8 6246.7 6253.6 6289.8 6290.8 4452.0 6631.8 6917.0 6959.7 7055.2 6820.4 6930.5 6961.3 6998.8 7007.0 5952.9 5979.8 5988.4 6122.8 6139.2 21467.7 27533.6 27603.0 27876.0 28017.0 2141.9 2176.4 2558.9 2674.4 2958.8 15643.5 15959.5 16019.2 16920.3 17337.5 1959.9 1979.6 2004.8 2040.6 2055.3 118248.4 120131.0 121783.8 123464.0 125523.1 10936.7 11135.9 11500.9 11513.6 11756.8 12057.6 14448.3 14502.6 14503.0 14522.5 7573.6 8881.9 9002.1 9018.7 9093.4 9255.8 9266.3 9272.7 9284.0 9445.4 6670.9 6951.9 6966.9 6973.2 6987.5 1555.5 1622.3 1900.7 1907.8 1912.4 815.2 843.8 844.2 915.8 937.1 21008.9 21564.3 22288.8 23474.1 23498.3 983.0 1001.3 1015.6 1028.9 1108.3 11885.6 12216.5 12413.1 12438.9 12536.9 588366.1 627853.0 639995.0 655516.0 655958.0 120903.2 124096.8 126123.4 126674.0 127075.1 924.1 977.4 1006.6 1046.1 1079.9 19081.2 20376.1 20450.9 20545.2 20578.0 58368.0 59771.1 59833.7 60041.2 61667.7 80119.0 82263.0 82528.0 84829.6 88488.0 5494.7 5766.3 8089.4 8271.0 8706.3 9441.2 13134.3 13159.3 13179.7 13465.9 11348.1 11376.7 11421.8 11689.6 11847.1 11265.7 11335.4 11348.3 11557.3 11647.7 9610.9 11793.0 11904.8 12124.9 12127.8 7616.2 8213.1 8373.3 8426.8 8561.7 9902.9 10096.7 11327.5 11438.9 11509.1 04:30:29 INFO - PROCESS | 1964 | 04:30:29 INFO - PROCESS | 1964 | [#3] mootools.html Cycles:180 Average:5873.35 Median:4964.69 stddev:3351.57 (67.5%) stddev-sans-first:3345.00 04:30:29 INFO - PROCESS | 1964 | Values: 1519.9 1557.4 1746.4 1836.4 1886.7 8757.4 9299.2 9311.3 9312.3 9312.5 8218.8 8452.3 8469.8 8778.9 9062.5 2390.7 2438.4 2438.9 2441.9 2445.4 2407.5 2417.0 2448.1 2450.0 2452.3 2425.5 2432.3 2445.9 2450.6 2452.7 2412.1 2418.1 2427.7 2428.0 2439.3 2043.0 2395.4 2421.8 2423.1 2428.9 9148.5 9205.3 9321.9 9330.6 9355.1 5436.7 5597.6 5611.2 5612.5 5613.7 3595.3 3712.0 3716.6 3780.3 3791.7 1125.2 1136.8 1141.9 1152.3 1556.0 12255.9 12536.7 12607.9 12625.4 12631.7 4415.2 4466.4 4718.7 4818.1 4818.7 9347.2 9353.3 9369.4 9371.0 9387.5 5410.2 5414.1 5415.6 5419.4 5423.3 4607.0 4792.5 4921.2 5024.8 5103.8 3891.9 3912.3 4004.0 4029.8 4038.8 1175.8 1185.2 1186.2 1198.4 1204.1 761.4 855.9 904.9 913.2 928.1 5617.9 5666.6 5743.9 5954.5 6073.2 856.3 933.6 941.3 962.7 995.3 3770.2 3895.5 3903.5 3913.2 4031.5 11061.8 11563.5 11574.4 11579.1 11591.1 11505.5 11508.7 11533.1 11533.7 11536.9 7523.3 7588.0 8427.4 8476.5 8529.4 5877.9 5917.9 5958.3 5963.2 6020.0 10345.7 10633.1 10657.1 10657.8 10677.2 9919.4 10236.3 10252.0 10448.6 10749.0 7162.5 7367.2 7367.7 7741.1 8000.8 8127.9 8206.4 8206.5 8464.9 8735.8 7753.8 7824.4 7872.8 8022.8 8039.2 6593.7 7649.0 7689.5 7746.9 7781.2 7174.9 7322.2 7332.0 7332.3 7335.0 4804.0 4880.3 4949.2 4950.7 5019.6 4978.7 5000.3 5083.6 5147.9 5149.2 04:30:29 INFO - PROCESS | 1964 | 04:30:29 INFO - PROCESS | 1964 | [#4] prototype.html Cycles:180 Average:4223.36 Median:4603.99 stddev:1260.64 (27.4%) stddev-sans-first:1228.90 04:30:29 INFO - PROCESS | 1964 | Values: 278.1 308.2 320.1 322.2 324.3 5199.5 5448.3 5458.3 5480.2 5529.8 4251.6 4342.6 5221.5 5330.4 5341.8 3765.8 3835.8 4135.6 4142.2 4175.4 4035.6 4131.3 4157.5 4160.9 4189.7 3548.6 3807.6 3937.4 4118.7 4144.0 3646.9 4029.4 4085.0 4109.9 4115.5 3606.0 3610.0 3630.3 3638.1 3652.2 4376.5 5052.5 5263.2 5265.7 5272.2 3934.5 4022.2 4111.5 4158.8 4772.2 4875.1 5023.4 5359.5 5524.8 5635.6 3176.6 3917.3 3942.5 3994.9 3995.1 4915.5 5915.7 5928.9 5933.0 5941.0 3943.8 3953.0 3955.6 3960.9 3965.2 3504.7 4005.1 4006.3 4012.6 4029.3 4043.6 4579.8 4599.4 4616.8 4622.0 5667.3 5668.5 5670.8 5675.4 5690.3 1182.4 1228.0 1283.7 1324.7 1329.8 890.8 921.9 923.7 931.1 931.4 4985.9 5335.2 5355.9 5362.9 5421.4 5198.6 5797.2 5895.9 5896.8 5930.9 5289.7 5318.0 5324.3 5345.7 5407.5 2003.5 2357.7 2580.7 2582.7 2583.4 4482.7 4956.6 4965.9 5002.6 5041.8 4461.3 4761.3 4762.8 4902.8 4920.2 4095.7 4245.5 4375.8 5002.9 5040.3 4300.6 4795.9 4800.4 4816.0 4831.9 4341.1 4737.9 4762.7 4775.9 4823.1 4700.6 4940.8 4941.7 4989.0 4999.8 3117.5 3235.9 3250.7 3391.6 3425.0 4019.3 4676.3 4697.5 4775.2 4840.1 4311.0 4547.6 4665.3 4693.8 4787.2 4095.4 4168.0 4300.9 4675.1 4680.3 3985.3 4593.6 4608.6 4608.7 4634.9 3864.7 4141.9 4413.9 4509.0 4700.4 4036.8 4352.0 4612.3 4618.5 4629.0 04:30:29 INFO - PROCESS | 1964 | 04:30:29 INFO - PROCESS | 1964 | [#5] yui.html Cycles:180 Average:25828.52 Median:22648.27 stddev:41398.82 (182.8%) stddev-sans-first:41471.83 04:30:29 INFO - PROCESS | 1964 | Values: 662.3 696.4 714.3 738.1 794.2 15738.0 16851.9 16889.2 16892.2 16927.9 10758.7 12790.0 15168.0 15221.7 15331.5 708.0 734.9 869.7 882.6 887.6 887.8 894.4 899.7 900.0 900.0 949.5 954.7 954.9 955.1 955.5 938.8 946.0 946.3 946.7 947.8 703.1 705.0 705.3 705.3 705.9 15734.8 15764.0 15770.5 15776.0 15790.2 15115.5 15176.2 15230.5 15342.4 15571.2 11635.8 11948.3 12036.0 12226.8 12330.6 3963.8 3996.6 4004.5 4074.4 4107.5 96310.0 97600.0 99081.0 100389.5 101323.5 11001.7 11181.3 11218.7 11387.9 11391.9 22486.8 22612.3 22616.3 22638.9 22657.7 8155.8 8187.8 8252.5 8312.4 8350.9 3853.4 4452.8 4556.7 4703.2 4761.1 3708.6 3861.3 3863.4 3865.1 3866.5 676.4 678.5 685.3 693.5 701.4 555.6 621.1 705.4 707.4 710.4 8594.7 9021.6 10125.3 10652.6 10963.4 558.6 606.3 621.8 640.9 732.2 4631.7 4775.4 4842.2 4847.3 4884.0 164129.2 166253.0 168220.0 169740.3 172518.0 122328.0 122654.0 123534.0 124235.0 127345.4 115609.4 116499.4 116952.8 117853.4 124087.0 9328.5 9473.4 9498.0 9528.6 9568.0 63972.4 64585.4 64997.7 65357.7 65458.0 99286.0 99626.5 101162.0 103981.0 104350.0 11800.2 12440.4 13256.9 13443.5 13759.3 14846.0 14885.9 14903.8 15230.7 16438.2 13886.2 14890.1 15006.2 15318.6 15348.0 13994.4 14072.2 14270.4 14563.9 14766.8 11044.9 13862.0 14465.3 14669.1 15133.9 9671.6 11632.5 11711.9 11944.4 12154.3 11671.9 11990.3 12057.2 12305.8 12327.8 04:30:29 INFO - PROCESS | 1964 | -------- Summary: end -------- 04:30:29 INFO - PROCESS | 1964 | 04:30:30 INFO - TEST-INFO | 1964: exit 0 04:30:30 INFO - TEST-OK | dromaeo_css | took 1116231ms 04:30:30 INFO - TEST-START | kraken 04:30:30 INFO - operating with platform_type : mac_ 04:30:30 INFO - Initialising browser for kraken test... 04:30:30 INFO - TEST-INFO | started process 1971 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/tmpDxonmz/profile http://localhost:49318/getInfo.html) 04:30:32 INFO - PROCESS | 1971 | __metrics Screen width/height:1600/1200 04:30:32 INFO - PROCESS | 1971 | colorDepth:24 04:30:32 INFO - PROCESS | 1971 | Browser inner width/height: 1024/689 04:30:32 INFO - PROCESS | 1971 | __metrics 04:30:32 INFO - PROCESS | 1971 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 04:30:32 INFO - PROCESS | 1971 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:30:33 INFO - TEST-INFO | 1971: exit 0 04:30:33 INFO - Browser initialized. 04:30:33 INFO - Running cycle 1/1 for kraken test... 04:30:33 INFO - TEST-INFO | started process 1973 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/tmpDxonmz/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:30:44 INFO - PROCESS | 1973 | RSS: Main: 168656896 04:30:44 INFO - PROCESS | 1973 | 04:30:47 INFO - PROCESS | 1973 | Cycle 1(1): loaded http://localhost:49318/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49318/tests/kraken/driver.html?testName=audio-beat-detection) 04:30:48 INFO - PROCESS | 1973 | RSS: Main: 218644480 04:30:48 INFO - PROCESS | 1973 | 04:30:51 INFO - PROCESS | 1973 | Cycle 1(1): loaded http://localhost:49318/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49318/tests/kraken/driver.html?testName=audio-dft) 04:30:51 INFO - PROCESS | 1973 | RSS: Main: 232009728 04:30:51 INFO - PROCESS | 1973 | 04:30:55 INFO - PROCESS | 1973 | Cycle 1(1): loaded http://localhost:49318/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49318/tests/kraken/driver.html?testName=audio-fft) 04:30:55 INFO - PROCESS | 1973 | RSS: Main: 330383360 04:30:55 INFO - PROCESS | 1973 | 04:30:57 INFO - PROCESS | 1973 | Cycle 1(1): loaded http://localhost:49318/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49318/tests/kraken/driver.html?testName=audio-oscillator) 04:30:58 INFO - PROCESS | 1973 | RSS: Main: 227876864 04:30:58 INFO - PROCESS | 1973 | 04:31:00 INFO - PROCESS | 1973 | Cycle 1(1): loaded http://localhost:49318/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49318/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:31:01 INFO - PROCESS | 1973 | RSS: Main: 230023168 04:31:01 INFO - PROCESS | 1973 | 04:31:03 INFO - PROCESS | 1973 | Cycle 1(1): loaded http://localhost:49318/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49318/tests/kraken/driver.html?testName=imaging-darkroom) 04:31:04 INFO - PROCESS | 1973 | RSS: Main: 268959744 04:31:04 INFO - PROCESS | 1973 | 04:31:07 INFO - PROCESS | 1973 | Cycle 1(1): loaded http://localhost:49318/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49318/tests/kraken/driver.html?testName=imaging-desaturate) 04:31:08 INFO - PROCESS | 1973 | RSS: Main: 267345920 04:31:08 INFO - PROCESS | 1973 | 04:31:10 INFO - PROCESS | 1973 | Cycle 1(1): loaded http://localhost:49318/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49318/tests/kraken/driver.html?testName=json-parse-financial) 04:31:11 INFO - PROCESS | 1973 | RSS: Main: 266633216 04:31:11 INFO - PROCESS | 1973 | 04:31:12 INFO - PROCESS | 1973 | Cycle 1(1): loaded http://localhost:49318/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49318/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:31:13 INFO - PROCESS | 1973 | RSS: Main: 239632384 04:31:13 INFO - PROCESS | 1973 | 04:31:15 INFO - PROCESS | 1973 | Cycle 1(1): loaded http://localhost:49318/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49318/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:31:16 INFO - PROCESS | 1973 | RSS: Main: 245309440 04:31:16 INFO - PROCESS | 1973 | 04:31:18 INFO - PROCESS | 1973 | Cycle 1(1): loaded http://localhost:49318/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49318/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:31:18 INFO - PROCESS | 1973 | RSS: Main: 251088896 04:31:18 INFO - PROCESS | 1973 | 04:31:21 INFO - PROCESS | 1973 | Cycle 1(1): loaded http://localhost:49318/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49318/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:31:22 INFO - PROCESS | 1973 | RSS: Main: 276738048 04:31:22 INFO - PROCESS | 1973 | 04:31:25 INFO - PROCESS | 1973 | Cycle 1(1): loaded http://localhost:49318/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49318/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:31:25 INFO - PROCESS | 1973 | RSS: Main: 264126464 04:31:25 INFO - PROCESS | 1973 | 04:31:27 INFO - PROCESS | 1973 | Cycle 1(1): loaded http://localhost:49318/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49318/tests/kraken/driver.html?testName=ai-astar) 04:31:27 INFO - PROCESS | 1973 | RSS: Main: 307761152 04:31:27 INFO - PROCESS | 1973 | 04:31:27 INFO - PROCESS | 1973 | __start_tp_report 04:31:27 INFO - PROCESS | 1973 | _x_x_mozilla_page_load 04:31:27 INFO - PROCESS | 1973 | _x_x_mozilla_page_load_details 04:31:27 INFO - PROCESS | 1973 | |i|pagename|runs| 04:31:27 INFO - PROCESS | 1973 | |0;ai-astar;114;112;112;113;112;112;113;114;113;113 04:31:27 INFO - PROCESS | 1973 | |1;audio-beat-detection;170;138;92;177;137;93;128;140;168;134 04:31:27 INFO - PROCESS | 1973 | |2;audio-dft;182;186;185;184;185;182;185;185;183;185 04:31:27 INFO - PROCESS | 1973 | |3;audio-fft;81;58;59;86;51;77;81;81;112;58 04:31:27 INFO - PROCESS | 1973 | |4;audio-oscillator;87;70;96;68;68;69;93;84;91;123 04:31:27 INFO - PROCESS | 1973 | |5;imaging-gaussian-blur;90;87;90;85;134;87;90;87;89;86 04:31:27 INFO - PROCESS | 1973 | |6;imaging-darkroom;94;94;95;94;94;94;95;94;106;147 04:31:27 INFO - PROCESS | 1973 | |7;imaging-desaturate;86;84;82;84;86;83;84;83;83;84 04:31:27 INFO - PROCESS | 1973 | |8;json-parse-financial;58;52;52;52;54;57;56;57;55;55 04:31:27 INFO - PROCESS | 1973 | |9;json-stringify-tinderbox;64;72;75;70;73;70;69;70;68;70 04:31:27 INFO - PROCESS | 1973 | |10;stanford-crypto-aes;84;83;81;84;84;84;81;82;87;98 04:31:27 INFO - PROCESS | 1973 | |11;stanford-crypto-ccm;136;137;143;150;144;140;134;139;137;131 04:31:27 INFO - PROCESS | 1973 | |12;stanford-crypto-pbkdf2;159;160;160;160;161;160;157;227;207;175 04:31:27 INFO - PROCESS | 1973 | |13;stanford-crypto-sha256-iterative;67;65;66;69;83;85;82;81;64;67 04:31:27 INFO - PROCESS | 1973 | __end_tp_report 04:31:27 INFO - PROCESS | 1973 | __start_cc_report 04:31:27 INFO - PROCESS | 1973 | _x_x_mozilla_cycle_collect,1904 04:31:27 INFO - PROCESS | 1973 | __end_cc_report 04:31:27 INFO - PROCESS | 1973 | __startTimestamp1483014687896__endTimestamp 04:31:27 INFO - PROCESS | 1973 | 04:31:27 INFO - PROCESS | 1973 | ------- Summary: start ------- 04:31:27 INFO - PROCESS | 1973 | Number of tests: 14 04:31:27 INFO - PROCESS | 1973 | 04:31:27 INFO - PROCESS | 1973 | [#0] ai-astar Cycles:10 Average:112.80 Median:113.00 stddev:0.79 (0.7%) stddev-sans-first:0.71 04:31:27 INFO - PROCESS | 1973 | Values: 114.0 112.0 112.0 113.0 112.0 112.0 113.0 114.0 113.0 113.0 04:31:27 INFO - PROCESS | 1973 | 04:31:27 INFO - PROCESS | 1973 | [#1] audio-beat-detection Cycles:10 Average:137.70 Median:169.00 stddev:29.26 (17.3%) stddev-sans-first:28.61 04:31:27 INFO - PROCESS | 1973 | Values: 170.0 138.0 92.0 177.0 137.0 93.0 128.0 140.0 168.0 134.0 04:31:27 INFO - PROCESS | 1973 | 04:31:27 INFO - PROCESS | 1973 | [#2] audio-dft Cycles:10 Average:184.20 Median:185.00 stddev:1.40 (0.8%) stddev-sans-first:1.24 04:31:27 INFO - PROCESS | 1973 | Values: 182.0 186.0 185.0 184.0 185.0 182.0 185.0 185.0 183.0 185.0 04:31:27 INFO - PROCESS | 1973 | 04:31:27 INFO - PROCESS | 1973 | [#3] audio-fft Cycles:10 Average:74.40 Median:79.00 stddev:18.28 (23.1%) stddev-sans-first:19.24 04:31:27 INFO - PROCESS | 1973 | Values: 81.0 58.0 59.0 86.0 51.0 77.0 81.0 81.0 112.0 58.0 04:31:27 INFO - PROCESS | 1973 | 04:31:27 INFO - PROCESS | 1973 | [#4] audio-oscillator Cycles:10 Average:84.90 Median:85.50 stddev:17.41 (20.4%) stddev-sans-first:18.45 04:31:27 INFO - PROCESS | 1973 | Values: 87.0 70.0 96.0 68.0 68.0 69.0 93.0 84.0 91.0 123.0 04:31:27 INFO - PROCESS | 1973 | 04:31:27 INFO - PROCESS | 1973 | [#5] imaging-gaussian-blur Cycles:10 Average:92.50 Median:88.00 stddev:14.69 (16.7%) stddev-sans-first:15.55 04:31:27 INFO - PROCESS | 1973 | Values: 90.0 87.0 90.0 85.0 134.0 87.0 90.0 87.0 89.0 86.0 04:31:27 INFO - PROCESS | 1973 | 04:31:27 INFO - PROCESS | 1973 | [#6] imaging-darkroom Cycles:10 Average:100.70 Median:94.00 stddev:16.69 (17.8%) stddev-sans-first:17.52 04:31:27 INFO - PROCESS | 1973 | Values: 94.0 94.0 95.0 94.0 94.0 94.0 95.0 94.0 106.0 147.0 04:31:27 INFO - PROCESS | 1973 | 04:31:27 INFO - PROCESS | 1973 | [#7] imaging-desaturate Cycles:10 Average:83.90 Median:84.00 stddev:1.29 (1.5%) stddev-sans-first:1.12 04:31:27 INFO - PROCESS | 1973 | Values: 86.0 84.0 82.0 84.0 86.0 83.0 84.0 83.0 83.0 84.0 04:31:27 INFO - PROCESS | 1973 | 04:31:27 INFO - PROCESS | 1973 | [#8] json-parse-financial Cycles:10 Average:54.80 Median:55.50 stddev:2.25 (4.1%) stddev-sans-first:2.07 04:31:27 INFO - PROCESS | 1973 | Values: 58.0 52.0 52.0 52.0 54.0 57.0 56.0 57.0 55.0 55.0 04:31:27 INFO - PROCESS | 1973 | 04:31:27 INFO - PROCESS | 1973 | [#9] json-stringify-tinderbox Cycles:10 Average:70.10 Median:70.00 stddev:2.96 (4.2%) stddev-sans-first:2.17 04:31:27 INFO - PROCESS | 1973 | Values: 64.0 72.0 75.0 70.0 73.0 70.0 69.0 70.0 68.0 70.0 04:31:27 INFO - PROCESS | 1973 | 04:31:27 INFO - PROCESS | 1973 | [#10] stanford-crypto-aes Cycles:10 Average:84.80 Median:84.00 stddev:4.96 (5.9%) stddev-sans-first:5.25 04:31:27 INFO - PROCESS | 1973 | Values: 84.0 83.0 81.0 84.0 84.0 84.0 81.0 82.0 87.0 98.0 04:31:27 INFO - PROCESS | 1973 | 04:31:27 INFO - PROCESS | 1973 | [#11] stanford-crypto-ccm Cycles:10 Average:139.10 Median:139.50 stddev:5.47 (3.9%) stddev-sans-first:5.68 04:31:27 INFO - PROCESS | 1973 | Values: 136.0 137.0 143.0 150.0 144.0 140.0 134.0 139.0 137.0 131.0 04:31:27 INFO - PROCESS | 1973 | 04:31:27 INFO - PROCESS | 1973 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:172.60 Median:160.50 stddev:24.37 (15.2%) stddev-sans-first:25.35 04:31:27 INFO - PROCESS | 1973 | Values: 159.0 160.0 160.0 160.0 161.0 160.0 157.0 227.0 207.0 175.0 04:31:27 INFO - PROCESS | 1973 | 04:31:27 INFO - PROCESS | 1973 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:72.90 Median:75.00 stddev:8.63 (11.5%) stddev-sans-first:8.89 04:31:27 INFO - PROCESS | 1973 | Values: 67.0 65.0 66.0 69.0 83.0 85.0 82.0 81.0 64.0 67.0 04:31:27 INFO - PROCESS | 1973 | -------- Summary: end -------- 04:31:27 INFO - PROCESS | 1973 | 04:31:28 INFO - TEST-INFO | 1973: exit 0 04:31:28 INFO - TEST-OK | kraken | took 58760ms 04:31:28 INFO - SUITE-END | took 1174s 04:31:29 INFO - Completed test suite (00:19:35) 04:31:29 INFO - javascript benchmark 04:31:29 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3454.1019334972907, 3455.429854074078, 3472.548568686072, 3501.404761190597, 3533.9646603533974, 5747.626404283724, 5764.769409223636, 5782.595218334708, 5797.36229014808, 5807.506361959238, 5707.286589176353, 5721.742521586528, 5780.971095144529, 5816.651000939936, 5819.621724587899, 5207.817726379587, 5235.450277720842, 5262.0, 5288.444713305105, 5295.126304159809, 5220.817271395502, 5224.712640804754, 5242.8165014224505, 5332.120200166968, 5353.678779273256, 5279.2872962150195, 5286.814961476349, 5321.148616221405, 5323.946760532383, 5326.387465441485, 5253.212018197263, 5261.210818377236, 5264.315638966948, 5293.338332708411, 5327.760250788724, 5149.524735578351, 5232.372115346145, 5254.553362964152, 5282.445343238982, 5285.920711189336, 5680.744366503517, 5707.74315155819, 5731.742071606787, 5782.161586569966, 5793.594448388614, 6146.815595532141, 6229.96885015572, 6238.4697300729495, 6327.905081423783, 6339.96830015847, 5177.741112944375, 6330.9683451582905, 6347.555671103025, 6347.968260158716, 6381.840453988688, 5758.74085666146, 5807.274090738658, 5851.063829787214, 5872.911906321408, 5935.614185077956, 5221.373435187802, 6287.308396076428, 6296.811095667137, 6318.273398559132, 6330.113784070234, 6234.064890266405, 6234.781782637586, 6239.656818874914, 6259.6870156492, 6266.467350275187, 6249.281332646713, 6258.405451482102, 6323.399277068671, 6337.809865703944, 6341.556091073673, 6120.355709576858, 6194.0708893666315, 6215.440610345091, 6315.463185629181, 6324.557280990287, 6248.4064013918605, 6317.778877739349, 6326.841828954221, 6335.809925702236, 6354.142190804275, 5036.597072234213, 5042.319286896295, 5052.9494705052475, 5055.014272216956, 5081.212412076134, 4462.152191083684, 4470.865874023784, 4500.257457519473, 4544.750038747835, 4545.909081818345, 5763.423657634203, 5827.446392592697, 5831.358550559435, 5831.854203644943, 5913.349531551526, 6321.209848768904, 6326.557141000178, 6349.206349206349, 6358.713857876407, 6366.6180029198395, 5852.7658893643775, 5858.47273745365, 5860.38465961068, 5875.0, 5903.0555111182, 5358.705271210121, 5394.8921021579345, 5438.102713052302, 5456.099743542271, 5506.063969125258, 6305.085762564402, 6324.968375158095, 6345.206849143857, 6364.459020983176, 6405.455536279282, 6343.968280158754, 6345.206849143857, 6362.491000720024, 6371.203599550056, 6371.649559274284, 6270.310265870842, 6323.747050118128, 6397.264314603694, 6408.711607977559, 6412.871742565216, 6177.660228687465, 6238.781642642486, 6287.71705273273, 6317.810465686037, 6360.554761166674, 6352.428281454691, 6368.713407896748, 6372.426481616677, 6376.808695739135, 6394.200724909387, 6159.72281247336, 6246.843828904313, 6296.748130074746, 6300.149479820349, 6306.495480361652, 6131.141640170291, 6131.284916201153, 6142.959235178615, 6151.784687535915, 6199.56603037783, 6121.755129794758, 6146.262448506208, 6146.416090471398, 6150.815475535741, 6156.815295541141, 6226.1905952225925, 6244.812655620339, 6247.250329960434, 6255.999040153553, 6260.0, 5206.505381988705, 5294.338207724035, 5891.793787217427, 6023.277206735044, 6028.668423236764], "value": 5772.2393057926865, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [517.7230181852708, 520.8828013696918, 528.5877015927576, 548.9588280878933, 573.8522954091817, 26043.86978065112, 42508.512202072896, 43950.461733839285, 44186.895327616825, 46139.53860461395, 45529.0, 45892.0, 45935.0, 46040.539594604044, 46143.0, 9373.437593744364, 9636.0, 10169.644062457834, 10370.066693997538, 10385.42880141592, 12214.083943704214, 12550.0, 12567.245965242115, 12679.429425675868, 12696.111272210948, 12307.38463076847, 12388.194767340094, 12397.752044959096, 12399.752004959895, 12409.627711168634, 12469.940055095283, 12540.686482837911, 12541.122121451503, 12555.435005424777, 12560.874391256062, 12389.318587477685, 12462.252264864137, 12474.313912734797, 12474.625761227178, 12510.81233781494, 42365.788171059256, 42583.0, 42624.57375426268, 42678.0, 42823.0, 3415.880444184442, 3955.7033222508426, 4165.895852603679, 4181.372794080882, 4186.769727664977, 26094.608580871303, 33185.0, 33348.49977250343, 33473.66526334754, 33943.81196658105, 3336.349411864687, 3351.6480769519335, 3368.511565822942, 3415.2486452980306, 3493.266414053052, 530208.0, 532809.0, 534139.0, 535358.0, 536404.0, 35122.297554048775, 35767.821160894026, 35955.0, 63086.68456657687, 63664.68167659225, 37117.62882371142, 37251.62748372536, 37388.0, 37430.812845935594, 37444.063898402215, 15854.524364269091, 16051.518454446385, 16053.839461605468, 16061.437849675205, 16071.0, 12350.38248087592, 12634.178778379375, 13116.278604676834, 13368.131071480322, 13379.53171638988, 8251.422400431911, 8258.917410825814, 8301.211384918422, 8330.8333833323, 8367.665293388318, 3465.4108801503803, 3471.687548120681, 3474.4961980512685, 3477.9478307824897, 3523.6124026357593, 934.6728644974205, 964.5676170886228, 972.6741541583507, 990.7126933189294, 1034.4724190662816, 30975.225619359695, 31033.0, 31084.067477975696, 31611.683883161335, 31730.841345793124, 1104.4422566603973, 1134.4838098665089, 1161.7095726068483, 1164.9184557080923, 1184.6682928779956, 16089.195540223176, 16566.337346506003, 16837.073960932266, 17256.0, 17427.47717568475, 727257.0, 732344.0, 734765.0, 735345.0, 737852.0, 63163.0, 63503.364966350666, 63559.364406355344, 63599.046014309824, 63707.0, 1293.9029572782079, 1325.840899092115, 1414.6251243420295, 1427.7358688642635, 1448.2324368084933, 25942.702864856303, 30258.0, 31579.052628421185, 32464.0, 32480.35039299248, 60243.0, 61182.0, 61288.0, 61459.0, 61603.07595385983, 672618.0, 680288.0, 680675.0, 680757.0, 915303.0, 37581.81209093937, 47227.76386118047, 47554.286685700434, 47853.760731197515, 48107.03785924192, 49522.75238623784, 50109.0, 50570.0, 50572.49427505678, 50624.240636389746, 39865.60134398735, 40467.595324046386, 41742.79128604338, 42100.157996839276, 43499.0, 42034.159316814104, 42104.78947605242, 42640.57359426366, 42929.57070429256, 43140.352894707234, 40640.79679601583, 41257.174856503305, 41622.583774161874, 41683.37474937818, 41767.164656707304, 35193.29613407769, 36475.27049459049, 36627.90116296515, 37428.0, 37570.0, 27072.0, 27153.59269610918, 27214.591781122905, 27265.0, 27419.588706169023], "value": 20652.322398929675, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [342.5136306444848, 383.24691980258797, 383.9366504526755, 395.10311592684604, 416.38998866660336, 16530.917345413287, 17329.48011559652, 19737.901310493446, 21775.782242177575, 22114.999999999978, 18202.544936376566, 21856.25149988001, 22013.459057865955, 22471.0, 22609.321720348376, 6042.425969532887, 6118.265808103034, 6216.658083805389, 6301.968490157566, 6416.839579010515, 4373.825046998117, 6246.687665616723, 6253.562250642457, 6289.779857704982, 6290.811275661715, 4451.977740111295, 6631.801045968605, 6917.031615573824, 6959.721611135574, 7055.153381594216, 6820.420264277543, 6930.468186800725, 6961.303869613049, 6998.755043573476, 7007.019017337526, 5952.940470595282, 5979.790707325223, 5988.431099045583, 6122.816315510542, 6139.201903752483, 21467.67798483024, 27533.586996195074, 27603.0, 27876.0, 28017.0, 2141.8714877107423, 2176.4341271269427, 2558.8592627405487, 2674.398260391416, 2958.778091643114, 15643.530694079082, 15959.521214363587, 16019.199040047952, 16920.323187072503, 17337.479875603753, 1959.8824070555813, 1979.633767752956, 2004.7594288685304, 2040.5918816236813, 2055.2806517718827, 118248.40875795652, 120131.0, 121783.78216217813, 123464.0, 125523.11715324187, 10936.671899843017, 11135.944320278346, 11500.88499115015, 11513.597024104116, 11756.764864702829, 12057.638270851889, 14448.277586120652, 14502.564923052325, 14503.0, 14522.49171279, 7573.6213189340315, 8881.911180888237, 9002.05478424769, 9018.729438116867, 9093.40892841963, 9255.76860578491, 9266.31681864427, 9272.72181834546, 9283.953580232192, 9445.433274003582, 6670.899301615179, 6951.860962780817, 6966.860662786818, 6973.163220413583, 6987.510874238857, 1555.478914563634, 1622.3429511048043, 1900.667383207933, 1907.818757218062, 1912.359359614517, 815.2255357410365, 843.8481073406723, 844.2359664503634, 915.771057235691, 937.1378331934636, 21008.949552522314, 21564.274858011322, 22288.77711222867, 23474.061037558306, 23498.295051148492, 982.9557669904872, 1001.329109496639, 1015.5785349080197, 1028.8713910761155, 1108.2962318927378, 11885.5840045598, 12216.511339546318, 12413.131080824256, 12438.875611243953, 12536.937315313366, 588366.058169715, 627853.0, 639995.0, 655516.0, 655958.0, 120903.18645220328, 124096.75903241032, 126123.3693831525, 126674.0, 127075.09387359198, 924.0805398628407, 977.3744803325877, 1006.572206812102, 1046.0689985912543, 1079.8704155501391, 19081.236750529824, 20376.123958328113, 20450.897745511178, 20545.178192872118, 20578.0, 58368.0, 59771.1034334494, 59833.700831497306, 60041.196704264425, 61667.69166154141, 80118.99702507484, 82263.0, 82528.0, 84829.57585212034, 88488.0, 5494.670319780826, 5766.3368712598585, 8089.393295502979, 8270.958645206736, 8706.259967902546, 9441.201661492816, 13134.343282836011, 13159.342032898508, 13179.736405272033, 13465.865341346462, 11348.092152627934, 11376.658700239006, 11421.771564568497, 11689.649310520697, 11847.111466639864, 11265.662030139109, 11335.433228338385, 11348.319100853645, 11557.30656160633, 11647.708807279885, 9610.942796292542, 11793.0, 11904.76190476203, 12124.939375303067, 12127.818082728943, 7616.162222155669, 8213.096559378344, 8373.330133589176, 8426.789330266793, 8561.743147705578, 9902.900970990486, 10096.69709908704, 11327.490262938352, 11438.94280528592, 11509.079273658255], "value": 10138.229736452302, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1519.9468018619348, 1557.4471062772714, 1746.3713063297212, 1836.3664535735168, 1886.6792645250307, 8757.43076700014, 9299.209567186788, 9311.301652376065, 9312.255019598433, 9312.487813170274, 8218.794530136749, 8452.281556067726, 8469.830603387929, 8778.91221087789, 9062.501562414065, 2390.7250666173395, 2438.4147804526874, 2438.890249938757, 2441.9023239070416, 2445.3886528367907, 2407.4703565215714, 2417.033186725306, 2448.1186772761794, 2450.0444826517673, 2452.2520631207476, 2425.5391475619663, 2432.3189506937997, 2445.938851528717, 2450.583400821856, 2452.6934133233344, 2412.083408304833, 2418.141559746291, 2427.684401027855, 2428.0166532554344, 2439.292605144506, 2042.9591408171902, 2395.413123784684, 2421.757824217582, 2423.127674037345, 2428.86641234732, 9148.542572871329, 9205.309601779893, 9321.860172097424, 9330.626774928995, 9355.111264429868, 5436.673799571999, 5597.552195824324, 5611.186377975211, 5612.466815652507, 5613.747381367807, 3595.334863050344, 3711.962880371189, 3716.6283371662616, 3780.281746468162, 3791.715621328384, 1125.2123513540555, 1136.7896939066216, 1141.8686851012073, 1152.3258893547286, 1555.992220038904, 12255.877441225563, 12536.74926501474, 12607.936960315139, 12625.368731563385, 12631.747365052739, 4415.227335216325, 4466.414422879896, 4718.693284936537, 4818.084563932842, 4818.734969576637, 9347.158755712018, 9353.298502612195, 9369.390989585656, 9370.95314523423, 9387.530623468936, 5410.161424979135, 5414.052540805422, 5415.6479828811, 5419.430959749248, 5423.267858839006, 4606.95393046072, 4792.544708252711, 4921.212605983025, 5024.773885175176, 5103.770330335144, 3891.922161556753, 3912.315344814646, 4004.0390306326854, 4029.7783621901076, 4038.838446462167, 1175.8001139806254, 1185.2177562808677, 1186.1578279421535, 1198.4187668980537, 1204.145057009533, 761.3604572159413, 855.8758979947997, 904.9276057915482, 913.1735779119907, 928.1043792740038, 5617.9438205618235, 5666.603337766399, 5743.913841292384, 5954.523638109027, 6073.210482637229, 856.3277826905849, 933.6218831373304, 941.2846236860036, 962.7015625156084, 995.3082607587658, 3770.1517158639085, 3895.4935858338235, 3903.531576210873, 3913.2173565287057, 4031.5162180538523, 11061.834072488919, 11563.479643416067, 11574.363410012362, 11579.073674106052, 11591.130665200144, 11505.482253298622, 11508.712282193012, 11533.077353811675, 11533.653990380302, 11536.942315288537, 7523.285287897641, 7588.013558237394, 8427.367947403969, 8476.533790641573, 8529.402941794015, 5877.884721097825, 5917.911231331447, 5958.34458209588, 5963.194968679173, 6020.0, 10345.741356465847, 10633.149348051982, 10657.14742820557, 10657.786844263226, 10677.199210059433, 9919.355241909252, 10236.283460157718, 10252.0, 10448.582056717647, 10748.97884700952, 7162.498625096193, 7367.189609143097, 7367.742129025459, 7741.109772376249, 8000.83998320042, 8127.878081828659, 8206.425550211667, 8206.548639824867, 8464.873026904725, 8735.825283494421, 7753.844923101394, 7824.413169012233, 7872.803179920548, 8022.799430014296, 8039.15588863161, 6593.703283352164, 7649.04386951631, 7689.50018248812, 7746.92253077462, 7781.182975787688, 7174.928250717635, 7322.1579518356075, 7332.046833911558, 7332.340089391981, 7334.96332518334, 4803.975980120217, 4880.341153944172, 4949.232868905326, 4950.702957822542, 5019.623528235324, 4978.6763860348965, 5000.324956130876, 5083.6187285952965, 5147.867469156779, 5149.176131818891], "value": 4699.934021395401, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [278.1447050320265, 308.21712849362603, 320.1484052420561, 322.2025486919875, 324.3205484509952, 5199.4800519947985, 5448.264484294619, 5458.26313447685, 5480.232767412555, 5529.806456774014, 4251.6173544381, 4342.610364683294, 5221.5197781053985, 5330.387005494369, 5341.759620817063, 3765.811709414532, 3835.830071828091, 4135.58644135587, 4142.233686767942, 4175.373693945902, 4035.616616421435, 4131.277026520347, 4157.50109986802, 4160.916781664365, 4189.727667701605, 3548.5514994653736, 3807.619238076184, 3937.448757173998, 4118.691098167635, 4143.984723742672, 3646.8541258349633, 4029.3553031514816, 4085.0, 4109.856155034589, 4115.54728979812, 3606.0, 3609.963900360989, 3630.3283892479976, 3638.108663377463, 3652.1782598915297, 4376.540463251376, 5052.46949070346, 5263.157894736823, 5265.710385928773, 5272.235525848769, 3934.5278566572197, 4022.155347377054, 4111.48606424197, 4158.841158841159, 4772.188727916227, 4875.122477953967, 5023.447420783711, 5359.490848369399, 5524.751386187591, 5635.5773317001385, 3176.5857947959485, 3917.3340532109323, 3942.5071866016747, 3994.900127496807, 3995.10110225197, 4915.48387419323, 5915.704214789286, 5928.851778705523, 5932.982785852831, 5941.019516923671, 3943.842246310173, 3952.960470395259, 3955.6044395560216, 3960.881173564798, 3965.1871366369824, 3504.7021003215013, 4005.0588111793704, 4006.25884211416, 4012.6388625023887, 4029.294873397144, 4043.5754245804355, 4579.793909274091, 4599.379083823641, 4616.792244349012, 4622.0, 5667.291588551431, 5668.542189264545, 5670.773169073191, 5675.3757086720425, 5690.260266165372, 1182.39697754146, 1227.9991806677529, 1283.7111649878702, 1324.6820763016806, 1329.7539955108336, 890.7684002159485, 921.9124183202586, 923.7413524213231, 931.064280398209, 931.4039015030386, 4985.875353116201, 5335.226392173191, 5355.86610334737, 5362.892742145135, 5421.376541697677, 5198.596378977655, 5797.246357973437, 5895.911561326584, 5896.7936122235515, 5930.881382372415, 5289.725418070267, 5318.0, 5324.3078399808555, 5345.701348420217, 5407.540359069523, 2003.5091402606454, 2357.705286839145, 2580.6902821974227, 2582.728813474596, 2583.354161459635, 4482.651827727164, 4956.603471722254, 4965.925511117336, 5002.59979201663, 5041.773120209526, 4461.3416998061275, 4761.309610106515, 4762.78567464458, 4902.842749190345, 4920.188168952154, 4095.6518695910586, 4245.490541135084, 4375.846845360461, 5002.949970500248, 5040.319556859777, 4300.569943005675, 4795.928061079157, 4800.399950006249, 4815.977289538472, 4831.88866560686, 4341.13331267558, 4737.905241895074, 4762.666613337033, 4775.904481910273, 4823.131836269506, 4700.55344742249, 4940.802367905244, 4941.690452030143, 4988.9501104988485, 4999.825041115262, 3117.50119980802, 3235.9483167970975, 3250.6586808384777, 3391.576052993376, 3425.030607400705, 4019.336809426529, 4676.251799712029, 4697.459792123813, 4775.248627615545, 4840.056189043103, 4310.978445107754, 4547.590716835501, 4665.32352808834, 4693.835715749932, 4787.156944576433, 4095.413792931923, 4168.0, 4300.924838740316, 4675.096294593916, 4680.274557443602, 3985.282649123186, 4593.621913425892, 4608.608268297232, 4608.723476591281, 4634.907301854011, 3864.6908247339584, 4141.943804329997, 4413.889652758707, 4509.038568222833, 4700.435947686299, 4036.8385264589087, 4352.018867076063, 4612.316504475909, 4618.468876079294, 4628.963256167275], "value": 3835.4230509193053, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [662.3178126529676, 696.4150113904319, 714.3071220915712, 738.0700317599823, 794.1700922535952, 15738.0, 16851.91574042131, 16889.1555422229, 16892.155392230386, 16927.915360423198, 10758.73103172421, 12790.0, 15168.0, 15221.695566088672, 15331.463398781045, 707.9893801592967, 734.9044624198847, 869.699953516036, 882.5807741322884, 887.5517863478934, 887.7958069643986, 894.3650008493977, 899.6761165980242, 900.0, 900.0144841398658, 949.5015117063527, 954.7326748510428, 954.8758661374046, 955.1165172215707, 955.4506158958592, 938.760616042908, 946.0397696338222, 946.3186505715873, 946.711253067814, 947.7867479817021, 703.0579024107669, 705.0235423937831, 705.270045502902, 705.340506626306, 705.92234854166, 15734.842651573452, 15764.0, 15770.526884193492, 15776.0, 15790.210489475596, 15115.459765232608, 15176.241187940559, 15230.466933657379, 15342.386304547805, 15571.221438928122, 11635.825462618068, 11948.283103013848, 12036.0, 12226.75546489074, 12330.568430104993, 3963.8414463421427, 3996.6121960940673, 4004.478298246677, 4074.4295798588223, 4107.54816970133, 96310.0, 97600.0, 99081.0091899079, 100389.49805250927, 101323.49338253262, 11001.724956876142, 11181.273217240854, 11218.719532011764, 11387.943060284646, 11391.886081139248, 22486.775132248797, 22612.321630351114, 22616.321510354388, 22638.886805565868, 22657.660135097987, 8155.836883262302, 8187.79530511742, 8252.504849708917, 8312.376571757142, 8350.916490835136, 3853.402722578005, 4452.8218871245435, 4556.726596404226, 4703.17694403478, 4761.142994260997, 3708.647678470595, 3861.2856621524547, 3863.4204869269274, 3865.053061999828, 3866.4586957825927, 676.4317972902687, 678.4640134293852, 685.2667645619239, 693.4902846407887, 701.368768108696, 555.555555555562, 621.0745988477137, 705.4321271376591, 707.3881092854643, 710.4103594016954, 8594.742157735152, 9021.594028268744, 10125.341852779693, 10652.62715804943, 10963.397013164193, 558.5643198305328, 606.3088079589272, 621.7823761683466, 640.8782331357028, 732.1799584465326, 4631.745254010994, 4775.379200703886, 4842.15262329091, 4847.297141914473, 4883.951160488421, 164129.17935410247, 166253.0, 168220.0, 169740.3025969749, 172518.0, 122328.0, 122654.0, 123534.0, 124235.0, 127345.36327318489, 115609.4219528897, 116499.41750291194, 116952.8304716942, 117853.41073294579, 124087.0, 9328.486933218737, 9473.431594104375, 9498.0, 9528.571214295234, 9568.0, 63972.3602763985, 64585.35414645793, 64997.67501162653, 65357.673211633635, 65458.0, 99286.00713992768, 99626.50560241747, 101162.0, 103980.96019040016, 104349.95650043403, 11800.173987821114, 12440.440180192094, 13256.933715331748, 13443.529476468277, 13759.312034398441, 14846.0, 14885.92557037208, 14903.776443353141, 15230.695386091995, 16438.178091095637, 13886.166829990232, 14890.137662414598, 15006.2496875158, 15318.617034574225, 15348.0, 13994.440222390991, 14072.155670659793, 14270.446282312467, 14563.92718036403, 14766.77849832232, 11044.889551104387, 13862.0, 14465.349059292146, 14669.119852808866, 15133.924330378277, 9671.613135474783, 11632.519486701389, 11711.88288117142, 11944.402779860799, 12154.270743755404, 11671.88328116708, 11990.280583165038, 12057.15599908033, 12305.753884922073, 12327.815082773945], "value": 8116.129474670412, "unit": "score"}], "name": "dromaeo_css", "value": 7491.980368781989, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 112.0, 112.0, 113.0, 112.0, 112.0, 113.0, 114.0, 113.0, 113.0], "value": 112.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [170.0, 138.0, 92.0, 177.0, 137.0, 93.0, 128.0, 140.0, 168.0, 134.0], "value": 137.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [182.0, 186.0, 185.0, 184.0, 185.0, 182.0, 185.0, 185.0, 183.0, 185.0], "value": 184.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 58.0, 59.0, 86.0, 51.0, 77.0, 81.0, 81.0, 112.0, 58.0], "value": 74.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 70.0, 96.0, 68.0, 68.0, 69.0, 93.0, 84.0, 91.0, 123.0], "value": 84.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 87.0, 90.0, 85.0, 134.0, 87.0, 90.0, 87.0, 89.0, 86.0], "value": 92.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 95.0, 94.0, 94.0, 94.0, 95.0, 94.0, 106.0, 147.0], "value": 100.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 84.0, 82.0, 84.0, 86.0, 83.0, 84.0, 83.0, 83.0, 84.0], "value": 83.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 52.0, 52.0, 52.0, 54.0, 57.0, 56.0, 57.0, 55.0, 55.0], "value": 54.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 72.0, 75.0, 70.0, 73.0, 70.0, 69.0, 70.0, 68.0, 70.0], "value": 70.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 83.0, 81.0, 84.0, 84.0, 84.0, 81.0, 82.0, 87.0, 98.0], "value": 84.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [136.0, 137.0, 143.0, 150.0, 144.0, 140.0, 134.0, 139.0, 137.0, 131.0], "value": 139.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 160.0, 160.0, 160.0, 161.0, 160.0, 157.0, 227.0, 207.0, 175.0], "value": 172.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 65.0, 66.0, 69.0, 83.0, 85.0, 82.0, 81.0, 64.0, 67.0], "value": 72.9, "unit": "score"}], "name": "kraken", "value": 1465.3999999999999, "alertThreshold": 2.0}]} 04:31:29 INFO - Return code: 0 04:31:29 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 04:31:29 INFO - # TBPL SUCCESS # 04:31:29 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:31:29 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:31:29 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:31:29 INFO - 2016-12-29 04:31:29.209 screenresolution[1977:12157] starting screenresolution argv=screenresolution get 04:31:29 INFO - 2016-12-29 04:31:29.211 screenresolution[1977:12157] Display 0: 1600x1200x32@60 04:31:29 INFO - 2016-12-29 04:31:29.217 screenresolution[1978:12160] starting screenresolution argv=screenresolution list 04:31:29 INFO - Available Modes on Display 0 04:31:29 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:31:29 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:31:29 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:31:29 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:31:29 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:31:29 INFO - Intel Iris: 04:31:29 INFO - Chipset Model: Intel Iris 04:31:29 INFO - Type: GPU 04:31:29 INFO - Bus: Built-In 04:31:29 INFO - VRAM (Dynamic, Max): 1536 MB 04:31:29 INFO - Vendor: Intel (0x8086) 04:31:29 INFO - Device ID: 0x0a2e 04:31:29 INFO - Revision ID: 0x0009 04:31:29 INFO - Displays: 04:31:29 INFO - Display: 04:31:29 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:31:29 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:31:29 INFO - Display Serial Number: 1600x1200 60 04:31:29 INFO - Main Display: Yes 04:31:29 INFO - Mirror: Off 04:31:29 INFO - Online: Yes 04:31:29 INFO - Rotation: Supported 04:31:29 INFO - Return code: 0 04:31:29 INFO - Running post-action listener: _resource_record_post_action 04:31:29 INFO - [mozharness: 2016-12-29 12:31:29.456496Z] Finished run-tests step (success) 04:31:29 INFO - Running post-run listener: _resource_record_post_run 04:31:29 INFO - Total resource usage - Wall time: 1198s; CPU: 53.0%; Read bytes: 2605056; Write bytes: 495691776; Read time: 29; Write time: 1843 04:31:29 INFO - TinderboxPrint: CPU usage
53.3% 04:31:29 INFO - TinderboxPrint: I/O read bytes / time
2,605,056 / 29 04:31:29 INFO - TinderboxPrint: I/O write bytes / time
495,691,776 / 1,843 04:31:29 INFO - TinderboxPrint: CPU idle
2,238.3 (46.7%) 04:31:29 INFO - TinderboxPrint: CPU system
956.6 (20.0%) 04:31:29 INFO - TinderboxPrint: CPU user
1,598.8 (33.4%) 04:31:29 INFO - TinderboxPrint: Swap in / out
198,672,384 / 0 04:31:29 INFO - install - Wall time: 23s; CPU: 54.0%; Read bytes: 188135936; Write bytes: 185905152; Read time: 17895; Write time: 464 04:31:29 INFO - run-tests - Wall time: 1176s; CPU: 53.0%; Read bytes: 2605056; Write bytes: 299665408; Read time: 29; Write time: 1341 04:31:29 INFO - Running post-run listener: _upload_blobber_files 04:31:29 INFO - Blob upload gear active. 04:31:29 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:31:29 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 04:31:29 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', 'Mozilla-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 04:31:29 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 Mozilla-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 04:31:30 INFO - (blobuploader) - INFO - Open directory for files ... 04:31:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 04:31:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:31:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:31:31 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 04:31:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:31:31 INFO - (blobuploader) - INFO - Done attempting. 04:31:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 04:31:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:31:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:31:32 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 04:31:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:31:32 INFO - (blobuploader) - INFO - Done attempting. 04:31:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 04:31:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:31:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:31:34 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 04:31:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:31:34 INFO - (blobuploader) - INFO - Done attempting. 04:31:34 INFO - (blobuploader) - INFO - Iteration through files over. 04:31:34 INFO - Return code: 0 04:31:34 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:31:34 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:31:34 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/8ec2fd03eea8d8a79acbf1c1ab7069e7b264f0127a37cf5d7726e6082bfa8d35b88b20bee65d466b1b47276ed851bc35e4c309714e578517271096758fe45b52", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/f03ae1d788e883fd617ddcdb1f3f2c53031d56ee9ac9ad5c02615a9e2be09a1e16a5a57bd11e06324096b9304481ca31fef05d64b55ce44d22f8a4bad9410571", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/7395aa542b9bd829f56d24ed3dd69a9a4aab6a961970d8f80c62e6332a65c5cdd024068b7319c1aeded5c27f0515acbf86890deee27656a91c0682bc4a24fbe4"} 04:31:34 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:31:34 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:31:34 INFO - Contents: 04:31:34 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/8ec2fd03eea8d8a79acbf1c1ab7069e7b264f0127a37cf5d7726e6082bfa8d35b88b20bee65d466b1b47276ed851bc35e4c309714e578517271096758fe45b52", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/f03ae1d788e883fd617ddcdb1f3f2c53031d56ee9ac9ad5c02615a9e2be09a1e16a5a57bd11e06324096b9304481ca31fef05d64b55ce44d22f8a4bad9410571", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/7395aa542b9bd829f56d24ed3dd69a9a4aab6a961970d8f80c62e6332a65c5cdd024068b7319c1aeded5c27f0515acbf86890deee27656a91c0682bc4a24fbe4"} 04:31:34 INFO - Running post-run listener: copy_logs_to_upload_dir 04:31:34 INFO - Copying logs to upload dir... 04:31:34 INFO - mkdir: /builds/slave/test/build/upload/logs 04:31:34 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1259.172445 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 20 mins, 59 secs) (at 2016-12-29 04:31:34.350921) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-29 04:31:34.354678) ========= 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.Ej6Y6nvngP/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.iX0ux7Fnyr/Listeners TMPDIR=/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/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/Mozilla-Beta/sha512/8ec2fd03eea8d8a79acbf1c1ab7069e7b264f0127a37cf5d7726e6082bfa8d35b88b20bee65d466b1b47276ed851bc35e4c309714e578517271096758fe45b52", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/f03ae1d788e883fd617ddcdb1f3f2c53031d56ee9ac9ad5c02615a9e2be09a1e16a5a57bd11e06324096b9304481ca31fef05d64b55ce44d22f8a4bad9410571", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/7395aa542b9bd829f56d24ed3dd69a9a4aab6a961970d8f80c62e6332a65c5cdd024068b7319c1aeded5c27f0515acbf86890deee27656a91c0682bc4a24fbe4"} build_url:https://queue.taskcluster.net/v1/task/c56tdNxOS9usCrrt9dwM6g/artifacts/public/build/firefox-51.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011169 build_url: 'https://queue.taskcluster.net/v1/task/c56tdNxOS9usCrrt9dwM6g/artifacts/public/build/firefox-51.0.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/8ec2fd03eea8d8a79acbf1c1ab7069e7b264f0127a37cf5d7726e6082bfa8d35b88b20bee65d466b1b47276ed851bc35e4c309714e578517271096758fe45b52", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/f03ae1d788e883fd617ddcdb1f3f2c53031d56ee9ac9ad5c02615a9e2be09a1e16a5a57bd11e06324096b9304481ca31fef05d64b55ce44d22f8a4bad9410571", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/7395aa542b9bd829f56d24ed3dd69a9a4aab6a961970d8f80c62e6332a65c5cdd024068b7319c1aeded5c27f0515acbf86890deee27656a91c0682bc4a24fbe4"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-29 04:31:34.388646) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-29 04:31:34.388943) ========= 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.Ej6Y6nvngP/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.iX0ux7Fnyr/Listeners TMPDIR=/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/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.005097 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-29 04:31:34.436879) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-29 04:31:34.437175) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-29 04:31:34.437481) ========= ========= Total master_lag: 0.38 =========