builder: mozilla-beta_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0216 starttime: 1479417984.33 results: success (0) buildid: 20161117105628 builduid: 99e8c3f8f27b4f3eb3d3715b71f7f2fb revision: 4a50f24275d4f5d0afb68752ca228c5fbf2a6784 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-11-17 13:26:24.330293) ========= master: http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-11-17 13:26:24.330746) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-17 13:26:24.331030) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-17 13:26:24.354275) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-17 13:26:24.354575) ========= 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.RhRrF4ntBj/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.2dEkvsOkUX/Listeners TMPDIR=/var/folders/63/97m36r0j7js9vzr9g5gsghq400000w/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-11-17 13:26:24-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 11.9M=0.001s 2016-11-17 13:26:24 (11.9 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.358255 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-17 13:26:24.734912) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-17 13:26:24.735295) ========= 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.RhRrF4ntBj/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.2dEkvsOkUX/Listeners TMPDIR=/var/folders/63/97m36r0j7js9vzr9g5gsghq400000w/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.018796 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-17 13:26:24.784109) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-11-17 13:26:24.784468) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 4a50f24275d4f5d0afb68752ca228c5fbf2a6784 --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 4a50f24275d4f5d0afb68752ca228c5fbf2a6784 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.RhRrF4ntBj/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.2dEkvsOkUX/Listeners TMPDIR=/var/folders/63/97m36r0j7js9vzr9g5gsghq400000w/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-11-17 13:26:24,871 truncating revision to first 12 chars 2016-11-17 13:26:24,871 Setting DEBUG logging. 2016-11-17 13:26:24,871 attempt 1/10 2016-11-17 13:26:24,871 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/4a50f24275d4?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-11-17 13:26:26,658 unpacking tar archive at: mozilla-beta-4a50f24275d4/testing/mozharness/ program finished with exit code 0 elapsedTime=2.070283 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-11-17 13:26:26.877963) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-17 13:26:26.878537) ========= script_repo_revision: 4a50f24275d4f5d0afb68752ca228c5fbf2a6784 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-17 13:26:26.879122) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-17 13:26:26.879408) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-17 13:26:26.897543) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 20 mins, 53 secs) (at 2016-11-17 13:26:26.897964) ========= /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.RhRrF4ntBj/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.2dEkvsOkUX/Listeners TMPDIR=/var/folders/63/97m36r0j7js9vzr9g5gsghq400000w/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 13:26:27 INFO - MultiFileLogger online at 20161117 13:26:27 in /builds/slave/test 13:26:27 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 13:26:27 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 13:26:27 INFO - {'append_to_log': False, 13:26:27 INFO - 'base_work_dir': '/builds/slave/test', 13:26:27 INFO - 'blob_upload_branch': 'Mozilla-Beta', 13:26:27 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 13:26:27 INFO - 'branch': 'Mozilla-Beta', 13:26:27 INFO - 'buildbot_json_path': 'buildprops.json', 13:26:27 INFO - 'config_files': ('talos/mac_config.py',), 13:26:27 INFO - 'default_actions': ('clobber', 13:26:27 INFO - 'read-buildbot-config', 13:26:27 INFO - 'download-and-extract', 13:26:27 INFO - 'populate-webroot', 13:26:27 INFO - 'create-virtualenv', 13:26:27 INFO - 'install', 13:26:27 INFO - 'run-tests'), 13:26:27 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 13:26:27 INFO - 'download_minidump_stackwalk': True, 13:26:27 INFO - 'download_symbols': 'ondemand', 13:26:27 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 13:26:27 INFO - 'tooltool.py': '/tools/tooltool.py', 13:26:27 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 13:26:27 INFO - '/tools/misc-python/virtualenv.py')}, 13:26:27 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 13:26:27 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 13:26:27 INFO - 'installer_path': 'installer.exe', 13:26:27 INFO - 'log_level': 'info', 13:26:27 INFO - 'log_name': 'talos', 13:26:27 INFO - 'log_to_console': True, 13:26:27 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 13:26:27 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 13:26:27 INFO - 'opt_config_files': (), 13:26:27 INFO - 'pip_index': False, 13:26:27 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 13:26:27 INFO - 'cmd': ('bash', 13:26:27 INFO - '-c', 13:26:27 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 13:26:27 INFO - 'enabled': True, 13:26:27 INFO - 'halt_on_failure': False, 13:26:27 INFO - 'name': 'check_screen_resolution'},), 13:26:27 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 13:26:27 INFO - 'cmd': ('bash', 13:26:27 INFO - '-c', 13:26:27 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 13:26:27 INFO - 'enabled': True, 13:26:27 INFO - 'halt_on_failure': False, 13:26:27 INFO - 'name': 'check_screen_resolution'},), 13:26:27 INFO - 'run_cmd_checks_enabled': True, 13:26:27 INFO - 'sps_profile': False, 13:26:27 INFO - 'sps_profile_interval': 0, 13:26:27 INFO - 'suite': 'dromaeojs', 13:26:27 INFO - 'system_bits': '32', 13:26:27 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 13:26:27 INFO - 'title': 't-yosemite-r7-0216', 13:26:27 INFO - 'tooltool_cache': '/builds/tooltool_cache', 13:26:27 INFO - 'use_talos_json': True, 13:26:27 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 13:26:27 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 13:26:27 INFO - 'work_dir': 'build'} 13:26:27 INFO - [mozharness: 2016-11-17 21:26:27.101614Z] Running clobber step. 13:26:27 INFO - Running pre-action listener: _resource_record_pre_action 13:26:27 INFO - Running main action method: clobber 13:26:27 INFO - rmtree: /builds/slave/test/build 13:26:27 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 13:26:28 INFO - Running post-action listener: _resource_record_post_action 13:26:28 INFO - [mozharness: 2016-11-17 21:26:28.569252Z] Finished clobber step (success) 13:26:28 INFO - [mozharness: 2016-11-17 21:26:28.569414Z] Running read-buildbot-config step. 13:26:28 INFO - Running pre-action listener: _resource_record_pre_action 13:26:28 INFO - Running main action method: read_buildbot_config 13:26:28 INFO - Using buildbot properties: 13:26:28 INFO - { 13:26:28 INFO - "project": "", 13:26:28 INFO - "product": "firefox", 13:26:28 INFO - "script_repo_revision": "production", 13:26:28 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs", 13:26:28 INFO - "repository": "", 13:26:28 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs", 13:26:28 INFO - "buildid": "20161117105628", 13:26:28 INFO - "pgo_build": "False", 13:26:28 INFO - "basedir": "/builds/slave/test", 13:26:28 INFO - "buildnumber": 66, 13:26:28 INFO - "slavename": "t-yosemite-r7-0216", 13:26:28 INFO - "master": "http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/", 13:26:28 INFO - "platform": "yosemite_r7", 13:26:28 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 13:26:28 INFO - "branch": "mozilla-beta", 13:26:28 INFO - "repo_path": "releases/mozilla-beta", 13:26:28 INFO - "revision": "4a50f24275d4f5d0afb68752ca228c5fbf2a6784", 13:26:28 INFO - "stage_platform": "macosx64", 13:26:28 INFO - "builduid": "99e8c3f8f27b4f3eb3d3715b71f7f2fb", 13:26:28 INFO - "slavebuilddir": "test" 13:26:28 INFO - } 13:26:28 INFO - Found installer url https://queue.taskcluster.net/v1/task/aIv3f7hCSkqntywFtt1cMQ/artifacts/public/build/firefox-51.0.en-US.mac.dmg. 13:26:28 INFO - Running post-action listener: _resource_record_post_action 13:26:28 INFO - [mozharness: 2016-11-17 21:26:28.572366Z] Finished read-buildbot-config step (success) 13:26:28 INFO - [mozharness: 2016-11-17 21:26:28.572471Z] Running download-and-extract step. 13:26:28 INFO - Running pre-action listener: _resource_record_pre_action 13:26:28 INFO - Running main action method: download_and_extract 13:26:28 INFO - mkdir: /builds/slave/test/build/tests 13:26:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:26:28 INFO - trying https://queue.taskcluster.net/v1/task/aIv3f7hCSkqntywFtt1cMQ/artifacts/public/build/firefox-51.0.en-US.mac.test_packages.json 13:26:28 INFO - Downloading https://queue.taskcluster.net/v1/task/aIv3f7hCSkqntywFtt1cMQ/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 13:26:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/aIv3f7hCSkqntywFtt1cMQ/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 13:26:29 INFO - Downloaded 1165 bytes. 13:26:29 INFO - Reading from file /builds/slave/test/build/firefox-51.0.en-US.mac.test_packages.json 13:26:29 INFO - Using the following test package requirements: 13:26:29 INFO - {u'common': [u'firefox-51.0.en-US.mac.common.tests.zip'], 13:26:29 INFO - u'cppunittest': [u'firefox-51.0.en-US.mac.common.tests.zip', 13:26:29 INFO - u'firefox-51.0.en-US.mac.cppunittest.tests.zip'], 13:26:29 INFO - u'gtest': [u'firefox-51.0.en-US.mac.common.tests.zip', 13:26:29 INFO - u'firefox-51.0.en-US.mac.gtest.tests.zip'], 13:26:29 INFO - u'jittest': [u'firefox-51.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 13:26:29 INFO - u'mochitest': [u'firefox-51.0.en-US.mac.common.tests.zip', 13:26:29 INFO - u'firefox-51.0.en-US.mac.mochitest.tests.zip'], 13:26:29 INFO - u'mozbase': [u'firefox-51.0.en-US.mac.common.tests.zip'], 13:26:29 INFO - u'reftest': [u'firefox-51.0.en-US.mac.common.tests.zip', 13:26:29 INFO - u'firefox-51.0.en-US.mac.reftest.tests.zip'], 13:26:29 INFO - u'talos': [u'firefox-51.0.en-US.mac.common.tests.zip', 13:26:29 INFO - u'firefox-51.0.en-US.mac.talos.tests.zip'], 13:26:29 INFO - u'web-platform': [u'firefox-51.0.en-US.mac.common.tests.zip', 13:26:29 INFO - u'firefox-51.0.en-US.mac.web-platform.tests.zip'], 13:26:29 INFO - u'xpcshell': [u'firefox-51.0.en-US.mac.common.tests.zip', 13:26:29 INFO - u'firefox-51.0.en-US.mac.xpcshell.tests.zip']} 13:26:29 INFO - Downloading packages: [u'firefox-51.0.en-US.mac.common.tests.zip'] for test suite category: common 13:26:29 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/aIv3f7hCSkqntywFtt1cMQ/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip 13:26:29 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/aIv3f7hCSkqntywFtt1cMQ/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip'}, attempt #1 13:26:29 INFO - Fetch https://queue.taskcluster.net/v1/task/aIv3f7hCSkqntywFtt1cMQ/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip into memory 13:26:30 INFO - Expected file size: 16231342 13:26:37 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 13:26:37 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/aIv3f7hCSkqntywFtt1cMQ/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip 13:26:37 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/aIv3f7hCSkqntywFtt1cMQ/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip'}, attempt #1 13:26:37 INFO - Fetch https://queue.taskcluster.net/v1/task/aIv3f7hCSkqntywFtt1cMQ/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip into memory 13:26:37 INFO - Expected file size: 16231342 13:26:44 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/aIv3f7hCSkqntywFtt1cMQ/artifacts/public/build/firefox-51.0.en-US.mac.talos.tests.zip 13:26:44 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/aIv3f7hCSkqntywFtt1cMQ/artifacts/public/build/firefox-51.0.en-US.mac.talos.tests.zip'}, attempt #1 13:26:44 INFO - Fetch https://queue.taskcluster.net/v1/task/aIv3f7hCSkqntywFtt1cMQ/artifacts/public/build/firefox-51.0.en-US.mac.talos.tests.zip into memory 13:26:45 INFO - Expected file size: 14414089 13:26:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:26:46 INFO - trying https://queue.taskcluster.net/v1/task/aIv3f7hCSkqntywFtt1cMQ/artifacts/public/build/firefox-51.0.en-US.mac.dmg 13:26:46 INFO - Downloading https://queue.taskcluster.net/v1/task/aIv3f7hCSkqntywFtt1cMQ/artifacts/public/build/firefox-51.0.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0.en-US.mac.dmg 13:26:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/aIv3f7hCSkqntywFtt1cMQ/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 13:26:48 INFO - Downloaded 86020171 bytes. 13:26:48 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/aIv3f7hCSkqntywFtt1cMQ/artifacts/public/build/firefox-51.0.en-US.mac.dmg 13:26:48 INFO - mkdir: /builds/slave/test/properties 13:26:48 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 13:26:48 INFO - Writing to file /builds/slave/test/properties/build_url 13:26:48 INFO - Contents: 13:26:48 INFO - build_url:https://queue.taskcluster.net/v1/task/aIv3f7hCSkqntywFtt1cMQ/artifacts/public/build/firefox-51.0.en-US.mac.dmg 13:26:49 INFO - Running post-action listener: _resource_record_post_action 13:26:49 INFO - Running post-action listener: set_extra_try_arguments 13:26:49 INFO - [mozharness: 2016-11-17 21:26:49.359951Z] Finished download-and-extract step (success) 13:26:49 INFO - [mozharness: 2016-11-17 21:26:49.360085Z] Running populate-webroot step. 13:26:49 INFO - Running pre-action listener: _resource_record_pre_action 13:26:49 INFO - Running main action method: populate_webroot 13:26:49 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 13:26:49 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 13:26:49 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 13:26:49 INFO - '--tppagecycles', 13:26:49 INFO - '7'], 13:26:49 INFO - 'tests': ['tsvgm']}}, 13:26:49 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 13:26:49 INFO - 'tests': ['tresize', 'tcanvasmark']}, 13:26:49 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 13:26:49 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 13:26:49 INFO - 'tests': ['dromaeo_css', 'kraken']}, 13:26:49 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 13:26:49 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:26:49 INFO - 'talos_options': ['--disable-e10s'], 13:26:49 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:26:49 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:26:49 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:26:49 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:26:49 INFO - 'talos_options': ['--disable-e10s'], 13:26:49 INFO - 'tests': ['damp', 'tps']}, 13:26:49 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:26:49 INFO - 'tests': ['damp', 'tps']}, 13:26:49 INFO - 'g3': {'talos_options': ['--disable-e10s'], 13:26:49 INFO - 'tests': ['dromaeo_dom']}, 13:26:49 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 13:26:49 INFO - 'g4': {'talos_options': ['--disable-e10s'], 13:26:49 INFO - 'tests': ['basic_compositor_video']}, 13:26:49 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 13:26:49 INFO - 'other': {'talos_options': ['--disable-e10s'], 13:26:49 INFO - 'tests': ['a11yr', 13:26:49 INFO - 'ts_paint', 13:26:49 INFO - 'tpaint', 13:26:49 INFO - 'sessionrestore', 13:26:49 INFO - 'sessionrestore_no_auto_restore', 13:26:49 INFO - 'tabpaint']}, 13:26:49 INFO - 'other-e10s': {'tests': ['a11yr', 13:26:49 INFO - 'ts_paint', 13:26:49 INFO - 'tpaint', 13:26:49 INFO - 'sessionrestore', 13:26:49 INFO - 'sessionrestore_no_auto_restore', 13:26:49 INFO - 'tabpaint']}, 13:26:49 INFO - 'other-e10s_l64': {'tests': ['a11yr', 13:26:49 INFO - 'ts_paint', 13:26:49 INFO - 'tpaint', 13:26:49 INFO - 'sessionrestore', 13:26:49 INFO - 'sessionrestore_no_auto_restore', 13:26:49 INFO - 'tabpaint']}, 13:26:49 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 13:26:49 INFO - 'ts_paint', 13:26:49 INFO - 'tpaint', 13:26:49 INFO - 'sessionrestore', 13:26:49 INFO - 'sessionrestore_no_auto_restore', 13:26:49 INFO - 'tabpaint']}, 13:26:49 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 13:26:49 INFO - 'tests': ['a11yr', 13:26:49 INFO - 'ts_paint', 13:26:49 INFO - 'tpaint', 13:26:49 INFO - 'sessionrestore', 13:26:49 INFO - 'sessionrestore_no_auto_restore', 13:26:49 INFO - 'tabpaint']}, 13:26:49 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 13:26:49 INFO - 'tests': ['a11yr', 13:26:49 INFO - 'ts_paint', 13:26:49 INFO - 'tpaint', 13:26:49 INFO - 'sessionrestore', 13:26:49 INFO - 'sessionrestore_no_auto_restore', 13:26:49 INFO - 'tabpaint']}, 13:26:49 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 13:26:49 INFO - 'tests': ['tsvgx', 13:26:49 INFO - 'tsvgr_opacity', 13:26:49 INFO - 'tart', 13:26:49 INFO - 'tscrollx', 13:26:49 INFO - 'cart']}, 13:26:49 INFO - 'svgr-e10s': {'tests': ['tsvgx', 13:26:49 INFO - 'tsvgr_opacity', 13:26:49 INFO - 'tart', 13:26:49 INFO - 'tscrollx', 13:26:49 INFO - 'cart']}, 13:26:49 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:26:49 INFO - 'talos_options': ['--disable-e10s'], 13:26:49 INFO - 'tests': ['tp5o']}, 13:26:49 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:26:49 INFO - 'tests': ['tp5o']}, 13:26:49 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:26:49 INFO - 'talos_options': ['--disable-e10s', 13:26:49 INFO - '--xperf_path', 13:26:49 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:26:49 INFO - 'tests': ['tp5n']}, 13:26:49 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:26:49 INFO - 'talos_options': ['--xperf_path', 13:26:49 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:26:49 INFO - 'tests': ['tp5n']}}, 13:26:49 INFO - 'talos.zip': {'path': '', 13:26:49 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 13:26:49 INFO - Running post-action listener: _resource_record_post_action 13:26:49 INFO - [mozharness: 2016-11-17 21:26:49.378736Z] Finished populate-webroot step (success) 13:26:49 INFO - [mozharness: 2016-11-17 21:26:49.378836Z] Running create-virtualenv step. 13:26:49 INFO - Running pre-action listener: _resource_record_pre_action 13:26:49 INFO - Running main action method: create_virtualenv 13:26:49 INFO - Creating virtualenv /builds/slave/test/build/venv 13:26:49 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 13:26:49 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 13:26:49 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 13:26:49 INFO - Using real prefix '/tools/python27' 13:26:49 INFO - New python executable in /builds/slave/test/build/venv/bin/python 13:26:50 INFO - Installing distribute.............................................................................................................................................................................................done. 13:26:53 INFO - Installing pip.................done. 13:26:53 INFO - Return code: 0 13:26:53 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 13:26: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')]} 13:26:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:26:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:26: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')]} 13:26:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:26:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:26:53 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 0x10a062490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109fd8570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffd62c7f620>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109e76d30>, '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 0x109cdcdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109e6eb20>, '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.RhRrF4ntBj/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.2dEkvsOkUX/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/63/97m36r0j7js9vzr9g5gsghq400000w/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 13:26:53 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 13:26:53 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 13:26:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.RhRrF4ntBj/Render', 13:26:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:26:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:26:53 INFO - 'HOME': '/Users/cltbld', 13:26:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:26:53 INFO - 'LOGNAME': 'cltbld', 13:26:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:26:53 INFO - 'MOZ_NO_REMOTE': '1', 13:26:53 INFO - 'NO_EM_RESTART': '1', 13:26:53 INFO - 'PAGER': '/bin/cat', 13:26:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:26:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:26:53 INFO - 'PWD': '/builds/slave/test', 13:26:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:26:53 INFO - 'SHELL': '/bin/bash', 13:26:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2dEkvsOkUX/Listeners', 13:26:53 INFO - 'TMPDIR': '/var/folders/63/97m36r0j7js9vzr9g5gsghq400000w/T/', 13:26:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:26:53 INFO - 'USER': 'cltbld', 13:26:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:26:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:26:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:26:53 INFO - 'XPC_FLAGS': '0x0', 13:26:53 INFO - 'XPC_SERVICE_NAME': '0', 13:26:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:26:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:26:53 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 13:26:53 INFO - Cleaning up... 13:26:53 INFO - Return code: 0 13:26:53 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 13:26: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')]} 13:26:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:26:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:26: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')]} 13:26:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:26:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:26:53 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 0x10a062490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109fd8570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffd62c7f620>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109e76d30>, '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 0x109cdcdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109e6eb20>, '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.RhRrF4ntBj/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.2dEkvsOkUX/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/63/97m36r0j7js9vzr9g5gsghq400000w/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 13:26:53 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 13:26:53 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 13:26:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.RhRrF4ntBj/Render', 13:26:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:26:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:26:53 INFO - 'HOME': '/Users/cltbld', 13:26:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:26:53 INFO - 'LOGNAME': 'cltbld', 13:26:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:26:53 INFO - 'MOZ_NO_REMOTE': '1', 13:26:53 INFO - 'NO_EM_RESTART': '1', 13:26:53 INFO - 'PAGER': '/bin/cat', 13:26:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:26:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:26:53 INFO - 'PWD': '/builds/slave/test', 13:26:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:26:53 INFO - 'SHELL': '/bin/bash', 13:26:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2dEkvsOkUX/Listeners', 13:26:53 INFO - 'TMPDIR': '/var/folders/63/97m36r0j7js9vzr9g5gsghq400000w/T/', 13:26:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:26:53 INFO - 'USER': 'cltbld', 13:26:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:26:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:26:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:26:53 INFO - 'XPC_FLAGS': '0x0', 13:26:53 INFO - 'XPC_SERVICE_NAME': '0', 13:26:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:26:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:26:53 INFO - Downloading/unpacking psutil>=3.1.1 13:26:53 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 13:26:53 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 13:26:53 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 13:26:53 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 13:26:53 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 13:26:53 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 13:26:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 13:26:56 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:26:56 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:26:56 INFO - Installing collected packages: psutil 13:26:56 INFO - Running setup.py install for psutil 13:26:56 INFO - building 'psutil._psutil_osx' extension 13:26:56 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 13:26:56 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 13:26:56 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 13:26:56 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 13:26:56 INFO - building 'psutil._psutil_posix' extension 13:26:56 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 13:26:56 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 13:26:56 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 13:26:56 INFO - ^ 13:26:56 INFO - 1 warning generated. 13:26:56 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 13:26:57 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:26:57 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:26:57 INFO - Successfully installed psutil 13:26:57 INFO - Cleaning up... 13:26:57 INFO - Return code: 0 13:26:57 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 13:26:57 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')]} 13:26:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:26:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:26:57 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')]} 13:26:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:26:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:26:57 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 0x10a062490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109fd8570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffd62c7f620>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109e76d30>, '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 0x109cdcdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109e6eb20>, '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.RhRrF4ntBj/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.2dEkvsOkUX/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/63/97m36r0j7js9vzr9g5gsghq400000w/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 13:26:57 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 13:26:57 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 13:26:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.RhRrF4ntBj/Render', 13:26:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:26:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:26:57 INFO - 'HOME': '/Users/cltbld', 13:26:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:26:57 INFO - 'LOGNAME': 'cltbld', 13:26:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:26:57 INFO - 'MOZ_NO_REMOTE': '1', 13:26:57 INFO - 'NO_EM_RESTART': '1', 13:26:57 INFO - 'PAGER': '/bin/cat', 13:26:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:26:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:26:57 INFO - 'PWD': '/builds/slave/test', 13:26:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:26:57 INFO - 'SHELL': '/bin/bash', 13:26:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2dEkvsOkUX/Listeners', 13:26:57 INFO - 'TMPDIR': '/var/folders/63/97m36r0j7js9vzr9g5gsghq400000w/T/', 13:26:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:26:57 INFO - 'USER': 'cltbld', 13:26:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:26:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:26:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:26:57 INFO - 'XPC_FLAGS': '0x0', 13:26:57 INFO - 'XPC_SERVICE_NAME': '0', 13:26:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:26:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:26:57 INFO - Downloading/unpacking mozsystemmonitor==0.3 13:26:57 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 13:26:57 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 13:26:57 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 13:26:57 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 13:26:57 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 13:26:57 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 13:26:59 INFO - Downloading mozsystemmonitor-0.3.tar.gz 13:26:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 13:26:59 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 13:26:59 INFO - Installing collected packages: mozsystemmonitor 13:26:59 INFO - Running setup.py install for mozsystemmonitor 13:27:00 INFO - Successfully installed mozsystemmonitor 13:27:00 INFO - Cleaning up... 13:27:00 INFO - Return code: 0 13:27:00 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 13:27:00 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')]} 13:27:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:27:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:27:00 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')]} 13:27:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:27:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:27:00 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 0x10a062490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109fd8570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffd62c7f620>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109e76d30>, '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 0x109cdcdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109e6eb20>, '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.RhRrF4ntBj/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.2dEkvsOkUX/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/63/97m36r0j7js9vzr9g5gsghq400000w/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 13:27:00 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 13:27:00 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 13:27:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.RhRrF4ntBj/Render', 13:27:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:27:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:27:00 INFO - 'HOME': '/Users/cltbld', 13:27:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:27:00 INFO - 'LOGNAME': 'cltbld', 13:27:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:27:00 INFO - 'MOZ_NO_REMOTE': '1', 13:27:00 INFO - 'NO_EM_RESTART': '1', 13:27:00 INFO - 'PAGER': '/bin/cat', 13:27:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:27:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:27:00 INFO - 'PWD': '/builds/slave/test', 13:27:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:27:00 INFO - 'SHELL': '/bin/bash', 13:27:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2dEkvsOkUX/Listeners', 13:27:00 INFO - 'TMPDIR': '/var/folders/63/97m36r0j7js9vzr9g5gsghq400000w/T/', 13:27:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:27:00 INFO - 'USER': 'cltbld', 13:27:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:27:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:27:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:27:00 INFO - 'XPC_FLAGS': '0x0', 13:27:00 INFO - 'XPC_SERVICE_NAME': '0', 13:27:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:27:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:27:00 INFO - Downloading/unpacking jsonschema==2.5.1 13:27:00 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 13:27:00 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 13:27:00 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 13:27:00 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 13:27:00 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 13:27:00 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 13:27:02 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 13:27:02 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 13:27:02 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 13:27:02 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 13:27:02 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 13:27:02 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 13:27:02 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 13:27:02 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 13:27:03 INFO - Downloading functools32-3.2.3-2.tar.gz 13:27:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 13:27:03 INFO - warning: no files found matching '*.txt' 13:27:03 INFO - no previously-included directories found matching 'build' 13:27:03 INFO - no previously-included directories found matching 'dist' 13:27:03 INFO - no previously-included directories found matching '.git*' 13:27:03 INFO - Installing collected packages: jsonschema, functools32 13:27:03 INFO - Running setup.py install for functools32 13:27:03 INFO - warning: no files found matching '*.txt' 13:27:03 INFO - no previously-included directories found matching 'build' 13:27:03 INFO - no previously-included directories found matching 'dist' 13:27:03 INFO - no previously-included directories found matching '.git*' 13:27:03 INFO - Successfully installed jsonschema functools32 13:27:03 INFO - Cleaning up... 13:27:03 INFO - Return code: 0 13:27:03 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 13:27:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:27:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:27:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:27:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:27:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:27:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:27:03 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 0x10a062490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109fd8570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffd62c7f620>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109e76d30>, '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 0x109cdcdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109e6eb20>, '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.RhRrF4ntBj/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.2dEkvsOkUX/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/63/97m36r0j7js9vzr9g5gsghq400000w/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 13:27:03 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 13:27:03 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 13:27:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.RhRrF4ntBj/Render', 13:27:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:27:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:27:03 INFO - 'HOME': '/Users/cltbld', 13:27:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:27:03 INFO - 'LOGNAME': 'cltbld', 13:27:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:27:03 INFO - 'MOZ_NO_REMOTE': '1', 13:27:03 INFO - 'NO_EM_RESTART': '1', 13:27:03 INFO - 'PAGER': '/bin/cat', 13:27:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:27:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:27:03 INFO - 'PWD': '/builds/slave/test', 13:27:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:27:03 INFO - 'SHELL': '/bin/bash', 13:27:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2dEkvsOkUX/Listeners', 13:27:03 INFO - 'TMPDIR': '/var/folders/63/97m36r0j7js9vzr9g5gsghq400000w/T/', 13:27:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:27:03 INFO - 'USER': 'cltbld', 13:27:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:27:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:27:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:27:03 INFO - 'XPC_FLAGS': '0x0', 13:27:03 INFO - 'XPC_SERVICE_NAME': '0', 13:27:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:27:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:27:04 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 13:27:04 INFO - Cleaning up... 13:27:04 INFO - Return code: 0 13:27:04 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 13:27:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:27:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:27:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:27:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:27:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:27:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:27:04 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 0x10a062490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109fd8570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffd62c7f620>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109e76d30>, '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 0x109cdcdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109e6eb20>, '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.RhRrF4ntBj/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.2dEkvsOkUX/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/63/97m36r0j7js9vzr9g5gsghq400000w/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 13:27:04 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 13:27:04 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 13:27:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.RhRrF4ntBj/Render', 13:27:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:27:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:27:04 INFO - 'HOME': '/Users/cltbld', 13:27:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:27:04 INFO - 'LOGNAME': 'cltbld', 13:27:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:27:04 INFO - 'MOZ_NO_REMOTE': '1', 13:27:04 INFO - 'NO_EM_RESTART': '1', 13:27:04 INFO - 'PAGER': '/bin/cat', 13:27:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:27:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:27:04 INFO - 'PWD': '/builds/slave/test', 13:27:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:27:04 INFO - 'SHELL': '/bin/bash', 13:27:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2dEkvsOkUX/Listeners', 13:27:04 INFO - 'TMPDIR': '/var/folders/63/97m36r0j7js9vzr9g5gsghq400000w/T/', 13:27:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:27:04 INFO - 'USER': 'cltbld', 13:27:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:27:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:27:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:27:04 INFO - 'XPC_FLAGS': '0x0', 13:27:04 INFO - 'XPC_SERVICE_NAME': '0', 13:27:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:27:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:27:04 INFO - Downloading/unpacking blobuploader==1.2.4 13:27:04 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 13:27:04 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 13:27:04 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 13:27:04 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 13:27:04 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 13:27:04 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 13:27:06 INFO - Downloading blobuploader-1.2.4.tar.gz 13:27:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 13:27:06 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 13:27:06 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 13:27:06 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 13:27:06 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 13:27:06 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 13:27:06 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 13:27:06 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 13:27:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 13:27:07 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 13:27: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 13:27: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 13:27: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 13:27: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 13:27: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 13:27: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 13:27:07 INFO - Downloading docopt-0.6.1.tar.gz 13:27:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 13:27:08 INFO - Installing collected packages: blobuploader, requests, docopt 13:27:08 INFO - Running setup.py install for blobuploader 13:27:08 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 13:27:08 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 13:27:08 INFO - Running setup.py install for requests 13:27:08 INFO - Running setup.py install for docopt 13:27:08 INFO - Successfully installed blobuploader requests docopt 13:27:08 INFO - Cleaning up... 13:27:08 INFO - Return code: 0 13:27:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:27:08 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')]} 13:27:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:27:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:27:08 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')]} 13:27:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:27:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:27:08 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 0x10a062490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109fd8570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffd62c7f620>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109e76d30>, '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 0x109cdcdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109e6eb20>, '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.RhRrF4ntBj/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.2dEkvsOkUX/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/63/97m36r0j7js9vzr9g5gsghq400000w/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 13:27:08 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 13:27:08 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 13:27:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.RhRrF4ntBj/Render', 13:27:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:27:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:27:08 INFO - 'HOME': '/Users/cltbld', 13:27:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:27:08 INFO - 'LOGNAME': 'cltbld', 13:27:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:27:08 INFO - 'MOZ_NO_REMOTE': '1', 13:27:08 INFO - 'NO_EM_RESTART': '1', 13:27:08 INFO - 'PAGER': '/bin/cat', 13:27:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:27:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:27:08 INFO - 'PWD': '/builds/slave/test', 13:27:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:27:08 INFO - 'SHELL': '/bin/bash', 13:27:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2dEkvsOkUX/Listeners', 13:27:08 INFO - 'TMPDIR': '/var/folders/63/97m36r0j7js9vzr9g5gsghq400000w/T/', 13:27:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:27:08 INFO - 'USER': 'cltbld', 13:27:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:27:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:27:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:27:08 INFO - 'XPC_FLAGS': '0x0', 13:27:08 INFO - 'XPC_SERVICE_NAME': '0', 13:27:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:27:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:27:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:27:09 INFO - Running setup.py (path:/var/folders/63/97m36r0j7js9vzr9g5gsghq400000w/T/pip-47wZk8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:27:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:27:09 INFO - Running setup.py (path:/var/folders/63/97m36r0j7js9vzr9g5gsghq400000w/T/pip-2hU52_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:27:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:27:09 INFO - Running setup.py (path:/var/folders/63/97m36r0j7js9vzr9g5gsghq400000w/T/pip-OTdYW3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:27:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:27:09 INFO - Running setup.py (path:/var/folders/63/97m36r0j7js9vzr9g5gsghq400000w/T/pip-YehzV4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:27:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:27:09 INFO - Running setup.py (path:/var/folders/63/97m36r0j7js9vzr9g5gsghq400000w/T/pip-cwxbkk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:27:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:27:09 INFO - Running setup.py (path:/var/folders/63/97m36r0j7js9vzr9g5gsghq400000w/T/pip-8IFTI8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:27:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:27:09 INFO - Running setup.py (path:/var/folders/63/97m36r0j7js9vzr9g5gsghq400000w/T/pip-2zq91p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:27:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:27:09 INFO - Running setup.py (path:/var/folders/63/97m36r0j7js9vzr9g5gsghq400000w/T/pip-z_ojED-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:27:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:27:09 INFO - Running setup.py (path:/var/folders/63/97m36r0j7js9vzr9g5gsghq400000w/T/pip-4UXz36-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:27:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:27:10 INFO - Running setup.py (path:/var/folders/63/97m36r0j7js9vzr9g5gsghq400000w/T/pip-O6pizP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:27:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:27:10 INFO - Running setup.py (path:/var/folders/63/97m36r0j7js9vzr9g5gsghq400000w/T/pip-W4q4P6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:27:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:27:10 INFO - Running setup.py (path:/var/folders/63/97m36r0j7js9vzr9g5gsghq400000w/T/pip-JxGBg4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:27:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:27:10 INFO - Running setup.py (path:/var/folders/63/97m36r0j7js9vzr9g5gsghq400000w/T/pip-OYkDOH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:27:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:27:10 INFO - Running setup.py (path:/var/folders/63/97m36r0j7js9vzr9g5gsghq400000w/T/pip-qVmO3J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:27:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:27:10 INFO - Running setup.py (path:/var/folders/63/97m36r0j7js9vzr9g5gsghq400000w/T/pip-qbfyDB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:27:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:27:10 INFO - Running setup.py (path:/var/folders/63/97m36r0j7js9vzr9g5gsghq400000w/T/pip-miskUD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:27:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:27:10 INFO - Running setup.py (path:/var/folders/63/97m36r0j7js9vzr9g5gsghq400000w/T/pip-HtVrLV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:27:10 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 13:27:10 INFO - Running setup.py install for manifestparser 13:27:11 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 13:27:11 INFO - Running setup.py install for mozcrash 13:27:11 INFO - Running setup.py install for mozdebug 13:27:11 INFO - Running setup.py install for mozdevice 13:27:11 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 13:27:11 INFO - Installing dm script to /builds/slave/test/build/venv/bin 13:27:11 INFO - Running setup.py install for mozfile 13:27:11 INFO - Running setup.py install for mozhttpd 13:27:11 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 13:27:11 INFO - Running setup.py install for mozinfo 13:27:11 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 13:27:11 INFO - Running setup.py install for mozInstall 13:27:12 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 13:27:12 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 13:27:12 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 13:27:12 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 13:27:12 INFO - Running setup.py install for mozleak 13:27:12 INFO - Running setup.py install for mozlog 13:27:12 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 13:27:12 INFO - Running setup.py install for moznetwork 13:27:12 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 13:27:12 INFO - Running setup.py install for mozprocess 13:27:12 INFO - Running setup.py install for mozprofile 13:27:12 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 13:27:12 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 13:27:12 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 13:27:12 INFO - Running setup.py install for mozrunner 13:27:13 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 13:27:13 INFO - Running setup.py install for mozscreenshot 13:27:13 INFO - Running setup.py install for moztest 13:27:13 INFO - Running setup.py install for mozversion 13:27:13 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 13:27:13 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 13:27:13 INFO - Cleaning up... 13:27:13 INFO - Return code: 0 13:27:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:27:13 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')]} 13:27:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:27:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:27:13 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')]} 13:27:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:27:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:27:13 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 0x10a062490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109fd8570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffd62c7f620>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109e76d30>, '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 0x109cdcdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109e6eb20>, '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.RhRrF4ntBj/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.2dEkvsOkUX/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/63/97m36r0j7js9vzr9g5gsghq400000w/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 13:27:13 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 13:27:13 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 13:27:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.RhRrF4ntBj/Render', 13:27:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:27:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:27:13 INFO - 'HOME': '/Users/cltbld', 13:27:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:27:13 INFO - 'LOGNAME': 'cltbld', 13:27:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:27:13 INFO - 'MOZ_NO_REMOTE': '1', 13:27:13 INFO - 'NO_EM_RESTART': '1', 13:27:13 INFO - 'PAGER': '/bin/cat', 13:27:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:27:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:27:13 INFO - 'PWD': '/builds/slave/test', 13:27:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:27:13 INFO - 'SHELL': '/bin/bash', 13:27:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2dEkvsOkUX/Listeners', 13:27:13 INFO - 'TMPDIR': '/var/folders/63/97m36r0j7js9vzr9g5gsghq400000w/T/', 13:27:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:27:13 INFO - 'USER': 'cltbld', 13:27:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:27:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:27:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:27:13 INFO - 'XPC_FLAGS': '0x0', 13:27:13 INFO - 'XPC_SERVICE_NAME': '0', 13:27:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:27:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:27:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:27:13 INFO - Running setup.py (path:/var/folders/63/97m36r0j7js9vzr9g5gsghq400000w/T/pip-uCl1Kx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:27:13 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)) 13:27:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:27:13 INFO - Running setup.py (path:/var/folders/63/97m36r0j7js9vzr9g5gsghq400000w/T/pip-puaqQj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:27:14 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)) 13:27:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:27:14 INFO - Running setup.py (path:/var/folders/63/97m36r0j7js9vzr9g5gsghq400000w/T/pip-k1GAD1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:27:14 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)) 13:27:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:27:14 INFO - Running setup.py (path:/var/folders/63/97m36r0j7js9vzr9g5gsghq400000w/T/pip-dklwTq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:27:14 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)) 13:27:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:27:14 INFO - Running setup.py (path:/var/folders/63/97m36r0j7js9vzr9g5gsghq400000w/T/pip-wG8biB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:27:14 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)) 13:27:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:27:14 INFO - Running setup.py (path:/var/folders/63/97m36r0j7js9vzr9g5gsghq400000w/T/pip-Tm_epL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:27:14 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)) 13:27:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:27:14 INFO - Running setup.py (path:/var/folders/63/97m36r0j7js9vzr9g5gsghq400000w/T/pip-u1jL5u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:27:14 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)) 13:27:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:27:14 INFO - Running setup.py (path:/var/folders/63/97m36r0j7js9vzr9g5gsghq400000w/T/pip-_dTUAc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:27:14 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)) 13:27:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:27:14 INFO - Running setup.py (path:/var/folders/63/97m36r0j7js9vzr9g5gsghq400000w/T/pip-2mVfAt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:27:14 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)) 13:27:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:27:14 INFO - Running setup.py (path:/var/folders/63/97m36r0j7js9vzr9g5gsghq400000w/T/pip-_HYZre-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:27:14 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)) 13:27:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:27:14 INFO - Running setup.py (path:/var/folders/63/97m36r0j7js9vzr9g5gsghq400000w/T/pip-NrU0LR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:27:14 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)) 13:27:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:27:14 INFO - Running setup.py (path:/var/folders/63/97m36r0j7js9vzr9g5gsghq400000w/T/pip-GeLfhS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:27:15 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)) 13:27:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:27:15 INFO - Running setup.py (path:/var/folders/63/97m36r0j7js9vzr9g5gsghq400000w/T/pip-SjvlqI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:27:15 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)) 13:27:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:27:15 INFO - Running setup.py (path:/var/folders/63/97m36r0j7js9vzr9g5gsghq400000w/T/pip-UcVx77-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:27:15 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)) 13:27:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:27:15 INFO - Running setup.py (path:/var/folders/63/97m36r0j7js9vzr9g5gsghq400000w/T/pip-NDJs04-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:27:15 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)) 13:27:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:27:15 INFO - Running setup.py (path:/var/folders/63/97m36r0j7js9vzr9g5gsghq400000w/T/pip-3eADL8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:27:15 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)) 13:27:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:27:15 INFO - Running setup.py (path:/var/folders/63/97m36r0j7js9vzr9g5gsghq400000w/T/pip-hGFMZF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:27:15 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)) 13:27:15 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)) 13:27:15 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)) 13:27:15 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)) 13:27:15 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)) 13:27:15 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)) 13:27:15 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 13:27: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 13:27: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 13:27: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 13:27: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 13:27: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 13:27: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 13:27:18 INFO - Downloading blessings-1.6.tar.gz 13:27:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 13:27:18 INFO - Installing collected packages: blessings 13:27:18 INFO - Running setup.py install for blessings 13:27:18 INFO - Successfully installed blessings 13:27:18 INFO - Cleaning up... 13:27:18 INFO - Return code: 0 13:27:18 INFO - Done creating virtualenv /builds/slave/test/build/venv. 13:27:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:27:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:27:18 INFO - Reading from file tmpfile_stdout 13:27:18 INFO - Current package versions: 13:27:18 INFO - blessings == 1.6 13:27:18 INFO - blobuploader == 1.2.4 13:27:18 INFO - docopt == 0.6.1 13:27:18 INFO - functools32 == 3.2.3-2 13:27:18 INFO - jsonschema == 2.5.1 13:27:18 INFO - manifestparser == 1.1 13:27:18 INFO - mozInstall == 1.12 13:27:18 INFO - mozcrash == 0.17 13:27:18 INFO - mozdebug == 0.1 13:27:18 INFO - mozdevice == 0.48 13:27:18 INFO - mozfile == 1.2 13:27:18 INFO - mozhttpd == 0.7 13:27:18 INFO - mozinfo == 0.9 13:27:18 INFO - mozleak == 0.1 13:27:18 INFO - mozlog == 3.4 13:27:18 INFO - moznetwork == 0.27 13:27:18 INFO - mozprocess == 0.23 13:27:18 INFO - mozprofile == 0.28 13:27:18 INFO - mozrunner == 6.12 13:27:18 INFO - mozscreenshot == 0.1 13:27:18 INFO - mozsystemmonitor == 0.3 13:27:18 INFO - moztest == 0.7 13:27:18 INFO - mozversion == 1.4 13:27:18 INFO - psutil == 3.1.1 13:27:18 INFO - requests == 1.2.3 13:27:18 INFO - wsgiref == 0.1.2 13:27:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:27:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:27:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:27:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:27:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:27:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:27:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:27:18 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 0x10a062490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109fd8570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffd62c7f620>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109e76d30>, '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 0x109cdcdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109e6eb20>, '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.RhRrF4ntBj/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.2dEkvsOkUX/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/63/97m36r0j7js9vzr9g5gsghq400000w/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 13:27:18 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 13:27:18 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 13:27:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.RhRrF4ntBj/Render', 13:27:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:27:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:27:18 INFO - 'HOME': '/Users/cltbld', 13:27:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:27:18 INFO - 'LOGNAME': 'cltbld', 13:27:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:27:18 INFO - 'MOZ_NO_REMOTE': '1', 13:27:18 INFO - 'NO_EM_RESTART': '1', 13:27:18 INFO - 'PAGER': '/bin/cat', 13:27:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:27:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:27:18 INFO - 'PWD': '/builds/slave/test', 13:27:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:27:18 INFO - 'SHELL': '/bin/bash', 13:27:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2dEkvsOkUX/Listeners', 13:27:18 INFO - 'TMPDIR': '/var/folders/63/97m36r0j7js9vzr9g5gsghq400000w/T/', 13:27:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:27:18 INFO - 'USER': 'cltbld', 13:27:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:27:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:27:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:27:18 INFO - 'XPC_FLAGS': '0x0', 13:27:18 INFO - 'XPC_SERVICE_NAME': '0', 13:27:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:27:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:27:18 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)) 13:27:18 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)) 13:27:18 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)) 13:27:18 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)) 13:27:18 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)) 13:27:18 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)) 13:27:18 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)) 13:27:18 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)) 13:27:18 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)) 13:27:18 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)) 13:27:18 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)) 13:27:18 INFO - Cleaning up... 13:27:18 INFO - Return code: 0 13:27:18 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 13:27:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:27:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:27:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:27:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:27:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:27:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:27:18 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10a062490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109fd8570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffd62c7f620>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109e76d30>, '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 0x109cdcdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109e6eb20>, '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.RhRrF4ntBj/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.2dEkvsOkUX/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/63/97m36r0j7js9vzr9g5gsghq400000w/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 13:27:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 13:27:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 13:27:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.RhRrF4ntBj/Render', 13:27:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:27:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:27:18 INFO - 'HOME': '/Users/cltbld', 13:27:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:27:18 INFO - 'LOGNAME': 'cltbld', 13:27:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:27:18 INFO - 'MOZ_NO_REMOTE': '1', 13:27:18 INFO - 'NO_EM_RESTART': '1', 13:27:18 INFO - 'PAGER': '/bin/cat', 13:27:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:27:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:27:18 INFO - 'PWD': '/builds/slave/test', 13:27:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:27:18 INFO - 'SHELL': '/bin/bash', 13:27:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2dEkvsOkUX/Listeners', 13:27:18 INFO - 'TMPDIR': '/var/folders/63/97m36r0j7js9vzr9g5gsghq400000w/T/', 13:27:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:27:18 INFO - 'USER': 'cltbld', 13:27:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:27:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:27:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:27:18 INFO - 'XPC_FLAGS': '0x0', 13:27:18 INFO - 'XPC_SERVICE_NAME': '0', 13:27:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:27:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:27:19 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 13:27:19 INFO - Cleaning up... 13:27:19 INFO - Return code: 0 13:27:19 INFO - Running post-action listener: _resource_record_post_action 13:27:19 INFO - Running post-action listener: _start_resource_monitoring 13:27:19 INFO - Starting resource monitoring. 13:27:19 INFO - [mozharness: 2016-11-17 21:27:19.264330Z] Finished create-virtualenv step (success) 13:27:19 INFO - [mozharness: 2016-11-17 21:27:19.265391Z] Running install step. 13:27:19 INFO - Running pre-action listener: _resource_record_pre_action 13:27:19 INFO - Running main action method: install 13:27:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:27:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:27:19 INFO - Reading from file tmpfile_stdout 13:27:19 INFO - Detecting whether we're running mozinstall >=1.0... 13:27:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 13:27:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 13:27:19 INFO - Reading from file tmpfile_stdout 13:27:19 INFO - Output received: 13:27:19 INFO - Usage: mozinstall [options] installer 13:27:19 INFO - Options: 13:27:19 INFO - -h, --help show this help message and exit 13:27:19 INFO - -d DEST, --destination=DEST 13:27:19 INFO - Directory to install application into. [default: 13:27:19 INFO - "/builds/slave/test"] 13:27:19 INFO - --app=APP Application being installed. [default: firefox] 13:27:19 INFO - mkdir: /builds/slave/test/build/application 13:27:19 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'] 13:27:19 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 13:27:41 INFO - Reading from file tmpfile_stdout 13:27:41 INFO - Output received: 13:27:41 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 13:27:41 INFO - Running post-action listener: _resource_record_post_action 13:27:41 INFO - [mozharness: 2016-11-17 21:27:41.178785Z] Finished install step (success) 13:27:41 INFO - [mozharness: 2016-11-17 21:27:41.178901Z] Running run-tests step. 13:27:41 INFO - Running pre-action listener: _resource_record_pre_action 13:27:41 INFO - Running main action method: run_tests 13:27:41 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 13:27:41 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 13:27:41 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 13:27:41 INFO - 2016-11-17 13:27:41.193 screenresolution[2074:17708] starting screenresolution argv=screenresolution get 13:27:41 INFO - 2016-11-17 13:27:41.195 screenresolution[2074:17708] Display 0: 1600x1200x32@60 13:27:41 INFO - 2016-11-17 13:27:41.201 screenresolution[2075:17710] starting screenresolution argv=screenresolution list 13:27:41 INFO - Available Modes on Display 0 13:27:41 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 13:27:41 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 13:27:41 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 13:27:41 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 13:27:41 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 13:27:41 INFO - Intel Iris: 13:27:41 INFO - Chipset Model: Intel Iris 13:27:41 INFO - Type: GPU 13:27:41 INFO - Bus: Built-In 13:27:41 INFO - VRAM (Dynamic, Max): 1536 MB 13:27:41 INFO - Vendor: Intel (0x8086) 13:27:41 INFO - Device ID: 0x0a2e 13:27:41 INFO - Revision ID: 0x0009 13:27:41 INFO - Displays: 13:27:41 INFO - Display: 13:27:41 INFO - Resolution: 1600 x 1200 @ 60 Hz 13:27:41 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 13:27:41 INFO - Display Serial Number: 1600x1200 60 13:27:41 INFO - Main Display: Yes 13:27:41 INFO - Mirror: Off 13:27:41 INFO - Online: Yes 13:27:41 INFO - Rotation: Supported 13:27:41 INFO - Return code: 0 13:27:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 13:27:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 13:27:41 INFO - Python 2.7.3 13:27:41 INFO - Return code: 0 13:27:41 INFO - grabbing minidump binary from tooltool 13:27:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:27:41 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 0x109e76d30>, '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 0x109cdcdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109e6eb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 13:27:41 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 13:27:41 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 13:27:41 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 13:27:41 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 13:27:41 INFO - Return code: 0 13:27:41 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 13:27:41 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 13:27:41 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 13:27:41 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 13:27:41 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 13:27:41 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/aIv3f7hCSkqntywFtt1cMQ/artifacts/public/build/firefox-51.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0216', '--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 13:27:41 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/aIv3f7hCSkqntywFtt1cMQ/artifacts/public/build/firefox-51.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0216 --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 13:27:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.RhRrF4ntBj/Render', 13:27:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:27:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:27:41 INFO - 'HOME': '/Users/cltbld', 13:27:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:27:41 INFO - 'LOGNAME': 'cltbld', 13:27:41 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 13:27:41 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 13:27:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:27:41 INFO - 'MOZ_NO_REMOTE': '1', 13:27:41 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 13:27:41 INFO - 'NO_EM_RESTART': '1', 13:27:41 INFO - 'PAGER': '/bin/cat', 13:27:41 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:27:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:27:41 INFO - 'PWD': '/builds/slave/test', 13:27:41 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 13:27:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:27:41 INFO - 'SHELL': '/bin/bash', 13:27:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2dEkvsOkUX/Listeners', 13:27:41 INFO - 'TMPDIR': '/var/folders/63/97m36r0j7js9vzr9g5gsghq400000w/T/', 13:27:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:27:41 INFO - 'USER': 'cltbld', 13:27:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:27:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:27:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:27:41 INFO - 'XPC_FLAGS': '0x0', 13:27:41 INFO - 'XPC_SERVICE_NAME': '0', 13:27:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:27:41 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/aIv3f7hCSkqntywFtt1cMQ/artifacts/public/build/firefox-51.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0216', '--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 13:27:41 INFO - mozversion application_buildid: 20161117105628 13:27:41 INFO - mozversion application_changeset: 4a50f24275d4f5d0afb68752ca228c5fbf2a6784 13:27:41 INFO - mozversion application_display_name: Firefox 13:27:41 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 13:27:41 INFO - mozversion application_name: Firefox 13:27:41 INFO - mozversion application_remotingname: firefox 13:27:41 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 13:27:41 INFO - mozversion application_vendor: Mozilla 13:27:41 INFO - mozversion application_version: 51.0 13:27:41 INFO - mozversion platform_buildid: 20161117105628 13:27:41 INFO - mozversion platform_changeset: 4a50f24275d4f5d0afb68752ca228c5fbf2a6784 13:27:41 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 13:27:41 INFO - mozversion platform_version: 51.0 13:27:41 INFO - using testdate: 1479418061 13:27:41 INFO - actual date: 1479418061 13:27:41 INFO - starting webserver on 'localhost:54426' 13:27:41 INFO - SUITE-START | Running 2 tests 13:27:41 INFO - TEST-START | dromaeo_css 13:27:41 INFO - operating with platform_type : mac_ 13:27:41 INFO - Initialising browser for dromaeo_css test... 13:27:41 INFO - TEST-INFO | started process 2085 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/63/97m36r0j7js9vzr9g5gsghq400000w/T/tmpPw5CHe/profile http://localhost:54426/getInfo.html) 13:27:44 INFO - PROCESS | 2085 | __metrics Screen width/height:1600/1200 13:27:44 INFO - PROCESS | 2085 | colorDepth:24 13:27:44 INFO - PROCESS | 2085 | Browser inner width/height: 1024/689 13:27:44 INFO - PROCESS | 2085 | __metrics 13:27:44 INFO - PROCESS | 2085 | 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" 13:27:44 INFO - PROCESS | 2085 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 13:27:44 INFO - TEST-INFO | 2085: exit 0 13:27:44 INFO - Browser initialized. 13:27:44 INFO - Running cycle 1/1 for dromaeo_css test... 13:27:44 INFO - TEST-INFO | started process 2089 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/63/97m36r0j7js9vzr9g5gsghq400000w/T/tmpPw5CHe/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:27:56 INFO - PROCESS | 2089 | RSS: Main: 190640128 13:27:56 INFO - PROCESS | 2089 | 13:28:48 INFO - PROCESS | 2089 | 1479418128124 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] 13:30:58 INFO - PROCESS | 2089 | Cycle 1(1): loaded http://localhost:54426/tests/dromaeo/cssquery-dojo.html (next: http://localhost:54426/tests/dromaeo/cssquery-ext.html) 13:30:59 INFO - PROCESS | 2089 | RSS: Main: 334258176 13:30:59 INFO - PROCESS | 2089 | 13:34:02 INFO - PROCESS | 2089 | Cycle 1(1): loaded http://localhost:54426/tests/dromaeo/cssquery-ext.html (next: http://localhost:54426/tests/dromaeo/cssquery-jquery.html) 13:34:03 INFO - PROCESS | 2089 | RSS: Main: 319987712 13:34:03 INFO - PROCESS | 2089 | 13:37:05 INFO - PROCESS | 2089 | Cycle 1(1): loaded http://localhost:54426/tests/dromaeo/cssquery-jquery.html (next: http://localhost:54426/tests/dromaeo/cssquery-mootools.html) 13:37:06 INFO - PROCESS | 2089 | RSS: Main: 293224448 13:37:06 INFO - PROCESS | 2089 | 13:40:08 INFO - PROCESS | 2089 | Cycle 1(1): loaded http://localhost:54426/tests/dromaeo/cssquery-mootools.html (next: http://localhost:54426/tests/dromaeo/cssquery-prototype.html) 13:40:09 INFO - PROCESS | 2089 | RSS: Main: 310951936 13:40:09 INFO - PROCESS | 2089 | 13:43:12 INFO - PROCESS | 2089 | Cycle 1(1): loaded http://localhost:54426/tests/dromaeo/cssquery-prototype.html (next: http://localhost:54426/tests/dromaeo/cssquery-yui.html) 13:43:13 INFO - PROCESS | 2089 | RSS: Main: 278908928 13:43:13 INFO - PROCESS | 2089 | 13:46:15 INFO - PROCESS | 2089 | Cycle 1(1): loaded http://localhost:54426/tests/dromaeo/cssquery-yui.html (next: http://localhost:54426/tests/dromaeo/cssquery-dojo.html) 13:46:16 INFO - PROCESS | 2089 | RSS: Main: 395022336 13:46:16 INFO - PROCESS | 2089 | 13:46:16 INFO - PROCESS | 2089 | __start_tp_report 13:46:16 INFO - PROCESS | 2089 | _x_x_mozilla_page_load 13:46:16 INFO - PROCESS | 2089 | _x_x_mozilla_page_load_details 13:46:16 INFO - PROCESS | 2089 | |i|pagename|runs| 13:46:16 INFO - PROCESS | 2089 | |0;dojo.html;2844.587534807453;3441.088111650413;3483.5993860706026;3503.9299214015737;3553.9644603553957;5777.277840269966;5851.79518716845;5858.443447872456;5858.472737453639;5888;5808.883822323551;5837.357890632038;5869.853253668661;5882.000059989801;5894.793682221123;5311.62818602698;5311.840644780644;5395.649282796625;5401.891962160755;5403.054465468547;5306.018386598473;5309.946900531003;5319.388270348921;5414.972925135388;5445.047116754572;5336.946630533703;5403.83788486346;5431.321084864392;5445.891082178354;5457.181422786574;5382.569394448455;5451.836444906659;5460.563154947595;5461.563074953994;5479.369872464677;5328.733563321857;5417.891642167135;5430.294061771984;5437.755301011464;5461.371942226655;5681.829545113612;5717.285339332583;5734.111212762028;5743.798967036176;5914.9112763308585;6267.811965641038;6334.239891213084;6348.111264422984;6362.840928976766;6365.554411191219;6250.281217659936;6281.623102613858;6292.087647291163;6297.779577714804;6310.116583678288;5766.221560089376;5801.53587712982;5815.883682326415;5936.376680448577;5951.6726580038085;6226.40849119333;6262.15460912771;6272.686365681698;6342.778002769881;6353.777617783356;6193.163922870445;6281.089242059876;6297.4332310091395;6302.180716506825;6319.8104056878365;6351.523635727246;6352.809415717444;6365.4589359904;6371.044343348442;6371.872562548723;5811.796587119515;5829.038208695602;5845.503132233808;6213.968930155411;6326.652034138075;6350.237971443364;6358.332375100548;6368.713407896656;6387.361263873576;6389.7763578274535;5005.974970125126;5013.373328333958;5022.648414610942;5043.571296439771;5073.9746301269;4477.283634618446;4493.213687604656;4527.094581083797;4541.069080838421;4553.681242313072;5909.084091965752;5936.673482958478;6019.578629495981;6019.69901504923;6100.603460775035;6259.374062593704;6285.77999770015;6296.150019747367;6300.21247344082;6303.558750887486;5978.790742323998;5998.3701711320555;6037.758489660452;6038.275406951194;6044.546659000593;5407.83776486706;5458.863528411742;5476.014317422902;5477.068898287221;5481.958427898687;6455.580387274812;6458.838529036718;6464.868647986677;6491.188601424822;6496.415322620986;5898.94101058984;6101.267847858286;6299.748010079546;6301.6534090625455;6331.90502142459;6083.908741368971;6250.531210159165;6329.683515824098;6378.840528986812;6471.029345598198;6238.344973777688;6297.905531416941;6322.620642761449;6327.303996560467;6334.683265836782;6161.72272247741;6285.874282514415;6288.905666415099;6302.054691796267;6307.873842523032;6102.084687296763;6144.56988010835;6214.2853571838;6263.655498947602;6280.214973128359;6160.383961603804;6172.907406388818;6209.658468784261;6258.687065646791;6296.685165741603;5981.910271346021;5998.1002849572915;6175.783847565313;6180.5673602849165;6191.721372538336;6053.485453736482;6131.101423540661;6290.2766181889665;6292.024736165901;6306.432421082125;6051.880402125445;6057.878842423215;6132.957397242569;6136.202293701969;6144.1398204250545 13:46:16 INFO - PROCESS | 2089 | |1;ext.html;478.6481935777204;485.9854204373868;493.49663343389733;510.4767613196471;580.3384142078029;34574.654253457455;43297.48458803943;44026.91811573191;44038.779806101;46551;45647.543524564746;45892.541074589244;46041.61875143751;46080.61758147253;46173.07653846921;10087;10165.695029149138;10286.897131028707;10291.022352876502;10292.433916134609;7987.7204297849585;9646.228301735844;10278.743031424237;12538.498460061586;12590.307533085677;12495.812897774696;12562.37188140594;12587.559435419762;12610.495580176783;12637.68405789858;12547.058970577198;12568.120231583793;12598.622041338775;12601.991840652772;12610.369481525888;12394.442250098768;12452.377381130998;12461.626151215478;12464.81302780459;12472.81290780639;43295.35056974148;43477.78261108706;43607.9098022552;43641.69074927757;43644.563554364686;3457.1529975155995;4035.677145828356;4171.20747058061;4179.1223842993;4210.51579068408;31209.416993645722;31475;31482;32966.3406731864;33941.490877636854;3329.234276116507;3371.2751758371824;3568.50040994261;3575.481555174485;3576.7138628909624;390556;390709;390988;391269.3492260335;392247;63901;64335.03497447542;64368.356316436235;64391.67804161043;64402.677986609764;67853;67971;68038.65980670066;68086;68134.65932670305;17847.73228401575;18074.096295185187;18076.819231807778;18094.185761640496;18102.275908963493;12757.234565926074;13042.869571304354;14049.508267210598;14096.788548171786;14151.71696566063;15376.15431151275;18025.40734603696;21618.56762864734;21691.457713557287;21912.013959371867;8598.140185981352;8618.224359807647;8839.734807955772;8869;8937.150970657776;933.8739270198572;1039.8111974294154;1049.6431213387484;1106.9225154239125;1177.4819079604947;31458.842705786323;31648;31700.682993169772;31939.201519962186;32107.83946080255;1092.6831218946415;1139.7720455908852;1141.223967701954;1146.541383446628;1152.2798251093068;15455.459058932884;16319.102449365399;16375.754363684555;16406.83593164077;16747.33010679559;779757;783505;784997;787704;788198;62958.685206573675;63212.05181922275;63228.05157922635;63324.05013924795;63364.68317658382;1236.2335352081766;1316.6247619428416;1384.2732565403041;1460.2771628044186;1463.1952426165353;27031;31319.373612527164;33483.995480135636;33777.66737051298;34015.319693605496;52237;52830.471695282555;52878.73560632172;52966;53119;615447;617796;619725;622596;625974;37340.81329593444;38146;40641.796791015855;40757;44251.11497770091;48739.268910967075;50243.74878125732;50457.74771126268;50590;51092.48907511026;40299;41255.381169281885;45344.773276133405;45837;46607;41999.3700094505;46070.76964615155;46292;46492.53507465017;47380.763096184295;44636.55363446324;44771.32843007292;45219.321710175034;45709.62871113872;46102.30846537372;42821;43537;44270;45826.312605311614;46685.533144668116;27930.58104128399;28742.71257287484;28774.280642984093;28774.568381473877;28774.856125719238 13:46:16 INFO - PROCESS | 2089 | |2;jquery.html;311.87680866057906;371.83267529611663;374.9718771092169;379.0504785512291;406.0235134501525;19742.309019184333;21426.678599820996;21798;22625.86870656469;22824;21125;21130;21863.78136218641;22134.88932555335;22403.663945040797;6030.939690603103;6088.969555152229;6238.500919926418;6297.181366422359;6307.463865571432;4420.58004489573;4564.383808185886;4579.450465944092;5257.158854583267;6257.530685198605;4549.363089167519;4590.540945905416;4592.678512504126;6973.476989225803;7049.224585295639;6759.93240067598;6911.6544172791155;7000.194977577567;7033.261507541712;7037.261087585806;6032.185654936571;6081.087836824468;6083.939160608382;6095.359987201325;6109.236345456818;27757.028504002465;28214.717852821414;28284.434311313864;28506;28724.425511489862;2256.3047445706584;2263.6830843681896;2395.197608801054;2470.28361775085;2528.4311030018284;13104.672383190402;15610.29753661088;15968.76046859298;16394.016359018497;16426.83573164265;1848.9815101849078;1869.4391682495198;1926.258390519646;1926.8169523895208;1928.6142771445627;106029;111413.99999999919;111570;111752;111837.44081279622;9984.004798560403;10101.898981010243;10154.004568652264;10302.484875756183;10445.425501597334;12694.49222031127;12739.80890286628;12746.872531274754;12756.489740410465;12770.80843787344;8583.95584597844;8952.910470895207;8956.955215223883;9018.909810901938;9020.14308640678;9494.477803720862;9513.429194248367;9528.142467177988;9703.320767546204;9713.61145554184;5925.525957923356;6014.458698717136;6014.879702405928;6023.518118550505;6126.295476020315;1512.3648067811546;1687.6118492746737;1723.327902118175;1733.8266173382813;1734.540346808097;951.2532661860545;982.1013772398319;984.9556769945369;1053.4522048534873;1133.6032388663903;22561.097556097902;22754.772452275596;22850.885745571166;23116.76883231146;23163.7683623165;869.891263592051;873.9606717697719;1007.9193664506822;1026.9024442677933;1050.175612144463;11022.944885275523;11977.580784672495;12226.694332641755;12250.326232057323;12258.81611775824;636304;639765;651707;653581;661449;89983.55008224917;113236;118092.40953795348;123877;126478.36760816321;971.4074414607084;999.5651891427398;1019.3985548526405;1020.698893826323;1022.6931920423843;20174.193032278545;21319.360419187447;21484.462888427915;21523.92380381006;21584.568308634054;55991.72004139953;56422.717886410304;56900;57183.42816571781;57666;71717;76783.61608191923;78943.60528197323;79915.20084799078;82659;7907;8194.38542109356;8204.220599043081;8279.710210142615;8383.538905360263;13413.396397161956;13448.596542103753;13467.922566194486;13532.797008045085;13756.312184390541;11596.47815848272;11631.53473861036;11650.76698466009;11742.471588778355;12041.638750837488;9668.613255469703;11572.537098515964;11666.591669291534;11698.70753231176;11778.76442471163;11532.423378831192;11745.88254117482;11770.823437648613;11981.341026243292;12177.33024683651;6372.808815735535;8104.351651867954;8190.262876341158;8244.340452763885;8302.792430189294;11389.487473063566;11610.941945290557;11655.53377864876;11964.42764805571;12206.63380098563 13:46:16 INFO - PROCESS | 2089 | |3;mootools.html;1576.8423157684233;1584.1208129488134;1820.1445320699268;1913.732077509148;1957.9804201957977;8601.354898382622;9130.954345228272;9131.543422828865;9134.862977055349;9138.588763505642;7669.309762121408;8045.1552586978405;8304.377171712116;8781.736547903558;8895.95552022239;2395.4370722880153;2424.684790977179;2425.866577338246;2431.5623187826186;2434.2453839309783;2383.5232953409386;2404.0263693204192;2428.8178386620984;2429.259075981825;2429.514097180562;2065.5455799724036;2392.473655795722;2409.975900240993;2417.3714834143075;2428.781409673129;2361.1617875654238;2379.3456799380224;2388.593939030369;2389.2593296078185;2409.6024156014237;2373.905043798246;2383.892724827387;2387.5583017141885;2390.53384590005;2394.880255987211;8944.59749311276;9151.542422878829;9152.679656212067;9155;9165.358424910259;5343.412224655285;5505.009098362293;5510.201020851994;5511.145772405283;5511.338639363262;3604.3872541667715;3707.2029513654425;3716.776993380379;3761.322961866863;3791.464456894962;1133.1331531378503;1142.5372724046774;1147.248552198303;1153.0948205658601;1841.9631607367778;11667.066634669207;11915.285082895054;11922.821157682642;11968.640940771791;11972.760544789142;4336.82652693895;4570.040291538748;4645.605123564467;4646.95353046472;4650.720956742606;9311.301652376098;9315.301352398597;9329.207017403462;9330.95334523323;9351;5327.813526526553;5329.600279979017;5332.466753324714;5334.06653835585;5335.226392173113;4506.977465112719;4665.6967297125575;4846.248831431134;4965.478624744422;5015.448300686921;3776.811159442017;3804.752691075071;3881.378979363288;3922.156736301709;3922.195789936661;1158.5250047480492;1167.538822165257;1169.6491052684162;1178.5639313454076;1180.8819118088295;922.9123233292827;930.0656428966621;942.5193151492788;946.9242460603135;995.8854731705802;5825.359210486843;6096.237970253718;6139.079138129317;6179.84550386235;6252.749890004349;919.8804155459882;958.2525630008604;959.3332633819568;974.1768205866032;988.1699372527112;3234.7088762011062;3972.165845172546;3980.4626375439525;3986.621270979252;4166.291730405838;10788.51451684676;11080.224384293022;11188.328700278009;11190.216684831983;11221.887781122248;11093.5562577496;11131.332120072822;11139.443027848738;11140.442977851075;11162.107031437465;7992.640331185111;8300.709475168462;8383.203595658524;8491.108433614505;8600.612972416257;5991.850203744942;6017.969910150421;6040.75836966534;6192.783252586138;6296.811095667137;10238.948805255926;10288;10302.742431438974;10395.688129356131;10461.424621645883;8711.782205444915;10348.327358721659;10366.274360794672;10483.108935740547;10513.842292365467;6628.602283862983;7138.607376594337;7373.262673732584;7522.548647081193;7656.73201437947;8353.916460835313;8672.132786721277;8682.91317086821;8687.174718401742;8688.739337819876;6980.685869135799;7364.7790566280955;7589.544627322378;7701.961490192513;7857.489263197874;7491.513051651626;7498.32515073646;7534.35957943581;7539.0576177977755;7698.46110772263;7076.646167691491;7211;7215.062041934515;7220;7224.638768061681;4974.303597496426;5045.1146819675;5161.690298582097;5168.896622067462;5235.790568377222;4942.4316203637045;5004.2493625956395;5145.974270128625;5170.1727723564045;5208.140656791587 13:46:16 INFO - PROCESS | 2089 | |4;prototype.html;298.546209761163;300.24787906294745;304.9451098802215;311.4953774884687;313.0639388229194;4248.852809741372;5334.5732341412695;5353.483862584584;5419.241306217133;5424.593155513333;4969.975150124254;5056.659985103941;5192.948070519294;5236.476352364771;5341.30563026807;4085.7548547087194;4121.402396652498;4132.380142978563;4132.958670413303;4140.958590414102;4108.917821643566;4133.73130746502;4139.461869956916;4140.3168477201225;4143.316352801784;3938.645521903028;4086.4891888513935;4094.733842300241;4097.180563887219;4105.938410923838;4073.796310184479;4075.8369665213354;4106.260873042851;4120.114175452277;4125.278076336629;3130.4521708701113;3552.9111772205642;3560.9673194773745;3570.179558149059;3586.65500437336;4081.8367265309353;4557.635389168891;5207.6354655174155;5260.711590458163;5285.973570132163;4652.325412815123;4664;4693.601043911238;4716.245400735866;4743.715377077387;4876.244551961291;5641.435856414367;5662.292213473316;5684.232628595169;5722.713864306768;3294.9505757413417;3756.7558108722847;3940.6847452203756;3957.140144132282;3962.702797290186;5884.293884733816;5888.705564721789;5891.351951285398;5951.702414879239;5959.761609535613;3969.702272329587;3975.8012099394914;3981.3722942857576;3981.7013723970817;3993.8003099845473;3880.5925377835483;4043.433919251307;4073.429719839225;4077.4087757275624;4084.3873418986796;3811.2187001664593;4341.45731783527;4515.503294637587;4659.930101048487;4726.26742854858;5390.595705322038;5397.676139431646;5674.900286893793;5691.662459322056;5703.17303990919;1130.7964566377966;1220.853497580296;1278.4119305119564;1365.9180449173082;1382.3710211853584;680.9921316451679;869.2133619074748;926.2358554192817;941.6186444489992;950.12588418655;5306.495882891119;5307.4427185145005;5314.707691077027;5422.810201642924;5447.673139611636;4187.225363307798;4887.706737595756;5793.478586927113;5825.621334613236;5832.854178645568;5162.354705661793;5255.658382205144;5273.736313184326;5312.273511108828;5325.9733701332025;2512.4975004999073;2785.5459230553965;2901.7243361880587;2964.184849166453;3014.9849250753605;4914.926276105862;5646.8023619173955;5735.311762588516;5894.4064611570775;6071.908921366183;6055.333913269536;6063.636181829104;6071.453569178795;6077.9392206078255;6090.390960903963;5791.942080579141;6074.635521868614;6120.816375508742;6131.264248290145;6135.466133466633;4840.177169881199;5597.44025597437;5882.5293976482635;5910.7931222407005;5950.523958083257;4872.512748725099;5033.206570353343;5697.57268204878;5849.8537536560225;5859.853503662443;5870.618409803349;5894.970525147518;6068.9089663654195;6077.331493535619;6105.938940610715;3324.335132973367;3547.689557188029;3973.92052158961;4058.817353219053;4059.9391009134297;5533.944660553504;5856.707164641836;5868.882622347614;5897.734601943009;5913.852153696192;4478.664100192434;5623.88752224945;5663.943360566342;5684.857878553069;5735.275744021556;4192.895177620584;4655.511171327097;5641.2639869664;5683.516901063456;5719.8570035749435;5264.236685680478;5463.672179669233;5466.3713672928125;5551.444855514578;5573.470520300565;4751.976240118777;5104.269215969587;5164.715940623302;5297.125974214211;5778.8266352009505;5600.327960644586;5620.381758006698;5630.943690563042;5634.126710359901;5640.887182256414 13:46:16 INFO - PROCESS | 2089 | |5;yui.html;748.2293237964891;787.6691789448431;837.330135891287;853.232091117994;868.2836659755703;15780.921095394522;16595.50213493594;16717;17073.487795366127;17316;15436.922815385935;15580.376784928589;15582.987105838141;15590.766138507903;15668.608284792886;747.1109379838002;771.5524995502595;908.2461556907767;923.4320892651039;929.9491574520782;912.2382810353363;935.9625614975427;953.1993125774349;954.19370631816;955.4983633592385;998.3410948773811;1000.7398076500126;1001.2290536287055;1003.5032658833887;1004.0160642570286;988.3674448352988;990.1336330710628;992.2111921022804;995.7859060301997;996.795656890343;736.6095969136367;738.0774032459426;739.8483310921248;741.4772585327331;741.7885902517756;15621.921890390475;15666.451674191349;15666.451674191349;15691.843081569152;15692.450764223197;13453;13608.931955340258;13633.590992270249;13796.586102416944;13853.51512697061;11201.271917325348;13446.462141514328;13806.033577649569;13853.51512697061;13894;4600.447946246439;4618.9376443418205;4657.510961349078;4776.474587795375;4793.5685788279225;127245.72754272431;131289.6871031287;131892;133250;134084.9887251692;11105.777884442428;11348.319100853974;11399.088072954144;11425.771484570429;11442.771144577062;21823.01796419165;21886.671699924515;22004;22015.889920550293;22055.11779528801;7887.881681774778;8016.519008859371;8071.515709057476;8323.292520135736;8329.875051874227;4497.707649002804;4545.250033744462;4598.701084429501;4616.469106052847;4706.129366067288;3513.508108864761;3590.263995880838;3598;3621.5292012038267;3633.291508155937;603.5111559636708;644.8678021005683;651.7555916531301;659.488896105522;675.2167485716545;417.6888218277403;583.8336074218827;620.5066971757464;630.391672036487;657.9046038324416;9330.393524420891;9438.622455101719;9517.048295170427;9665.758356041155;9764.609415623296;602.6203491800138;633.3508154142041;636.3604577399684;638.9073584330339;641.7721708793405;4508.549145085531;4636.211843986531;4641.883952901205;4642.303654451792;4665.486796452387;103490;128990;131259.3437032828;137408;163365.18317408336;141468.29265853605;142226;143581.5641843589;143814;148382;101191.49404252932;115555.42222289003;119342.80657193491;120024.3998780018;123965;8573.806881243103;8889.73330800077;8939.240164586083;8951;9093.318001149808;66616.66691666511;66925.3307466919;68074;68079.65960170167;71156;95057;100849.48725769266;101888.98111019091;103036.84815759033;109207;11237.213395062266;11256.943715281699;11647.88352116468;11729;12044.819327710267;12060.396980150781;12671.17637353569;12712.427940742504;13035.739285214433;13343.599692009255;11821.349825759322;12072.275663460221;12293.56972505958;12353.938230308791;12481.375931203585;11242.269252498561;11582.015528680156;11715.824262636237;11905.880941190824;12574.622761317176;11647.417629118341;12177.147599667938;12331.876681233432;12333.075019373404;12481.750364992831;9778.608855645694;10205.59177632916;10286.742831429274;10422.843657344994;10555.155587552823;9164.266858651159;9778.511074446391;10363.32638378503;10383.428911409945;10432.321899076536 13:46:16 INFO - PROCESS | 2089 | __end_tp_report 13:46:16 INFO - PROCESS | 2089 | __start_cc_report 13:46:16 INFO - PROCESS | 2089 | _x_x_mozilla_cycle_collect,1313 13:46:16 INFO - PROCESS | 2089 | __end_cc_report 13:46:16 INFO - PROCESS | 2089 | __startTimestamp1479419176110__endTimestamp 13:46:16 INFO - PROCESS | 2089 | 13:46:16 INFO - PROCESS | 2089 | ------- Summary: start ------- 13:46:16 INFO - PROCESS | 2089 | Number of tests: 6 13:46:16 INFO - PROCESS | 2089 | 13:46:16 INFO - PROCESS | 2089 | [#0] dojo.html Cycles:165 Average:5858.01 Median:6057.88 stddev:635.41 (10.5%) stddev-sans-first:591.75 13:46:16 INFO - PROCESS | 2089 | Values: 2844.6 3441.1 3483.6 3503.9 3554.0 5777.3 5851.8 5858.4 5858.5 5888.0 5808.9 5837.4 5869.9 5882.0 5894.8 5311.6 5311.8 5395.6 5401.9 5403.1 5306.0 5309.9 5319.4 5415.0 5445.0 5336.9 5403.8 5431.3 5445.9 5457.2 5382.6 5451.8 5460.6 5461.6 5479.4 5328.7 5417.9 5430.3 5437.8 5461.4 5681.8 5717.3 5734.1 5743.8 5914.9 6267.8 6334.2 6348.1 6362.8 6365.6 6250.3 6281.6 6292.1 6297.8 6310.1 5766.2 5801.5 5815.9 5936.4 5951.7 6226.4 6262.2 6272.7 6342.8 6353.8 6193.2 6281.1 6297.4 6302.2 6319.8 6351.5 6352.8 6365.5 6371.0 6371.9 5811.8 5829.0 5845.5 6214.0 6326.7 6350.2 6358.3 6368.7 6387.4 6389.8 5006.0 5013.4 5022.6 5043.6 5074.0 4477.3 4493.2 4527.1 4541.1 4553.7 5909.1 5936.7 6019.6 6019.7 6100.6 6259.4 6285.8 6296.2 6300.2 6303.6 5978.8 5998.4 6037.8 6038.3 6044.5 5407.8 5458.9 5476.0 5477.1 5482.0 6455.6 6458.8 6464.9 6491.2 6496.4 5898.9 6101.3 6299.7 6301.7 6331.9 6083.9 6250.5 6329.7 6378.8 6471.0 6238.3 6297.9 6322.6 6327.3 6334.7 6161.7 6285.9 6288.9 6302.1 6307.9 6102.1 6144.6 6214.3 6263.7 6280.2 6160.4 6172.9 6209.7 6258.7 6296.7 5981.9 5998.1 6175.8 6180.6 6191.7 6053.5 6131.1 6290.3 6292.0 6306.4 6051.9 6057.9 6133.0 6136.2 6144.1 13:46:16 INFO - PROCESS | 2089 | 13:46:16 INFO - PROCESS | 2089 | [#1] ext.html Cycles:180 Average:75484.50 Median:216273.00 stddev:166133.64 (76.8%) stddev-sans-first:166504.24 13:46:16 INFO - PROCESS | 2089 | Values: 478.6 486.0 493.5 510.5 580.3 34574.7 43297.5 44026.9 44038.8 46551.0 45647.5 45892.5 46041.6 46080.6 46173.1 10087.0 10165.7 10286.9 10291.0 10292.4 7987.7 9646.2 10278.7 12538.5 12590.3 12495.8 12562.4 12587.6 12610.5 12637.7 12547.1 12568.1 12598.6 12602.0 12610.4 12394.4 12452.4 12461.6 12464.8 12472.8 43295.4 43477.8 43607.9 43641.7 43644.6 3457.2 4035.7 4171.2 4179.1 4210.5 31209.4 31475.0 31482.0 32966.3 33941.5 3329.2 3371.3 3568.5 3575.5 3576.7 390556.0 390709.0 390988.0 391269.3 392247.0 63901.0 64335.0 64368.4 64391.7 64402.7 67853.0 67971.0 68038.7 68086.0 68134.7 17847.7 18074.1 18076.8 18094.2 18102.3 12757.2 13042.9 14049.5 14096.8 14151.7 15376.2 18025.4 21618.6 21691.5 21912.0 8598.1 8618.2 8839.7 8869.0 8937.2 933.9 1039.8 1049.6 1106.9 1177.5 31458.8 31648.0 31700.7 31939.2 32107.8 1092.7 1139.8 1141.2 1146.5 1152.3 15455.5 16319.1 16375.8 16406.8 16747.3 779757.0 783505.0 784997.0 787704.0 788198.0 62958.7 63212.1 63228.1 63324.1 63364.7 1236.2 1316.6 1384.3 1460.3 1463.2 27031.0 31319.4 33484.0 33777.7 34015.3 52237.0 52830.5 52878.7 52966.0 53119.0 615447.0 617796.0 619725.0 622596.0 625974.0 37340.8 38146.0 40641.8 40757.0 44251.1 48739.3 50243.7 50457.7 50590.0 51092.5 40299.0 41255.4 45344.8 45837.0 46607.0 41999.4 46070.8 46292.0 46492.5 47380.8 44636.6 44771.3 45219.3 45709.6 46102.3 42821.0 43537.0 44270.0 45826.3 46685.5 27930.6 28742.7 28774.3 28774.6 28774.9 13:46:16 INFO - PROCESS | 2089 | 13:46:16 INFO - PROCESS | 2089 | [#2] jquery.html Cycles:180 Average:36507.36 Median:23140.27 stddev:107297.66 (463.7%) stddev-sans-first:107564.24 13:46:16 INFO - PROCESS | 2089 | Values: 311.9 371.8 375.0 379.1 406.0 19742.3 21426.7 21798.0 22625.9 22824.0 21125.0 21130.0 21863.8 22134.9 22403.7 6030.9 6089.0 6238.5 6297.2 6307.5 4420.6 4564.4 4579.5 5257.2 6257.5 4549.4 4590.5 4592.7 6973.5 7049.2 6759.9 6911.7 7000.2 7033.3 7037.3 6032.2 6081.1 6083.9 6095.4 6109.2 27757.0 28214.7 28284.4 28506.0 28724.4 2256.3 2263.7 2395.2 2470.3 2528.4 13104.7 15610.3 15968.8 16394.0 16426.8 1849.0 1869.4 1926.3 1926.8 1928.6 106029.0 111414.0 111570.0 111752.0 111837.4 9984.0 10101.9 10154.0 10302.5 10445.4 12694.5 12739.8 12746.9 12756.5 12770.8 8584.0 8952.9 8957.0 9018.9 9020.1 9494.5 9513.4 9528.1 9703.3 9713.6 5925.5 6014.5 6014.9 6023.5 6126.3 1512.4 1687.6 1723.3 1733.8 1734.5 951.3 982.1 985.0 1053.5 1133.6 22561.1 22754.8 22850.9 23116.8 23163.8 869.9 874.0 1007.9 1026.9 1050.2 11022.9 11977.6 12226.7 12250.3 12258.8 636304.0 639765.0 651707.0 653581.0 661449.0 89983.6 113236.0 118092.4 123877.0 126478.4 971.4 999.6 1019.4 1020.7 1022.7 20174.2 21319.4 21484.5 21523.9 21584.6 55991.7 56422.7 56900.0 57183.4 57666.0 71717.0 76783.6 78943.6 79915.2 82659.0 7907.0 8194.4 8204.2 8279.7 8383.5 13413.4 13448.6 13467.9 13532.8 13756.3 11596.5 11631.5 11650.8 11742.5 12041.6 9668.6 11572.5 11666.6 11698.7 11778.8 11532.4 11745.9 11770.8 11981.3 12177.3 6372.8 8104.4 8190.3 8244.3 8302.8 11389.5 11610.9 11655.5 11964.4 12206.6 13:46:16 INFO - PROCESS | 2089 | 13:46:16 INFO - PROCESS | 2089 | [#3] mootools.html Cycles:180 Average:5804.13 Median:5009.85 stddev:3248.02 (64.8%) stddev-sans-first:3241.59 13:46:16 INFO - PROCESS | 2089 | Values: 1576.8 1584.1 1820.1 1913.7 1958.0 8601.4 9131.0 9131.5 9134.9 9138.6 7669.3 8045.2 8304.4 8781.7 8896.0 2395.4 2424.7 2425.9 2431.6 2434.2 2383.5 2404.0 2428.8 2429.3 2429.5 2065.5 2392.5 2410.0 2417.4 2428.8 2361.2 2379.3 2388.6 2389.3 2409.6 2373.9 2383.9 2387.6 2390.5 2394.9 8944.6 9151.5 9152.7 9155.0 9165.4 5343.4 5505.0 5510.2 5511.1 5511.3 3604.4 3707.2 3716.8 3761.3 3791.5 1133.1 1142.5 1147.2 1153.1 1842.0 11667.1 11915.3 11922.8 11968.6 11972.8 4336.8 4570.0 4645.6 4647.0 4650.7 9311.3 9315.3 9329.2 9331.0 9351.0 5327.8 5329.6 5332.5 5334.1 5335.2 4507.0 4665.7 4846.2 4965.5 5015.4 3776.8 3804.8 3881.4 3922.2 3922.2 1158.5 1167.5 1169.6 1178.6 1180.9 922.9 930.1 942.5 946.9 995.9 5825.4 6096.2 6139.1 6179.8 6252.7 919.9 958.3 959.3 974.2 988.2 3234.7 3972.2 3980.5 3986.6 4166.3 10788.5 11080.2 11188.3 11190.2 11221.9 11093.6 11131.3 11139.4 11140.4 11162.1 7992.6 8300.7 8383.2 8491.1 8600.6 5991.9 6018.0 6040.8 6192.8 6296.8 10238.9 10288.0 10302.7 10395.7 10461.4 8711.8 10348.3 10366.3 10483.1 10513.8 6628.6 7138.6 7373.3 7522.5 7656.7 8353.9 8672.1 8682.9 8687.2 8688.7 6980.7 7364.8 7589.5 7702.0 7857.5 7491.5 7498.3 7534.4 7539.1 7698.5 7076.6 7211.0 7215.1 7220.0 7224.6 4974.3 5045.1 5161.7 5168.9 5235.8 4942.4 5004.2 5146.0 5170.2 5208.1 13:46:16 INFO - PROCESS | 2089 | 13:46:16 INFO - PROCESS | 2089 | [#4] prototype.html Cycles:180 Average:4600.84 Median:5222.06 stddev:1428.86 (27.4%) stddev-sans-first:1395.91 13:46:16 INFO - PROCESS | 2089 | Values: 298.5 300.2 304.9 311.5 313.1 4248.9 5334.6 5353.5 5419.2 5424.6 4970.0 5056.7 5192.9 5236.5 5341.3 4085.8 4121.4 4132.4 4133.0 4141.0 4108.9 4133.7 4139.5 4140.3 4143.3 3938.6 4086.5 4094.7 4097.2 4105.9 4073.8 4075.8 4106.3 4120.1 4125.3 3130.5 3552.9 3561.0 3570.2 3586.7 4081.8 4557.6 5207.6 5260.7 5286.0 4652.3 4664.0 4693.6 4716.2 4743.7 4876.2 5641.4 5662.3 5684.2 5722.7 3295.0 3756.8 3940.7 3957.1 3962.7 5884.3 5888.7 5891.4 5951.7 5959.8 3969.7 3975.8 3981.4 3981.7 3993.8 3880.6 4043.4 4073.4 4077.4 4084.4 3811.2 4341.5 4515.5 4659.9 4726.3 5390.6 5397.7 5674.9 5691.7 5703.2 1130.8 1220.9 1278.4 1365.9 1382.4 681.0 869.2 926.2 941.6 950.1 5306.5 5307.4 5314.7 5422.8 5447.7 4187.2 4887.7 5793.5 5825.6 5832.9 5162.4 5255.7 5273.7 5312.3 5326.0 2512.5 2785.5 2901.7 2964.2 3015.0 4914.9 5646.8 5735.3 5894.4 6071.9 6055.3 6063.6 6071.5 6077.9 6090.4 5791.9 6074.6 6120.8 6131.3 6135.5 4840.2 5597.4 5882.5 5910.8 5950.5 4872.5 5033.2 5697.6 5849.9 5859.9 5870.6 5895.0 6068.9 6077.3 6105.9 3324.3 3547.7 3973.9 4058.8 4059.9 5533.9 5856.7 5868.9 5897.7 5913.9 4478.7 5623.9 5663.9 5684.9 5735.3 4192.9 4655.5 5641.3 5683.5 5719.9 5264.2 5463.7 5466.4 5551.4 5573.5 4752.0 5104.3 5164.7 5297.1 5778.8 5600.3 5620.4 5630.9 5634.1 5640.9 13:46:16 INFO - PROCESS | 2089 | 13:46:16 INFO - PROCESS | 2089 | [#5] yui.html Cycles:180 Average:25966.02 Median:21854.84 stddev:42075.60 (192.5%) stddev-sans-first:42151.03 13:46:16 INFO - PROCESS | 2089 | Values: 748.2 787.7 837.3 853.2 868.3 15780.9 16595.5 16717.0 17073.5 17316.0 15436.9 15580.4 15583.0 15590.8 15668.6 747.1 771.6 908.2 923.4 929.9 912.2 936.0 953.2 954.2 955.5 998.3 1000.7 1001.2 1003.5 1004.0 988.4 990.1 992.2 995.8 996.8 736.6 738.1 739.8 741.5 741.8 15621.9 15666.5 15666.5 15691.8 15692.5 13453.0 13608.9 13633.6 13796.6 13853.5 11201.3 13446.5 13806.0 13853.5 13894.0 4600.4 4618.9 4657.5 4776.5 4793.6 127245.7 131289.7 131892.0 133250.0 134085.0 11105.8 11348.3 11399.1 11425.8 11442.8 21823.0 21886.7 22004.0 22015.9 22055.1 7887.9 8016.5 8071.5 8323.3 8329.9 4497.7 4545.3 4598.7 4616.5 4706.1 3513.5 3590.3 3598.0 3621.5 3633.3 603.5 644.9 651.8 659.5 675.2 417.7 583.8 620.5 630.4 657.9 9330.4 9438.6 9517.0 9665.8 9764.6 602.6 633.4 636.4 638.9 641.8 4508.5 4636.2 4641.9 4642.3 4665.5 103490.0 128990.0 131259.3 137408.0 163365.2 141468.3 142226.0 143581.6 143814.0 148382.0 101191.5 115555.4 119342.8 120024.4 123965.0 8573.8 8889.7 8939.2 8951.0 9093.3 66616.7 66925.3 68074.0 68079.7 71156.0 95057.0 100849.5 101889.0 103036.8 109207.0 11237.2 11256.9 11647.9 11729.0 12044.8 12060.4 12671.2 12712.4 13035.7 13343.6 11821.3 12072.3 12293.6 12353.9 12481.4 11242.3 11582.0 11715.8 11905.9 12574.6 11647.4 12177.1 12331.9 12333.1 12481.8 9778.6 10205.6 10286.7 10422.8 10555.2 9164.3 9778.5 10363.3 10383.4 10432.3 13:46:16 INFO - PROCESS | 2089 | -------- Summary: end -------- 13:46:16 INFO - PROCESS | 2089 | 13:46:16 INFO - TEST-INFO | 2089: exit 0 13:46:16 INFO - TEST-OK | dromaeo_css | took 1114950ms 13:46:16 INFO - TEST-START | kraken 13:46:16 INFO - operating with platform_type : mac_ 13:46:16 INFO - Initialising browser for kraken test... 13:46:16 INFO - TEST-INFO | started process 2206 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/63/97m36r0j7js9vzr9g5gsghq400000w/T/tmp47cPYD/profile http://localhost:54426/getInfo.html) 13:46:18 INFO - PROCESS | 2206 | __metrics Screen width/height:1600/1200 13:46:18 INFO - PROCESS | 2206 | colorDepth:24 13:46:18 INFO - PROCESS | 2206 | Browser inner width/height: 1024/689 13:46:18 INFO - PROCESS | 2206 | __metrics 13:46:18 INFO - PROCESS | 2206 | 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" 13:46:18 INFO - PROCESS | 2206 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 13:46:19 INFO - TEST-INFO | 2206: exit 0 13:46:19 INFO - Browser initialized. 13:46:19 INFO - Running cycle 1/1 for kraken test... 13:46:19 INFO - TEST-INFO | started process 2208 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/63/97m36r0j7js9vzr9g5gsghq400000w/T/tmp47cPYD/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:46:31 INFO - PROCESS | 2208 | RSS: Main: 187465728 13:46:31 INFO - PROCESS | 2208 | 13:46:34 INFO - PROCESS | 2208 | Cycle 1(1): loaded http://localhost:54426/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:54426/tests/kraken/driver.html?testName=audio-beat-detection) 13:46:35 INFO - PROCESS | 2208 | RSS: Main: 235008000 13:46:35 INFO - PROCESS | 2208 | 13:46:37 INFO - PROCESS | 2208 | Cycle 1(1): loaded http://localhost:54426/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:54426/tests/kraken/driver.html?testName=audio-dft) 13:46:38 INFO - PROCESS | 2208 | RSS: Main: 246779904 13:46:38 INFO - PROCESS | 2208 | 13:46:41 INFO - PROCESS | 2208 | Cycle 1(1): loaded http://localhost:54426/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:54426/tests/kraken/driver.html?testName=audio-fft) 13:46:42 INFO - PROCESS | 2208 | RSS: Main: 341094400 13:46:42 INFO - PROCESS | 2208 | 13:46:44 INFO - PROCESS | 2208 | Cycle 1(1): loaded http://localhost:54426/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:54426/tests/kraken/driver.html?testName=audio-oscillator) 13:46:44 INFO - PROCESS | 2208 | RSS: Main: 242085888 13:46:44 INFO - PROCESS | 2208 | 13:46:46 INFO - PROCESS | 2208 | Cycle 1(1): loaded http://localhost:54426/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:54426/tests/kraken/driver.html?testName=imaging-gaussian-blur) 13:46:47 INFO - PROCESS | 2208 | RSS: Main: 242933760 13:46:47 INFO - PROCESS | 2208 | 13:46:50 INFO - PROCESS | 2208 | Cycle 1(1): loaded http://localhost:54426/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:54426/tests/kraken/driver.html?testName=imaging-darkroom) 13:46:50 INFO - PROCESS | 2208 | RSS: Main: 281903104 13:46:50 INFO - PROCESS | 2208 | 13:46:53 INFO - PROCESS | 2208 | Cycle 1(1): loaded http://localhost:54426/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:54426/tests/kraken/driver.html?testName=imaging-desaturate) 13:46:54 INFO - PROCESS | 2208 | RSS: Main: 279019520 13:46:54 INFO - PROCESS | 2208 | 13:46:56 INFO - PROCESS | 2208 | Cycle 1(1): loaded http://localhost:54426/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:54426/tests/kraken/driver.html?testName=json-parse-financial) 13:46:57 INFO - PROCESS | 2208 | RSS: Main: 277893120 13:46:57 INFO - PROCESS | 2208 | 13:46:58 INFO - PROCESS | 2208 | Cycle 1(1): loaded http://localhost:54426/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:54426/tests/kraken/driver.html?testName=json-stringify-tinderbox) 13:46:59 INFO - PROCESS | 2208 | RSS: Main: 253829120 13:46:59 INFO - PROCESS | 2208 | 13:47:01 INFO - PROCESS | 2208 | Cycle 1(1): loaded http://localhost:54426/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:54426/tests/kraken/driver.html?testName=stanford-crypto-aes) 13:47:02 INFO - PROCESS | 2208 | RSS: Main: 259145728 13:47:02 INFO - PROCESS | 2208 | 13:47:04 INFO - PROCESS | 2208 | Cycle 1(1): loaded http://localhost:54426/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:54426/tests/kraken/driver.html?testName=stanford-crypto-ccm) 13:47:04 INFO - PROCESS | 2208 | RSS: Main: 270176256 13:47:04 INFO - PROCESS | 2208 | 13:47:07 INFO - PROCESS | 2208 | Cycle 1(1): loaded http://localhost:54426/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:54426/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 13:47:08 INFO - PROCESS | 2208 | RSS: Main: 280563712 13:47:08 INFO - PROCESS | 2208 | 13:47:11 INFO - PROCESS | 2208 | Cycle 1(1): loaded http://localhost:54426/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:54426/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 13:47:12 INFO - PROCESS | 2208 | RSS: Main: 274452480 13:47:12 INFO - PROCESS | 2208 | 13:47:13 INFO - PROCESS | 2208 | Cycle 1(1): loaded http://localhost:54426/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:54426/tests/kraken/driver.html?testName=ai-astar) 13:47:14 INFO - PROCESS | 2208 | RSS: Main: 317800448 13:47:14 INFO - PROCESS | 2208 | 13:47:14 INFO - PROCESS | 2208 | __start_tp_report 13:47:14 INFO - PROCESS | 2208 | _x_x_mozilla_page_load 13:47:14 INFO - PROCESS | 2208 | _x_x_mozilla_page_load_details 13:47:14 INFO - PROCESS | 2208 | |i|pagename|runs| 13:47:14 INFO - PROCESS | 2208 | |0;ai-astar;113;113;113;159;168;110;111;112;112;111 13:47:14 INFO - PROCESS | 2208 | |1;audio-beat-detection;145;105;109;142;107;106;108;106;138;127 13:47:14 INFO - PROCESS | 2208 | |2;audio-dft;179;181;180;185;182;182;182;190;183;182 13:47:14 INFO - PROCESS | 2208 | |3;audio-fft;82;56;59;92;85;83;67;57;83;58 13:47:14 INFO - PROCESS | 2208 | |4;audio-oscillator;87;72;95;69;67;69;92;67;68;115 13:47:14 INFO - PROCESS | 2208 | |5;imaging-gaussian-blur;94;90;94;88;95;86;94;91;89;85 13:47:14 INFO - PROCESS | 2208 | |6;imaging-darkroom;94;93;94;93;94;94;94;97;94;94 13:47:14 INFO - PROCESS | 2208 | |7;imaging-desaturate;84;84;83;84;86;85;84;83;83;84 13:47:14 INFO - PROCESS | 2208 | |8;json-parse-financial;54;52;50;51;56;57;55;55;55;57 13:47:14 INFO - PROCESS | 2208 | |9;json-stringify-tinderbox;62;70;68;70;75;70;67;91;102;88 13:47:14 INFO - PROCESS | 2208 | |10;stanford-crypto-aes;85;78;85;82;82;83;84;88;88;103 13:47:14 INFO - PROCESS | 2208 | |11;stanford-crypto-ccm;144;146;144;125;141;142;145;136;165;170 13:47:14 INFO - PROCESS | 2208 | |12;stanford-crypto-pbkdf2;161;160;160;159;159;160;157;205;221;159 13:47:14 INFO - PROCESS | 2208 | |13;stanford-crypto-sha256-iterative;65;65;66;77;84;71;57;76;79;83 13:47:14 INFO - PROCESS | 2208 | __end_tp_report 13:47:14 INFO - PROCESS | 2208 | __start_cc_report 13:47:14 INFO - PROCESS | 2208 | _x_x_mozilla_cycle_collect,1878 13:47:14 INFO - PROCESS | 2208 | __end_cc_report 13:47:14 INFO - PROCESS | 2208 | __startTimestamp1479419234076__endTimestamp 13:47:14 INFO - PROCESS | 2208 | 13:47:14 INFO - PROCESS | 2208 | ------- Summary: start ------- 13:47:14 INFO - PROCESS | 2208 | Number of tests: 14 13:47:14 INFO - PROCESS | 2208 | 13:47:14 INFO - PROCESS | 2208 | [#0] ai-astar Cycles:10 Average:122.20 Median:113.00 stddev:21.89 (19.4%) stddev-sans-first:22.97 13:47:14 INFO - PROCESS | 2208 | Values: 113.0 113.0 113.0 159.0 168.0 110.0 111.0 112.0 112.0 111.0 13:47:14 INFO - PROCESS | 2208 | 13:47:14 INFO - PROCESS | 2208 | [#1] audio-beat-detection Cycles:10 Average:119.30 Median:118.00 stddev:16.76 (14.2%) stddev-sans-first:14.98 13:47:14 INFO - PROCESS | 2208 | Values: 145.0 105.0 109.0 142.0 107.0 106.0 108.0 106.0 138.0 127.0 13:47:14 INFO - PROCESS | 2208 | 13:47:14 INFO - PROCESS | 2208 | [#2] audio-dft Cycles:10 Average:182.60 Median:182.00 stddev:3.06 (1.7%) stddev-sans-first:2.96 13:47:14 INFO - PROCESS | 2208 | Values: 179.0 181.0 180.0 185.0 182.0 182.0 182.0 190.0 183.0 182.0 13:47:14 INFO - PROCESS | 2208 | 13:47:14 INFO - PROCESS | 2208 | [#3] audio-fft Cycles:10 Average:72.20 Median:82.50 stddev:14.07 (17.1%) stddev-sans-first:14.47 13:47:14 INFO - PROCESS | 2208 | Values: 82.0 56.0 59.0 92.0 85.0 83.0 67.0 57.0 83.0 58.0 13:47:14 INFO - PROCESS | 2208 | 13:47:14 INFO - PROCESS | 2208 | [#4] audio-oscillator Cycles:10 Average:80.10 Median:70.50 stddev:16.43 (23.3%) stddev-sans-first:17.24 13:47:14 INFO - PROCESS | 2208 | Values: 87.0 72.0 95.0 69.0 67.0 69.0 92.0 67.0 68.0 115.0 13:47:14 INFO - PROCESS | 2208 | 13:47:14 INFO - PROCESS | 2208 | [#5] imaging-gaussian-blur Cycles:10 Average:90.60 Median:92.50 stddev:3.60 (3.9%) stddev-sans-first:3.60 13:47:14 INFO - PROCESS | 2208 | Values: 94.0 90.0 94.0 88.0 95.0 86.0 94.0 91.0 89.0 85.0 13:47:14 INFO - PROCESS | 2208 | 13:47:14 INFO - PROCESS | 2208 | [#6] imaging-darkroom Cycles:10 Average:94.10 Median:94.00 stddev:1.10 (1.2%) stddev-sans-first:1.17 13:47:14 INFO - PROCESS | 2208 | Values: 94.0 93.0 94.0 93.0 94.0 94.0 94.0 97.0 94.0 94.0 13:47:14 INFO - PROCESS | 2208 | 13:47:14 INFO - PROCESS | 2208 | [#7] imaging-desaturate Cycles:10 Average:84.00 Median:84.00 stddev:0.94 (1.1%) stddev-sans-first:1.00 13:47:14 INFO - PROCESS | 2208 | Values: 84.0 84.0 83.0 84.0 86.0 85.0 84.0 83.0 83.0 84.0 13:47:14 INFO - PROCESS | 2208 | 13:47:14 INFO - PROCESS | 2208 | [#8] json-parse-financial Cycles:10 Average:54.20 Median:55.00 stddev:2.44 (4.4%) stddev-sans-first:2.59 13:47:14 INFO - PROCESS | 2208 | Values: 54.0 52.0 50.0 51.0 56.0 57.0 55.0 55.0 55.0 57.0 13:47:14 INFO - PROCESS | 2208 | 13:47:14 INFO - PROCESS | 2208 | [#9] json-stringify-tinderbox Cycles:10 Average:76.30 Median:70.00 stddev:12.88 (18.4%) stddev-sans-first:12.58 13:47:14 INFO - PROCESS | 2208 | Values: 62.0 70.0 68.0 70.0 75.0 70.0 67.0 91.0 102.0 88.0 13:47:14 INFO - PROCESS | 2208 | 13:47:14 INFO - PROCESS | 2208 | [#10] stanford-crypto-aes Cycles:10 Average:85.80 Median:84.50 stddev:6.73 (8.0%) stddev-sans-first:7.13 13:47:14 INFO - PROCESS | 2208 | Values: 85.0 78.0 85.0 82.0 82.0 83.0 84.0 88.0 88.0 103.0 13:47:14 INFO - PROCESS | 2208 | 13:47:14 INFO - PROCESS | 2208 | [#11] stanford-crypto-ccm Cycles:10 Average:145.80 Median:144.50 stddev:13.03 (9.0%) stddev-sans-first:13.80 13:47:14 INFO - PROCESS | 2208 | Values: 144.0 146.0 144.0 125.0 141.0 142.0 145.0 136.0 165.0 170.0 13:47:14 INFO - PROCESS | 2208 | 13:47:14 INFO - PROCESS | 2208 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:170.10 Median:160.00 stddev:22.95 (14.3%) stddev-sans-first:24.10 13:47:14 INFO - PROCESS | 2208 | Values: 161.0 160.0 160.0 159.0 159.0 160.0 157.0 205.0 221.0 159.0 13:47:14 INFO - PROCESS | 2208 | 13:47:14 INFO - PROCESS | 2208 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:72.30 Median:76.50 stddev:8.91 (11.6%) stddev-sans-first:9.05 13:47:14 INFO - PROCESS | 2208 | Values: 65.0 65.0 66.0 77.0 84.0 71.0 57.0 76.0 79.0 83.0 13:47:14 INFO - PROCESS | 2208 | -------- Summary: end -------- 13:47:14 INFO - PROCESS | 2208 | 13:47:14 INFO - TEST-INFO | 2208: exit 0 13:47:14 INFO - TEST-OK | kraken | took 58169ms 13:47:14 INFO - SUITE-END | took 1173s 13:47:15 INFO - Completed test suite (00:19:33) 13:47:15 INFO - javascript benchmark 13:47:15 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2844.587534807453, 3441.088111650413, 3483.5993860706026, 3503.9299214015737, 3553.9644603553957, 5777.277840269966, 5851.79518716845, 5858.443447872456, 5858.472737453639, 5888.0, 5808.883822323551, 5837.357890632038, 5869.853253668661, 5882.000059989801, 5894.793682221123, 5311.62818602698, 5311.840644780644, 5395.649282796625, 5401.891962160755, 5403.054465468547, 5306.018386598473, 5309.946900531003, 5319.388270348921, 5414.972925135388, 5445.047116754572, 5336.946630533703, 5403.83788486346, 5431.321084864392, 5445.891082178354, 5457.181422786574, 5382.569394448455, 5451.836444906659, 5460.563154947595, 5461.563074953994, 5479.369872464677, 5328.733563321857, 5417.891642167135, 5430.294061771984, 5437.755301011464, 5461.371942226655, 5681.829545113612, 5717.285339332583, 5734.111212762028, 5743.798967036176, 5914.9112763308585, 6267.811965641038, 6334.239891213084, 6348.111264422984, 6362.840928976766, 6365.554411191219, 6250.281217659936, 6281.623102613858, 6292.087647291163, 6297.779577714804, 6310.116583678288, 5766.221560089376, 5801.53587712982, 5815.883682326415, 5936.376680448577, 5951.6726580038085, 6226.40849119333, 6262.15460912771, 6272.686365681698, 6342.778002769881, 6353.777617783356, 6193.163922870445, 6281.089242059876, 6297.4332310091395, 6302.180716506825, 6319.8104056878365, 6351.523635727246, 6352.809415717444, 6365.4589359904, 6371.044343348442, 6371.872562548723, 5811.796587119515, 5829.038208695602, 5845.503132233808, 6213.968930155411, 6326.652034138075, 6350.237971443364, 6358.332375100548, 6368.713407896656, 6387.361263873576, 6389.7763578274535, 5005.974970125126, 5013.373328333958, 5022.648414610942, 5043.571296439771, 5073.9746301269, 4477.283634618446, 4493.213687604656, 4527.094581083797, 4541.069080838421, 4553.681242313072, 5909.084091965752, 5936.673482958478, 6019.578629495981, 6019.69901504923, 6100.603460775035, 6259.374062593704, 6285.77999770015, 6296.150019747367, 6300.21247344082, 6303.558750887486, 5978.790742323998, 5998.3701711320555, 6037.758489660452, 6038.275406951194, 6044.546659000593, 5407.83776486706, 5458.863528411742, 5476.014317422902, 5477.068898287221, 5481.958427898687, 6455.580387274812, 6458.838529036718, 6464.868647986677, 6491.188601424822, 6496.415322620986, 5898.94101058984, 6101.267847858286, 6299.748010079546, 6301.6534090625455, 6331.90502142459, 6083.908741368971, 6250.531210159165, 6329.683515824098, 6378.840528986812, 6471.029345598198, 6238.344973777688, 6297.905531416941, 6322.620642761449, 6327.303996560467, 6334.683265836782, 6161.72272247741, 6285.874282514415, 6288.905666415099, 6302.054691796267, 6307.873842523032, 6102.084687296763, 6144.56988010835, 6214.2853571838, 6263.655498947602, 6280.214973128359, 6160.383961603804, 6172.907406388818, 6209.658468784261, 6258.687065646791, 6296.685165741603, 5981.910271346021, 5998.1002849572915, 6175.783847565313, 6180.5673602849165, 6191.721372538336, 6053.485453736482, 6131.101423540661, 6290.2766181889665, 6292.024736165901, 6306.432421082125, 6051.880402125445, 6057.878842423215, 6132.957397242569, 6136.202293701969, 6144.1398204250545], "value": 5816.898115959063, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [478.6481935777204, 485.9854204373868, 493.49663343389733, 510.4767613196471, 580.3384142078029, 34574.654253457455, 43297.48458803943, 44026.91811573191, 44038.779806101, 46551.0, 45647.543524564746, 45892.541074589244, 46041.61875143751, 46080.61758147253, 46173.07653846921, 10087.0, 10165.695029149138, 10286.897131028707, 10291.022352876502, 10292.433916134609, 7987.7204297849585, 9646.228301735844, 10278.743031424237, 12538.498460061586, 12590.307533085677, 12495.812897774696, 12562.37188140594, 12587.559435419762, 12610.495580176783, 12637.68405789858, 12547.058970577198, 12568.120231583793, 12598.622041338775, 12601.991840652772, 12610.369481525888, 12394.442250098768, 12452.377381130998, 12461.626151215478, 12464.81302780459, 12472.81290780639, 43295.35056974148, 43477.78261108706, 43607.9098022552, 43641.69074927757, 43644.563554364686, 3457.1529975155995, 4035.677145828356, 4171.20747058061, 4179.1223842993, 4210.51579068408, 31209.416993645722, 31475.0, 31482.0, 32966.3406731864, 33941.490877636854, 3329.234276116507, 3371.2751758371824, 3568.50040994261, 3575.481555174485, 3576.7138628909624, 390556.0, 390709.0, 390988.0, 391269.3492260335, 392247.0, 63901.0, 64335.03497447542, 64368.356316436235, 64391.67804161043, 64402.677986609764, 67853.0, 67971.0, 68038.65980670066, 68086.0, 68134.65932670305, 17847.73228401575, 18074.096295185187, 18076.819231807778, 18094.185761640496, 18102.275908963493, 12757.234565926074, 13042.869571304354, 14049.508267210598, 14096.788548171786, 14151.71696566063, 15376.15431151275, 18025.40734603696, 21618.56762864734, 21691.457713557287, 21912.013959371867, 8598.140185981352, 8618.224359807647, 8839.734807955772, 8869.0, 8937.150970657776, 933.8739270198572, 1039.8111974294154, 1049.6431213387484, 1106.9225154239125, 1177.4819079604947, 31458.842705786323, 31648.0, 31700.682993169772, 31939.201519962186, 32107.83946080255, 1092.6831218946415, 1139.7720455908852, 1141.223967701954, 1146.541383446628, 1152.2798251093068, 15455.459058932884, 16319.102449365399, 16375.754363684555, 16406.83593164077, 16747.33010679559, 779757.0, 783505.0, 784997.0, 787704.0, 788198.0, 62958.685206573675, 63212.05181922275, 63228.05157922635, 63324.05013924795, 63364.68317658382, 1236.2335352081766, 1316.6247619428416, 1384.2732565403041, 1460.2771628044186, 1463.1952426165353, 27031.0, 31319.373612527164, 33483.995480135636, 33777.66737051298, 34015.319693605496, 52237.0, 52830.471695282555, 52878.73560632172, 52966.0, 53119.0, 615447.0, 617796.0, 619725.0, 622596.0, 625974.0, 37340.81329593444, 38146.0, 40641.796791015855, 40757.0, 44251.11497770091, 48739.268910967075, 50243.74878125732, 50457.74771126268, 50590.0, 51092.48907511026, 40299.0, 41255.381169281885, 45344.773276133405, 45837.0, 46607.0, 41999.3700094505, 46070.76964615155, 46292.0, 46492.53507465017, 47380.763096184295, 44636.55363446324, 44771.32843007292, 45219.321710175034, 45709.62871113872, 46102.30846537372, 42821.0, 43537.0, 44270.0, 45826.312605311614, 46685.533144668116, 27930.58104128399, 28742.71257287484, 28774.280642984093, 28774.568381473877, 28774.856125719238], "value": 22243.348862354836, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [311.87680866057906, 371.83267529611663, 374.9718771092169, 379.0504785512291, 406.0235134501525, 19742.309019184333, 21426.678599820996, 21798.0, 22625.86870656469, 22824.0, 21125.0, 21130.0, 21863.78136218641, 22134.88932555335, 22403.663945040797, 6030.939690603103, 6088.969555152229, 6238.500919926418, 6297.181366422359, 6307.463865571432, 4420.58004489573, 4564.383808185886, 4579.450465944092, 5257.158854583267, 6257.530685198605, 4549.363089167519, 4590.540945905416, 4592.678512504126, 6973.476989225803, 7049.224585295639, 6759.93240067598, 6911.6544172791155, 7000.194977577567, 7033.261507541712, 7037.261087585806, 6032.185654936571, 6081.087836824468, 6083.939160608382, 6095.359987201325, 6109.236345456818, 27757.028504002465, 28214.717852821414, 28284.434311313864, 28506.0, 28724.425511489862, 2256.3047445706584, 2263.6830843681896, 2395.197608801054, 2470.28361775085, 2528.4311030018284, 13104.672383190402, 15610.29753661088, 15968.76046859298, 16394.016359018497, 16426.83573164265, 1848.9815101849078, 1869.4391682495198, 1926.258390519646, 1926.8169523895208, 1928.6142771445627, 106029.0, 111413.99999999919, 111570.0, 111752.0, 111837.44081279622, 9984.004798560403, 10101.898981010243, 10154.004568652264, 10302.484875756183, 10445.425501597334, 12694.49222031127, 12739.80890286628, 12746.872531274754, 12756.489740410465, 12770.80843787344, 8583.95584597844, 8952.910470895207, 8956.955215223883, 9018.909810901938, 9020.14308640678, 9494.477803720862, 9513.429194248367, 9528.142467177988, 9703.320767546204, 9713.61145554184, 5925.525957923356, 6014.458698717136, 6014.879702405928, 6023.518118550505, 6126.295476020315, 1512.3648067811546, 1687.6118492746737, 1723.327902118175, 1733.8266173382813, 1734.540346808097, 951.2532661860545, 982.1013772398319, 984.9556769945369, 1053.4522048534873, 1133.6032388663903, 22561.097556097902, 22754.772452275596, 22850.885745571166, 23116.76883231146, 23163.7683623165, 869.891263592051, 873.9606717697719, 1007.9193664506822, 1026.9024442677933, 1050.175612144463, 11022.944885275523, 11977.580784672495, 12226.694332641755, 12250.326232057323, 12258.81611775824, 636304.0, 639765.0, 651707.0, 653581.0, 661449.0, 89983.55008224917, 113236.0, 118092.40953795348, 123877.0, 126478.36760816321, 971.4074414607084, 999.5651891427398, 1019.3985548526405, 1020.698893826323, 1022.6931920423843, 20174.193032278545, 21319.360419187447, 21484.462888427915, 21523.92380381006, 21584.568308634054, 55991.72004139953, 56422.717886410304, 56900.0, 57183.42816571781, 57666.0, 71717.0, 76783.61608191923, 78943.60528197323, 79915.20084799078, 82659.0, 7907.0, 8194.38542109356, 8204.220599043081, 8279.710210142615, 8383.538905360263, 13413.396397161956, 13448.596542103753, 13467.922566194486, 13532.797008045085, 13756.312184390541, 11596.47815848272, 11631.53473861036, 11650.76698466009, 11742.471588778355, 12041.638750837488, 9668.613255469703, 11572.537098515964, 11666.591669291534, 11698.70753231176, 11778.76442471163, 11532.423378831192, 11745.88254117482, 11770.823437648613, 11981.341026243292, 12177.33024683651, 6372.808815735535, 8104.351651867954, 8190.262876341158, 8244.340452763885, 8302.792430189294, 11389.487473063566, 11610.941945290557, 11655.53377864876, 11964.42764805571, 12206.63380098563], "value": 9986.058300195735, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1576.8423157684233, 1584.1208129488134, 1820.1445320699268, 1913.732077509148, 1957.9804201957977, 8601.354898382622, 9130.954345228272, 9131.543422828865, 9134.862977055349, 9138.588763505642, 7669.309762121408, 8045.1552586978405, 8304.377171712116, 8781.736547903558, 8895.95552022239, 2395.4370722880153, 2424.684790977179, 2425.866577338246, 2431.5623187826186, 2434.2453839309783, 2383.5232953409386, 2404.0263693204192, 2428.8178386620984, 2429.259075981825, 2429.514097180562, 2065.5455799724036, 2392.473655795722, 2409.975900240993, 2417.3714834143075, 2428.781409673129, 2361.1617875654238, 2379.3456799380224, 2388.593939030369, 2389.2593296078185, 2409.6024156014237, 2373.905043798246, 2383.892724827387, 2387.5583017141885, 2390.53384590005, 2394.880255987211, 8944.59749311276, 9151.542422878829, 9152.679656212067, 9155.0, 9165.358424910259, 5343.412224655285, 5505.009098362293, 5510.201020851994, 5511.145772405283, 5511.338639363262, 3604.3872541667715, 3707.2029513654425, 3716.776993380379, 3761.322961866863, 3791.464456894962, 1133.1331531378503, 1142.5372724046774, 1147.248552198303, 1153.0948205658601, 1841.9631607367778, 11667.066634669207, 11915.285082895054, 11922.821157682642, 11968.640940771791, 11972.760544789142, 4336.82652693895, 4570.040291538748, 4645.605123564467, 4646.95353046472, 4650.720956742606, 9311.301652376098, 9315.301352398597, 9329.207017403462, 9330.95334523323, 9351.0, 5327.813526526553, 5329.600279979017, 5332.466753324714, 5334.06653835585, 5335.226392173113, 4506.977465112719, 4665.6967297125575, 4846.248831431134, 4965.478624744422, 5015.448300686921, 3776.811159442017, 3804.752691075071, 3881.378979363288, 3922.156736301709, 3922.195789936661, 1158.5250047480492, 1167.538822165257, 1169.6491052684162, 1178.5639313454076, 1180.8819118088295, 922.9123233292827, 930.0656428966621, 942.5193151492788, 946.9242460603135, 995.8854731705802, 5825.359210486843, 6096.237970253718, 6139.079138129317, 6179.84550386235, 6252.749890004349, 919.8804155459882, 958.2525630008604, 959.3332633819568, 974.1768205866032, 988.1699372527112, 3234.7088762011062, 3972.165845172546, 3980.4626375439525, 3986.621270979252, 4166.291730405838, 10788.51451684676, 11080.224384293022, 11188.328700278009, 11190.216684831983, 11221.887781122248, 11093.5562577496, 11131.332120072822, 11139.443027848738, 11140.442977851075, 11162.107031437465, 7992.640331185111, 8300.709475168462, 8383.203595658524, 8491.108433614505, 8600.612972416257, 5991.850203744942, 6017.969910150421, 6040.75836966534, 6192.783252586138, 6296.811095667137, 10238.948805255926, 10288.0, 10302.742431438974, 10395.688129356131, 10461.424621645883, 8711.782205444915, 10348.327358721659, 10366.274360794672, 10483.108935740547, 10513.842292365467, 6628.602283862983, 7138.607376594337, 7373.262673732584, 7522.548647081193, 7656.73201437947, 8353.916460835313, 8672.132786721277, 8682.91317086821, 8687.174718401742, 8688.739337819876, 6980.685869135799, 7364.7790566280955, 7589.544627322378, 7701.961490192513, 7857.489263197874, 7491.513051651626, 7498.32515073646, 7534.35957943581, 7539.0576177977755, 7698.46110772263, 7076.646167691491, 7211.0, 7215.062041934515, 7220.0, 7224.638768061681, 4974.303597496426, 5045.1146819675, 5161.690298582097, 5168.896622067462, 5235.790568377222, 4942.4316203637045, 5004.2493625956395, 5145.974270128625, 5170.1727723564045, 5208.140656791587], "value": 4681.769316873361, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [298.546209761163, 300.24787906294745, 304.9451098802215, 311.4953774884687, 313.0639388229194, 4248.852809741372, 5334.5732341412695, 5353.483862584584, 5419.241306217133, 5424.593155513333, 4969.975150124254, 5056.659985103941, 5192.948070519294, 5236.476352364771, 5341.30563026807, 4085.7548547087194, 4121.402396652498, 4132.380142978563, 4132.958670413303, 4140.958590414102, 4108.917821643566, 4133.73130746502, 4139.461869956916, 4140.3168477201225, 4143.316352801784, 3938.645521903028, 4086.4891888513935, 4094.733842300241, 4097.180563887219, 4105.938410923838, 4073.796310184479, 4075.8369665213354, 4106.260873042851, 4120.114175452277, 4125.278076336629, 3130.4521708701113, 3552.9111772205642, 3560.9673194773745, 3570.179558149059, 3586.65500437336, 4081.8367265309353, 4557.635389168891, 5207.6354655174155, 5260.711590458163, 5285.973570132163, 4652.325412815123, 4664.0, 4693.601043911238, 4716.245400735866, 4743.715377077387, 4876.244551961291, 5641.435856414367, 5662.292213473316, 5684.232628595169, 5722.713864306768, 3294.9505757413417, 3756.7558108722847, 3940.6847452203756, 3957.140144132282, 3962.702797290186, 5884.293884733816, 5888.705564721789, 5891.351951285398, 5951.702414879239, 5959.761609535613, 3969.702272329587, 3975.8012099394914, 3981.3722942857576, 3981.7013723970817, 3993.8003099845473, 3880.5925377835483, 4043.433919251307, 4073.429719839225, 4077.4087757275624, 4084.3873418986796, 3811.2187001664593, 4341.45731783527, 4515.503294637587, 4659.930101048487, 4726.26742854858, 5390.595705322038, 5397.676139431646, 5674.900286893793, 5691.662459322056, 5703.17303990919, 1130.7964566377966, 1220.853497580296, 1278.4119305119564, 1365.9180449173082, 1382.3710211853584, 680.9921316451679, 869.2133619074748, 926.2358554192817, 941.6186444489992, 950.12588418655, 5306.495882891119, 5307.4427185145005, 5314.707691077027, 5422.810201642924, 5447.673139611636, 4187.225363307798, 4887.706737595756, 5793.478586927113, 5825.621334613236, 5832.854178645568, 5162.354705661793, 5255.658382205144, 5273.736313184326, 5312.273511108828, 5325.9733701332025, 2512.4975004999073, 2785.5459230553965, 2901.7243361880587, 2964.184849166453, 3014.9849250753605, 4914.926276105862, 5646.8023619173955, 5735.311762588516, 5894.4064611570775, 6071.908921366183, 6055.333913269536, 6063.636181829104, 6071.453569178795, 6077.9392206078255, 6090.390960903963, 5791.942080579141, 6074.635521868614, 6120.816375508742, 6131.264248290145, 6135.466133466633, 4840.177169881199, 5597.44025597437, 5882.5293976482635, 5910.7931222407005, 5950.523958083257, 4872.512748725099, 5033.206570353343, 5697.57268204878, 5849.8537536560225, 5859.853503662443, 5870.618409803349, 5894.970525147518, 6068.9089663654195, 6077.331493535619, 6105.938940610715, 3324.335132973367, 3547.689557188029, 3973.92052158961, 4058.817353219053, 4059.9391009134297, 5533.944660553504, 5856.707164641836, 5868.882622347614, 5897.734601943009, 5913.852153696192, 4478.664100192434, 5623.88752224945, 5663.943360566342, 5684.857878553069, 5735.275744021556, 4192.895177620584, 4655.511171327097, 5641.2639869664, 5683.516901063456, 5719.8570035749435, 5264.236685680478, 5463.672179669233, 5466.3713672928125, 5551.444855514578, 5573.470520300565, 4751.976240118777, 5104.269215969587, 5164.715940623302, 5297.125974214211, 5778.8266352009505, 5600.327960644586, 5620.381758006698, 5630.943690563042, 5634.126710359901, 5640.887182256414], "value": 4139.842848764027, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [748.2293237964891, 787.6691789448431, 837.330135891287, 853.232091117994, 868.2836659755703, 15780.921095394522, 16595.50213493594, 16717.0, 17073.487795366127, 17316.0, 15436.922815385935, 15580.376784928589, 15582.987105838141, 15590.766138507903, 15668.608284792886, 747.1109379838002, 771.5524995502595, 908.2461556907767, 923.4320892651039, 929.9491574520782, 912.2382810353363, 935.9625614975427, 953.1993125774349, 954.19370631816, 955.4983633592385, 998.3410948773811, 1000.7398076500126, 1001.2290536287055, 1003.5032658833887, 1004.0160642570286, 988.3674448352988, 990.1336330710628, 992.2111921022804, 995.7859060301997, 996.795656890343, 736.6095969136367, 738.0774032459426, 739.8483310921248, 741.4772585327331, 741.7885902517756, 15621.921890390475, 15666.451674191349, 15666.451674191349, 15691.843081569152, 15692.450764223197, 13453.0, 13608.931955340258, 13633.590992270249, 13796.586102416944, 13853.51512697061, 11201.271917325348, 13446.462141514328, 13806.033577649569, 13853.51512697061, 13894.0, 4600.447946246439, 4618.9376443418205, 4657.510961349078, 4776.474587795375, 4793.5685788279225, 127245.72754272431, 131289.6871031287, 131892.0, 133250.0, 134084.9887251692, 11105.777884442428, 11348.319100853974, 11399.088072954144, 11425.771484570429, 11442.771144577062, 21823.01796419165, 21886.671699924515, 22004.0, 22015.889920550293, 22055.11779528801, 7887.881681774778, 8016.519008859371, 8071.515709057476, 8323.292520135736, 8329.875051874227, 4497.707649002804, 4545.250033744462, 4598.701084429501, 4616.469106052847, 4706.129366067288, 3513.508108864761, 3590.263995880838, 3598.0, 3621.5292012038267, 3633.291508155937, 603.5111559636708, 644.8678021005683, 651.7555916531301, 659.488896105522, 675.2167485716545, 417.6888218277403, 583.8336074218827, 620.5066971757464, 630.391672036487, 657.9046038324416, 9330.393524420891, 9438.622455101719, 9517.048295170427, 9665.758356041155, 9764.609415623296, 602.6203491800138, 633.3508154142041, 636.3604577399684, 638.9073584330339, 641.7721708793405, 4508.549145085531, 4636.211843986531, 4641.883952901205, 4642.303654451792, 4665.486796452387, 103490.0, 128990.0, 131259.3437032828, 137408.0, 163365.18317408336, 141468.29265853605, 142226.0, 143581.5641843589, 143814.0, 148382.0, 101191.49404252932, 115555.42222289003, 119342.80657193491, 120024.3998780018, 123965.0, 8573.806881243103, 8889.73330800077, 8939.240164586083, 8951.0, 9093.318001149808, 66616.66691666511, 66925.3307466919, 68074.0, 68079.65960170167, 71156.0, 95057.0, 100849.48725769266, 101888.98111019091, 103036.84815759033, 109207.0, 11237.213395062266, 11256.943715281699, 11647.88352116468, 11729.0, 12044.819327710267, 12060.396980150781, 12671.17637353569, 12712.427940742504, 13035.739285214433, 13343.599692009255, 11821.349825759322, 12072.275663460221, 12293.56972505958, 12353.938230308791, 12481.375931203585, 11242.269252498561, 11582.015528680156, 11715.824262636237, 11905.880941190824, 12574.622761317176, 11647.417629118341, 12177.147599667938, 12331.876681233432, 12333.075019373404, 12481.750364992831, 9778.608855645694, 10205.59177632916, 10286.742831429274, 10422.843657344994, 10555.155587552823, 9164.266858651159, 9778.511074446391, 10363.32638378503, 10383.428911409945, 10432.321899076536], "value": 7971.403209329368, "unit": "score"}], "name": "dromaeo_css", "value": 7644.995305653826, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 113.0, 113.0, 159.0, 168.0, 110.0, 111.0, 112.0, 112.0, 111.0], "value": 122.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 105.0, 109.0, 142.0, 107.0, 106.0, 108.0, 106.0, 138.0, 127.0], "value": 119.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [179.0, 181.0, 180.0, 185.0, 182.0, 182.0, 182.0, 190.0, 183.0, 182.0], "value": 182.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 56.0, 59.0, 92.0, 85.0, 83.0, 67.0, 57.0, 83.0, 58.0], "value": 72.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 72.0, 95.0, 69.0, 67.0, 69.0, 92.0, 67.0, 68.0, 115.0], "value": 80.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 90.0, 94.0, 88.0, 95.0, 86.0, 94.0, 91.0, 89.0, 85.0], "value": 90.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 93.0, 94.0, 93.0, 94.0, 94.0, 94.0, 97.0, 94.0, 94.0], "value": 94.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 83.0, 84.0, 86.0, 85.0, 84.0, 83.0, 83.0, 84.0], "value": 84.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 52.0, 50.0, 51.0, 56.0, 57.0, 55.0, 55.0, 55.0, 57.0], "value": 54.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 70.0, 68.0, 70.0, 75.0, 70.0, 67.0, 91.0, 102.0, 88.0], "value": 76.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 78.0, 85.0, 82.0, 82.0, 83.0, 84.0, 88.0, 88.0, 103.0], "value": 85.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 146.0, 144.0, 125.0, 141.0, 142.0, 145.0, 136.0, 165.0, 170.0], "value": 145.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 160.0, 160.0, 159.0, 159.0, 160.0, 157.0, 205.0, 221.0, 159.0], "value": 170.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 66.0, 77.0, 84.0, 71.0, 57.0, 76.0, 79.0, 83.0], "value": 72.3, "unit": "score"}], "name": "kraken", "value": 1449.6, "alertThreshold": 2.0}]} 13:47:15 INFO - Return code: 0 13:47:15 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 13:47:15 INFO - # TBPL SUCCESS # 13:47:15 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 13:47:15 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 13:47:15 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 13:47:15 INFO - 2016-11-17 13:47:15.329 screenresolution[2217:19992] starting screenresolution argv=screenresolution get 13:47:15 INFO - 2016-11-17 13:47:15.332 screenresolution[2217:19992] Display 0: 1600x1200x32@60 13:47:15 INFO - 2016-11-17 13:47:15.338 screenresolution[2218:19995] starting screenresolution argv=screenresolution list 13:47:15 INFO - Available Modes on Display 0 13:47:15 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 13:47:15 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 13:47:15 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 13:47:15 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 13:47:15 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 13:47:15 INFO - Intel Iris: 13:47:15 INFO - Chipset Model: Intel Iris 13:47:15 INFO - Type: GPU 13:47:15 INFO - Bus: Built-In 13:47:15 INFO - VRAM (Dynamic, Max): 1536 MB 13:47:15 INFO - Vendor: Intel (0x8086) 13:47:15 INFO - Device ID: 0x0a2e 13:47:15 INFO - Revision ID: 0x0009 13:47:15 INFO - Displays: 13:47:15 INFO - Display: 13:47:15 INFO - Resolution: 1600 x 1200 @ 60 Hz 13:47:15 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 13:47:15 INFO - Display Serial Number: 1600x1200 60 13:47:15 INFO - Main Display: Yes 13:47:15 INFO - Mirror: Off 13:47:15 INFO - Online: Yes 13:47:15 INFO - Rotation: Supported 13:47:15 INFO - Return code: 0 13:47:15 INFO - Running post-action listener: _resource_record_post_action 13:47:15 INFO - [mozharness: 2016-11-17 21:47:15.573158Z] Finished run-tests step (success) 13:47:15 INFO - Running post-run listener: _resource_record_post_run 13:47:15 INFO - Total resource usage - Wall time: 1195s; CPU: 53.0%; Read bytes: 2445312; Write bytes: 496400896; Read time: 16; Write time: 1574 13:47:15 INFO - TinderboxPrint: CPU usage
53.5% 13:47:15 INFO - TinderboxPrint: I/O read bytes / time
2,445,312 / 16 13:47:15 INFO - TinderboxPrint: I/O write bytes / time
496,400,896 / 1,574 13:47:15 INFO - TinderboxPrint: CPU idle
2,225.3 (46.5%) 13:47:15 INFO - TinderboxPrint: CPU system
963.8 (20.2%) 13:47:15 INFO - TinderboxPrint: CPU user
1,592.5 (33.3%) 13:47:15 INFO - TinderboxPrint: Swap in / out
197,746,688 / 0 13:47:15 INFO - install - Wall time: 22s; CPU: 54.0%; Read bytes: 183278080; Write bytes: 175828992; Read time: 16689; Write time: 371 13:47:15 INFO - run-tests - Wall time: 1174s; CPU: 53.0%; Read bytes: 2445312; Write bytes: 297751552; Read time: 16; Write time: 1136 13:47:16 INFO - Running post-run listener: _upload_blobber_files 13:47:16 INFO - Blob upload gear active. 13:47:16 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 13:47:16 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 13:47:16 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'] 13:47:16 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 13:47:16 INFO - (blobuploader) - INFO - Open directory for files ... 13:47:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 13:47:16 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:47:16 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:47:17 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 13:47:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:47:17 INFO - (blobuploader) - INFO - Done attempting. 13:47:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 13:47:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:47:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:47:18 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 13:47:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:47:18 INFO - (blobuploader) - INFO - Done attempting. 13:47:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 13:47:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:47:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:47:20 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 13:47:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:47:20 INFO - (blobuploader) - INFO - Done attempting. 13:47:20 INFO - (blobuploader) - INFO - Iteration through files over. 13:47:20 INFO - Return code: 0 13:47:20 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 13:47:20 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 13:47:20 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/b378f1a6e2d39f352f365dfd17ec0db5a6973e54587b4e0c517e0bb34cc1cba97572a90c6e1b7649574df7205f195d9c86dc47e02d12c23504dc73187c2a13ae", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/08dcbb6202fa2e2de46bc6b45eb686c10f4a6c98ad95046c12f05b9f6b9c41e70ffd665a2f29b40d55d9104acb575cee17defd86d63dc559f50cd777b97ac6c3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/818bc7e0a2a3f619ba32cb247195010ee752a58d46b6462351d58fb932a78a095e8fbda1836e4ef07b128a7d418ade62786a3e46edd3040b82a5578dec4ac1c2"} 13:47:20 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 13:47:20 INFO - Writing to file /builds/slave/test/properties/blobber_files 13:47:20 INFO - Contents: 13:47:20 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/b378f1a6e2d39f352f365dfd17ec0db5a6973e54587b4e0c517e0bb34cc1cba97572a90c6e1b7649574df7205f195d9c86dc47e02d12c23504dc73187c2a13ae", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/08dcbb6202fa2e2de46bc6b45eb686c10f4a6c98ad95046c12f05b9f6b9c41e70ffd665a2f29b40d55d9104acb575cee17defd86d63dc559f50cd777b97ac6c3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/818bc7e0a2a3f619ba32cb247195010ee752a58d46b6462351d58fb932a78a095e8fbda1836e4ef07b128a7d418ade62786a3e46edd3040b82a5578dec4ac1c2"} 13:47:20 INFO - Running post-run listener: copy_logs_to_upload_dir 13:47:20 INFO - Copying logs to upload dir... 13:47:20 INFO - mkdir: /builds/slave/test/build/upload/logs 13:47:20 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1253.833049 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 20 mins, 53 secs) (at 2016-11-17 13:47:20.771587) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-17 13:47:20.775506) ========= 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.RhRrF4ntBj/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.2dEkvsOkUX/Listeners TMPDIR=/var/folders/63/97m36r0j7js9vzr9g5gsghq400000w/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/b378f1a6e2d39f352f365dfd17ec0db5a6973e54587b4e0c517e0bb34cc1cba97572a90c6e1b7649574df7205f195d9c86dc47e02d12c23504dc73187c2a13ae", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/08dcbb6202fa2e2de46bc6b45eb686c10f4a6c98ad95046c12f05b9f6b9c41e70ffd665a2f29b40d55d9104acb575cee17defd86d63dc559f50cd777b97ac6c3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/818bc7e0a2a3f619ba32cb247195010ee752a58d46b6462351d58fb932a78a095e8fbda1836e4ef07b128a7d418ade62786a3e46edd3040b82a5578dec4ac1c2"} build_url:https://queue.taskcluster.net/v1/task/aIv3f7hCSkqntywFtt1cMQ/artifacts/public/build/firefox-51.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010951 build_url: 'https://queue.taskcluster.net/v1/task/aIv3f7hCSkqntywFtt1cMQ/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/b378f1a6e2d39f352f365dfd17ec0db5a6973e54587b4e0c517e0bb34cc1cba97572a90c6e1b7649574df7205f195d9c86dc47e02d12c23504dc73187c2a13ae", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/08dcbb6202fa2e2de46bc6b45eb686c10f4a6c98ad95046c12f05b9f6b9c41e70ffd665a2f29b40d55d9104acb575cee17defd86d63dc559f50cd777b97ac6c3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/818bc7e0a2a3f619ba32cb247195010ee752a58d46b6462351d58fb932a78a095e8fbda1836e4ef07b128a7d418ade62786a3e46edd3040b82a5578dec4ac1c2"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-17 13:47:20.809280) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-17 13:47:20.809660) ========= 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.RhRrF4ntBj/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.2dEkvsOkUX/Listeners TMPDIR=/var/folders/63/97m36r0j7js9vzr9g5gsghq400000w/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.005133 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-17 13:47:20.859385) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-17 13:47:20.859753) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-17 13:47:20.860173) ========= ========= Total master_lag: 0.18 =========