builder: mozilla-beta_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0028 starttime: 1479671577.38 results: success (0) buildid: 20161120103921 builduid: db7b2984eb874a7fbc8baa26accdaadd revision: 52b63dfdef59f12010e68534021a8a7a2dfbfde6 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-11-20 11:52:57.377425) ========= master: http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-11-20 11:52:57.378286) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-20 11:52:57.378901) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-20 11:52:57.464941) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-20 11:52:57.465256) ========= 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.VORdO4OMjB/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.ykaxYB9CbF/Listeners TMPDIR=/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/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-20 11:52:57-- 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% 15.5M=0.001s 2016-11-20 11:52:58 (15.5 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.516262 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-20 11:52:58.007923) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-20 11:52:58.011319) ========= 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.VORdO4OMjB/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.ykaxYB9CbF/Listeners TMPDIR=/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/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.025975 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-20 11:52:58.059932) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-20 11:52:58.063363) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 52b63dfdef59f12010e68534021a8a7a2dfbfde6 --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 52b63dfdef59f12010e68534021a8a7a2dfbfde6 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.VORdO4OMjB/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.ykaxYB9CbF/Listeners TMPDIR=/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/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-20 11:52:58,171 truncating revision to first 12 chars 2016-11-20 11:52:58,171 Setting DEBUG logging. 2016-11-20 11:52:58,171 attempt 1/10 2016-11-20 11:52:58,171 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/52b63dfdef59?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-11-20 11:52:59,168 unpacking tar archive at: mozilla-beta-52b63dfdef59/testing/mozharness/ program finished with exit code 0 elapsedTime=1.275218 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-20 11:52:59.364318) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-20 11:52:59.364901) ========= script_repo_revision: 52b63dfdef59f12010e68534021a8a7a2dfbfde6 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-20 11:52:59.365331) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-20 11:52:59.365639) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-20 11:52:59.384376) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 20 mins, 56 secs) (at 2016-11-20 11:52:59.384785) ========= /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.VORdO4OMjB/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.ykaxYB9CbF/Listeners TMPDIR=/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/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 11:52:59 INFO - MultiFileLogger online at 20161120 11:52:59 in /builds/slave/test 11:52:59 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 11:52:59 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:52:59 INFO - {'append_to_log': False, 11:52:59 INFO - 'base_work_dir': '/builds/slave/test', 11:52:59 INFO - 'blob_upload_branch': 'Mozilla-Beta', 11:52:59 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:52:59 INFO - 'branch': 'Mozilla-Beta', 11:52:59 INFO - 'buildbot_json_path': 'buildprops.json', 11:52:59 INFO - 'config_files': ('talos/mac_config.py',), 11:52:59 INFO - 'default_actions': ('clobber', 11:52:59 INFO - 'read-buildbot-config', 11:52:59 INFO - 'download-and-extract', 11:52:59 INFO - 'populate-webroot', 11:52:59 INFO - 'create-virtualenv', 11:52:59 INFO - 'install', 11:52:59 INFO - 'run-tests'), 11:52:59 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:52:59 INFO - 'download_minidump_stackwalk': True, 11:52:59 INFO - 'download_symbols': 'ondemand', 11:52:59 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:52:59 INFO - 'tooltool.py': '/tools/tooltool.py', 11:52:59 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:52:59 INFO - '/tools/misc-python/virtualenv.py')}, 11:52:59 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:52:59 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:52:59 INFO - 'installer_path': 'installer.exe', 11:52:59 INFO - 'log_level': 'info', 11:52:59 INFO - 'log_name': 'talos', 11:52:59 INFO - 'log_to_console': True, 11:52:59 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 11:52:59 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 11:52:59 INFO - 'opt_config_files': (), 11:52:59 INFO - 'pip_index': False, 11:52:59 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 11:52:59 INFO - 'cmd': ('bash', 11:52:59 INFO - '-c', 11:52:59 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 11:52:59 INFO - 'enabled': True, 11:52:59 INFO - 'halt_on_failure': False, 11:52:59 INFO - 'name': 'check_screen_resolution'},), 11:52:59 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 11:52:59 INFO - 'cmd': ('bash', 11:52:59 INFO - '-c', 11:52:59 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 11:52:59 INFO - 'enabled': True, 11:52:59 INFO - 'halt_on_failure': False, 11:52:59 INFO - 'name': 'check_screen_resolution'},), 11:52:59 INFO - 'run_cmd_checks_enabled': True, 11:52:59 INFO - 'sps_profile': False, 11:52:59 INFO - 'sps_profile_interval': 0, 11:52:59 INFO - 'suite': 'dromaeojs', 11:52:59 INFO - 'system_bits': '32', 11:52:59 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:52:59 INFO - 'title': 't-yosemite-r7-0028', 11:52:59 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:52:59 INFO - 'use_talos_json': True, 11:52:59 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:52:59 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:52:59 INFO - 'work_dir': 'build'} 11:52:59 INFO - [mozharness: 2016-11-20 19:52:59.598265Z] Running clobber step. 11:52:59 INFO - Running pre-action listener: _resource_record_pre_action 11:52:59 INFO - Running main action method: clobber 11:52:59 INFO - rmtree: /builds/slave/test/build 11:52:59 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:53:02 INFO - Running post-action listener: _resource_record_post_action 11:53:02 INFO - [mozharness: 2016-11-20 19:53:02.152173Z] Finished clobber step (success) 11:53:02 INFO - [mozharness: 2016-11-20 19:53:02.152329Z] Running read-buildbot-config step. 11:53:02 INFO - Running pre-action listener: _resource_record_pre_action 11:53:02 INFO - Running main action method: read_buildbot_config 11:53:02 INFO - Using buildbot properties: 11:53:02 INFO - { 11:53:02 INFO - "project": "", 11:53:02 INFO - "product": "firefox", 11:53:02 INFO - "script_repo_revision": "production", 11:53:02 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs", 11:53:02 INFO - "repository": "", 11:53:02 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs", 11:53:02 INFO - "buildid": "20161120103921", 11:53:02 INFO - "pgo_build": "False", 11:53:02 INFO - "basedir": "/builds/slave/test", 11:53:02 INFO - "buildnumber": 72, 11:53:02 INFO - "slavename": "t-yosemite-r7-0028", 11:53:02 INFO - "master": "http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/", 11:53:02 INFO - "platform": "yosemite_r7", 11:53:02 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 11:53:02 INFO - "branch": "mozilla-beta", 11:53:02 INFO - "repo_path": "releases/mozilla-beta", 11:53:02 INFO - "revision": "52b63dfdef59f12010e68534021a8a7a2dfbfde6", 11:53:02 INFO - "stage_platform": "macosx64", 11:53:02 INFO - "builduid": "db7b2984eb874a7fbc8baa26accdaadd", 11:53:02 INFO - "slavebuilddir": "test" 11:53:02 INFO - } 11:53:02 INFO - Found installer url https://queue.taskcluster.net/v1/task/BjkGeLi-Q5mgtI6hirYroQ/artifacts/public/build/firefox-51.0.en-US.mac.dmg. 11:53:02 INFO - Running post-action listener: _resource_record_post_action 11:53:02 INFO - [mozharness: 2016-11-20 19:53:02.155653Z] Finished read-buildbot-config step (success) 11:53:02 INFO - [mozharness: 2016-11-20 19:53:02.155761Z] Running download-and-extract step. 11:53:02 INFO - Running pre-action listener: _resource_record_pre_action 11:53:02 INFO - Running main action method: download_and_extract 11:53:02 INFO - mkdir: /builds/slave/test/build/tests 11:53:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:53:02 INFO - trying https://queue.taskcluster.net/v1/task/BjkGeLi-Q5mgtI6hirYroQ/artifacts/public/build/firefox-51.0.en-US.mac.test_packages.json 11:53:02 INFO - Downloading https://queue.taskcluster.net/v1/task/BjkGeLi-Q5mgtI6hirYroQ/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 11:53:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/BjkGeLi-Q5mgtI6hirYroQ/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 11:53:03 INFO - Downloaded 1165 bytes. 11:53:03 INFO - Reading from file /builds/slave/test/build/firefox-51.0.en-US.mac.test_packages.json 11:53:03 INFO - Using the following test package requirements: 11:53:03 INFO - {u'common': [u'firefox-51.0.en-US.mac.common.tests.zip'], 11:53:03 INFO - u'cppunittest': [u'firefox-51.0.en-US.mac.common.tests.zip', 11:53:03 INFO - u'firefox-51.0.en-US.mac.cppunittest.tests.zip'], 11:53:03 INFO - u'gtest': [u'firefox-51.0.en-US.mac.common.tests.zip', 11:53:03 INFO - u'firefox-51.0.en-US.mac.gtest.tests.zip'], 11:53:03 INFO - u'jittest': [u'firefox-51.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 11:53:03 INFO - u'mochitest': [u'firefox-51.0.en-US.mac.common.tests.zip', 11:53:03 INFO - u'firefox-51.0.en-US.mac.mochitest.tests.zip'], 11:53:03 INFO - u'mozbase': [u'firefox-51.0.en-US.mac.common.tests.zip'], 11:53:03 INFO - u'reftest': [u'firefox-51.0.en-US.mac.common.tests.zip', 11:53:03 INFO - u'firefox-51.0.en-US.mac.reftest.tests.zip'], 11:53:03 INFO - u'talos': [u'firefox-51.0.en-US.mac.common.tests.zip', 11:53:03 INFO - u'firefox-51.0.en-US.mac.talos.tests.zip'], 11:53:03 INFO - u'web-platform': [u'firefox-51.0.en-US.mac.common.tests.zip', 11:53:03 INFO - u'firefox-51.0.en-US.mac.web-platform.tests.zip'], 11:53:03 INFO - u'xpcshell': [u'firefox-51.0.en-US.mac.common.tests.zip', 11:53:03 INFO - u'firefox-51.0.en-US.mac.xpcshell.tests.zip']} 11:53:03 INFO - Downloading packages: [u'firefox-51.0.en-US.mac.common.tests.zip'] for test suite category: common 11:53:03 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/BjkGeLi-Q5mgtI6hirYroQ/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip 11:53:03 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/BjkGeLi-Q5mgtI6hirYroQ/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip'}, attempt #1 11:53:03 INFO - Fetch https://queue.taskcluster.net/v1/task/BjkGeLi-Q5mgtI6hirYroQ/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip into memory 11:53:03 INFO - Expected file size: 16231467 11:53:10 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 11:53:10 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/BjkGeLi-Q5mgtI6hirYroQ/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip 11:53:10 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/BjkGeLi-Q5mgtI6hirYroQ/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip'}, attempt #1 11:53:10 INFO - Fetch https://queue.taskcluster.net/v1/task/BjkGeLi-Q5mgtI6hirYroQ/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip into memory 11:53:11 INFO - Expected file size: 16231467 11:53:18 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/BjkGeLi-Q5mgtI6hirYroQ/artifacts/public/build/firefox-51.0.en-US.mac.talos.tests.zip 11:53:18 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/BjkGeLi-Q5mgtI6hirYroQ/artifacts/public/build/firefox-51.0.en-US.mac.talos.tests.zip'}, attempt #1 11:53:18 INFO - Fetch https://queue.taskcluster.net/v1/task/BjkGeLi-Q5mgtI6hirYroQ/artifacts/public/build/firefox-51.0.en-US.mac.talos.tests.zip into memory 11:53:18 INFO - Expected file size: 14414089 11:53:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:53:19 INFO - trying https://queue.taskcluster.net/v1/task/BjkGeLi-Q5mgtI6hirYroQ/artifacts/public/build/firefox-51.0.en-US.mac.dmg 11:53:19 INFO - Downloading https://queue.taskcluster.net/v1/task/BjkGeLi-Q5mgtI6hirYroQ/artifacts/public/build/firefox-51.0.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0.en-US.mac.dmg 11:53:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/BjkGeLi-Q5mgtI6hirYroQ/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 11:53:21 INFO - Downloaded 86009968 bytes. 11:53:21 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/BjkGeLi-Q5mgtI6hirYroQ/artifacts/public/build/firefox-51.0.en-US.mac.dmg 11:53:21 INFO - mkdir: /builds/slave/test/properties 11:53:21 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:53:21 INFO - Writing to file /builds/slave/test/properties/build_url 11:53:21 INFO - Contents: 11:53:21 INFO - build_url:https://queue.taskcluster.net/v1/task/BjkGeLi-Q5mgtI6hirYroQ/artifacts/public/build/firefox-51.0.en-US.mac.dmg 11:53:22 INFO - Running post-action listener: _resource_record_post_action 11:53:22 INFO - Running post-action listener: set_extra_try_arguments 11:53:22 INFO - [mozharness: 2016-11-20 19:53:22.614342Z] Finished download-and-extract step (success) 11:53:22 INFO - [mozharness: 2016-11-20 19:53:22.614468Z] Running populate-webroot step. 11:53:22 INFO - Running pre-action listener: _resource_record_pre_action 11:53:22 INFO - Running main action method: populate_webroot 11:53:22 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:53:22 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:53:22 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:53:22 INFO - '--tppagecycles', 11:53:22 INFO - '7'], 11:53:22 INFO - 'tests': ['tsvgm']}}, 11:53:22 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 11:53:22 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:53:22 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:53:22 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 11:53:22 INFO - 'tests': ['dromaeo_css', 'kraken']}, 11:53:22 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:53:22 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:53:22 INFO - 'talos_options': ['--disable-e10s'], 11:53:22 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:53:22 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:53:22 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:53:22 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:53:22 INFO - 'talos_options': ['--disable-e10s'], 11:53:22 INFO - 'tests': ['damp', 'tps']}, 11:53:22 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:53:22 INFO - 'tests': ['damp', 'tps']}, 11:53:22 INFO - 'g3': {'talos_options': ['--disable-e10s'], 11:53:22 INFO - 'tests': ['dromaeo_dom']}, 11:53:22 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:53:22 INFO - 'g4': {'talos_options': ['--disable-e10s'], 11:53:22 INFO - 'tests': ['basic_compositor_video']}, 11:53:22 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 11:53:22 INFO - 'other': {'talos_options': ['--disable-e10s'], 11:53:22 INFO - 'tests': ['a11yr', 11:53:22 INFO - 'ts_paint', 11:53:22 INFO - 'tpaint', 11:53:22 INFO - 'sessionrestore', 11:53:22 INFO - 'sessionrestore_no_auto_restore', 11:53:22 INFO - 'tabpaint']}, 11:53:22 INFO - 'other-e10s': {'tests': ['a11yr', 11:53:22 INFO - 'ts_paint', 11:53:22 INFO - 'tpaint', 11:53:22 INFO - 'sessionrestore', 11:53:22 INFO - 'sessionrestore_no_auto_restore', 11:53:22 INFO - 'tabpaint']}, 11:53:22 INFO - 'other-e10s_l64': {'tests': ['a11yr', 11:53:22 INFO - 'ts_paint', 11:53:22 INFO - 'tpaint', 11:53:22 INFO - 'sessionrestore', 11:53:22 INFO - 'sessionrestore_no_auto_restore', 11:53:22 INFO - 'tabpaint']}, 11:53:22 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 11:53:22 INFO - 'ts_paint', 11:53:22 INFO - 'tpaint', 11:53:22 INFO - 'sessionrestore', 11:53:22 INFO - 'sessionrestore_no_auto_restore', 11:53:22 INFO - 'tabpaint']}, 11:53:22 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 11:53:22 INFO - 'tests': ['a11yr', 11:53:22 INFO - 'ts_paint', 11:53:22 INFO - 'tpaint', 11:53:22 INFO - 'sessionrestore', 11:53:22 INFO - 'sessionrestore_no_auto_restore', 11:53:22 INFO - 'tabpaint']}, 11:53:22 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 11:53:22 INFO - 'tests': ['a11yr', 11:53:22 INFO - 'ts_paint', 11:53:22 INFO - 'tpaint', 11:53:22 INFO - 'sessionrestore', 11:53:22 INFO - 'sessionrestore_no_auto_restore', 11:53:22 INFO - 'tabpaint']}, 11:53:22 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 11:53:22 INFO - 'tests': ['tsvgx', 11:53:22 INFO - 'tsvgr_opacity', 11:53:22 INFO - 'tart', 11:53:22 INFO - 'tscrollx', 11:53:22 INFO - 'cart']}, 11:53:22 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:53:22 INFO - 'tsvgr_opacity', 11:53:22 INFO - 'tart', 11:53:22 INFO - 'tscrollx', 11:53:22 INFO - 'cart']}, 11:53:22 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:53:22 INFO - 'talos_options': ['--disable-e10s'], 11:53:22 INFO - 'tests': ['tp5o']}, 11:53:22 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:53:22 INFO - 'tests': ['tp5o']}, 11:53:22 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:53:22 INFO - 'talos_options': ['--disable-e10s', 11:53:22 INFO - '--xperf_path', 11:53:22 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:53:22 INFO - 'tests': ['tp5n']}, 11:53:22 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:53:22 INFO - 'talos_options': ['--xperf_path', 11:53:22 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:53:22 INFO - 'tests': ['tp5n']}}, 11:53:22 INFO - 'talos.zip': {'path': '', 11:53:22 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:53:22 INFO - Running post-action listener: _resource_record_post_action 11:53:22 INFO - [mozharness: 2016-11-20 19:53:22.632734Z] Finished populate-webroot step (success) 11:53:22 INFO - [mozharness: 2016-11-20 19:53:22.632842Z] Running create-virtualenv step. 11:53:22 INFO - Running pre-action listener: _resource_record_pre_action 11:53:22 INFO - Running main action method: create_virtualenv 11:53:22 INFO - Creating virtualenv /builds/slave/test/build/venv 11:53:22 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 11:53:22 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 11:53:22 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:53:22 INFO - Using real prefix '/tools/python27' 11:53:22 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:53:23 INFO - Installing distribute.............................................................................................................................................................................................done. 11:53:26 INFO - Installing pip.................done. 11:53:26 INFO - Return code: 0 11:53:26 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:53:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:53:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:53:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:53:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:53:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:53:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:53:26 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10bb09490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ba7f570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff200cb6110>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b91dd30>, '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 0x10b783db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b915b20>, '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.VORdO4OMjB/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.ykaxYB9CbF/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/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 11:53:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 11:53:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 11:53:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VORdO4OMjB/Render', 11:53:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:53:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:53:26 INFO - 'HOME': '/Users/cltbld', 11:53:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:53:26 INFO - 'LOGNAME': 'cltbld', 11:53:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:53:26 INFO - 'MOZ_NO_REMOTE': '1', 11:53:26 INFO - 'NO_EM_RESTART': '1', 11:53:26 INFO - 'PAGER': '/bin/cat', 11:53:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:53:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:53:26 INFO - 'PWD': '/builds/slave/test', 11:53:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:53:26 INFO - 'SHELL': '/bin/bash', 11:53:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ykaxYB9CbF/Listeners', 11:53:26 INFO - 'TMPDIR': '/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/', 11:53:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:53:26 INFO - 'USER': 'cltbld', 11:53:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:53:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:53:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:53:26 INFO - 'XPC_FLAGS': '0x0', 11:53:26 INFO - 'XPC_SERVICE_NAME': '0', 11:53:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:53:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:53:26 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 11:53:26 INFO - Cleaning up... 11:53:26 INFO - Return code: 0 11:53:26 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 11:53:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:53:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:53:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:53:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:53:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:53:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:53:26 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10bb09490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ba7f570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff200cb6110>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b91dd30>, '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 0x10b783db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b915b20>, '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.VORdO4OMjB/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.ykaxYB9CbF/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/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 11:53:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 11:53:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 11:53:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VORdO4OMjB/Render', 11:53:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:53:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:53:26 INFO - 'HOME': '/Users/cltbld', 11:53:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:53:26 INFO - 'LOGNAME': 'cltbld', 11:53:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:53:26 INFO - 'MOZ_NO_REMOTE': '1', 11:53:26 INFO - 'NO_EM_RESTART': '1', 11:53:26 INFO - 'PAGER': '/bin/cat', 11:53:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:53:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:53:26 INFO - 'PWD': '/builds/slave/test', 11:53:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:53:26 INFO - 'SHELL': '/bin/bash', 11:53:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ykaxYB9CbF/Listeners', 11:53:26 INFO - 'TMPDIR': '/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/', 11:53:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:53:26 INFO - 'USER': 'cltbld', 11:53:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:53:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:53:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:53:26 INFO - 'XPC_FLAGS': '0x0', 11:53:26 INFO - 'XPC_SERVICE_NAME': '0', 11:53:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:53:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:53:26 INFO - Downloading/unpacking psutil>=3.1.1 11:53:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:53:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:53:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:53:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:53:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:53:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:53:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:53:30 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:53:30 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:53:30 INFO - Installing collected packages: psutil 11:53:30 INFO - Running setup.py install for psutil 11:53:30 INFO - building 'psutil._psutil_osx' extension 11:53:30 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 11:53:31 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 11:53:31 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 11:53:31 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 11:53:31 INFO - building 'psutil._psutil_posix' extension 11:53:31 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 11:53:31 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 11:53:31 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 11:53:31 INFO - ^ 11:53:31 INFO - 1 warning generated. 11:53:31 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 11:53:31 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:53:31 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:53:31 INFO - Successfully installed psutil 11:53:31 INFO - Cleaning up... 11:53:31 INFO - Return code: 0 11:53:31 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 11:53:31 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')]} 11:53:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:53:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:53:31 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')]} 11:53:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:53:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:53:31 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 0x10bb09490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ba7f570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff200cb6110>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b91dd30>, '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 0x10b783db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b915b20>, '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.VORdO4OMjB/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.ykaxYB9CbF/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/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 11:53:31 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 11:53:31 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 11:53:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VORdO4OMjB/Render', 11:53:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:53:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:53:31 INFO - 'HOME': '/Users/cltbld', 11:53:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:53:31 INFO - 'LOGNAME': 'cltbld', 11:53:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:53:31 INFO - 'MOZ_NO_REMOTE': '1', 11:53:31 INFO - 'NO_EM_RESTART': '1', 11:53:31 INFO - 'PAGER': '/bin/cat', 11:53:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:53:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:53:31 INFO - 'PWD': '/builds/slave/test', 11:53:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:53:31 INFO - 'SHELL': '/bin/bash', 11:53:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ykaxYB9CbF/Listeners', 11:53:31 INFO - 'TMPDIR': '/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/', 11:53:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:53:31 INFO - 'USER': 'cltbld', 11:53:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:53:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:53:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:53:31 INFO - 'XPC_FLAGS': '0x0', 11:53:31 INFO - 'XPC_SERVICE_NAME': '0', 11:53:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:53:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:53:32 INFO - Downloading/unpacking mozsystemmonitor==0.3 11:53:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:53:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:53:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:53:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:53:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:53:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:53:34 INFO - Downloading mozsystemmonitor-0.3.tar.gz 11:53:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:53:34 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 11:53:34 INFO - Installing collected packages: mozsystemmonitor 11:53:34 INFO - Running setup.py install for mozsystemmonitor 11:53:34 INFO - Successfully installed mozsystemmonitor 11:53:34 INFO - Cleaning up... 11:53:35 INFO - Return code: 0 11:53:35 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 11:53:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:53:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:53:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:53:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:53:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:53:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:53:35 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 0x10bb09490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ba7f570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff200cb6110>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b91dd30>, '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 0x10b783db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b915b20>, '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.VORdO4OMjB/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.ykaxYB9CbF/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/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 11:53:35 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 11:53:35 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 11:53:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VORdO4OMjB/Render', 11:53:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:53:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:53:35 INFO - 'HOME': '/Users/cltbld', 11:53:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:53:35 INFO - 'LOGNAME': 'cltbld', 11:53:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:53:35 INFO - 'MOZ_NO_REMOTE': '1', 11:53:35 INFO - 'NO_EM_RESTART': '1', 11:53:35 INFO - 'PAGER': '/bin/cat', 11:53:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:53:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:53:35 INFO - 'PWD': '/builds/slave/test', 11:53:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:53:35 INFO - 'SHELL': '/bin/bash', 11:53:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ykaxYB9CbF/Listeners', 11:53:35 INFO - 'TMPDIR': '/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/', 11:53:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:53:35 INFO - 'USER': 'cltbld', 11:53:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:53:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:53:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:53:35 INFO - 'XPC_FLAGS': '0x0', 11:53:35 INFO - 'XPC_SERVICE_NAME': '0', 11:53:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:53:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:53:35 INFO - Downloading/unpacking jsonschema==2.5.1 11:53:35 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 11:53:35 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 11:53:35 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 11:53:35 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 11:53:35 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 11:53:35 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 11:53:37 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:53:37 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 11:53:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:53:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:53:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:53:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:53:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:53:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:53:38 INFO - Downloading functools32-3.2.3-2.tar.gz 11:53:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:53:38 INFO - warning: no files found matching '*.txt' 11:53:38 INFO - no previously-included directories found matching 'build' 11:53:38 INFO - no previously-included directories found matching 'dist' 11:53:38 INFO - no previously-included directories found matching '.git*' 11:53:38 INFO - Installing collected packages: jsonschema, functools32 11:53:38 INFO - Running setup.py install for functools32 11:53:38 INFO - warning: no files found matching '*.txt' 11:53:38 INFO - no previously-included directories found matching 'build' 11:53:38 INFO - no previously-included directories found matching 'dist' 11:53:38 INFO - no previously-included directories found matching '.git*' 11:53:38 INFO - Successfully installed jsonschema functools32 11:53:38 INFO - Cleaning up... 11:53:38 INFO - Return code: 0 11:53:38 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 11:53:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:53:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:53:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:53:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:53:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:53:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:53:38 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 0x10bb09490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ba7f570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff200cb6110>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b91dd30>, '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 0x10b783db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b915b20>, '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.VORdO4OMjB/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.ykaxYB9CbF/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/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 11:53:38 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 11:53:38 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 11:53:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VORdO4OMjB/Render', 11:53:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:53:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:53:38 INFO - 'HOME': '/Users/cltbld', 11:53:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:53:38 INFO - 'LOGNAME': 'cltbld', 11:53:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:53:38 INFO - 'MOZ_NO_REMOTE': '1', 11:53:38 INFO - 'NO_EM_RESTART': '1', 11:53:38 INFO - 'PAGER': '/bin/cat', 11:53:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:53:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:53:38 INFO - 'PWD': '/builds/slave/test', 11:53:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:53:38 INFO - 'SHELL': '/bin/bash', 11:53:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ykaxYB9CbF/Listeners', 11:53:38 INFO - 'TMPDIR': '/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/', 11:53:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:53:38 INFO - 'USER': 'cltbld', 11:53:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:53:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:53:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:53:38 INFO - 'XPC_FLAGS': '0x0', 11:53:38 INFO - 'XPC_SERVICE_NAME': '0', 11:53:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:53:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:53:38 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 11:53:38 INFO - Cleaning up... 11:53:38 INFO - Return code: 0 11:53:38 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:53:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:53:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:53:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:53:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:53:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:53:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:53:38 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 0x10bb09490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ba7f570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff200cb6110>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b91dd30>, '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 0x10b783db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b915b20>, '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.VORdO4OMjB/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.ykaxYB9CbF/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/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 11:53:38 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 11:53:38 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 11:53:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VORdO4OMjB/Render', 11:53:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:53:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:53:38 INFO - 'HOME': '/Users/cltbld', 11:53:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:53:38 INFO - 'LOGNAME': 'cltbld', 11:53:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:53:38 INFO - 'MOZ_NO_REMOTE': '1', 11:53:38 INFO - 'NO_EM_RESTART': '1', 11:53:38 INFO - 'PAGER': '/bin/cat', 11:53:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:53:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:53:38 INFO - 'PWD': '/builds/slave/test', 11:53:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:53:38 INFO - 'SHELL': '/bin/bash', 11:53:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ykaxYB9CbF/Listeners', 11:53:38 INFO - 'TMPDIR': '/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/', 11:53:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:53:38 INFO - 'USER': 'cltbld', 11:53:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:53:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:53:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:53:38 INFO - 'XPC_FLAGS': '0x0', 11:53:38 INFO - 'XPC_SERVICE_NAME': '0', 11:53:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:53:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:53:39 INFO - Downloading/unpacking blobuploader==1.2.4 11:53:39 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 11:53:39 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 11:53:39 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 11:53:39 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 11:53:39 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 11:53:39 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 11:53:41 INFO - Downloading blobuploader-1.2.4.tar.gz 11:53:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:53:41 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:53:41 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 11:53:41 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 11:53:41 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 11:53:41 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 11:53:41 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 11:53:41 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 11:53:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:53:42 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:53:42 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 11:53:42 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 11:53:42 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 11:53:42 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 11:53:42 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 11:53:42 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 11:53:42 INFO - Downloading docopt-0.6.1.tar.gz 11:53:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:53:42 INFO - Installing collected packages: blobuploader, requests, docopt 11:53:42 INFO - Running setup.py install for blobuploader 11:53:43 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:53:43 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:53:43 INFO - Running setup.py install for requests 11:53:43 INFO - Running setup.py install for docopt 11:53:43 INFO - Successfully installed blobuploader requests docopt 11:53:43 INFO - Cleaning up... 11:53:43 INFO - Return code: 0 11:53:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:53:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:53:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:53:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:53:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:53:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:53:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:53:43 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 0x10bb09490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ba7f570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff200cb6110>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b91dd30>, '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 0x10b783db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b915b20>, '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.VORdO4OMjB/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.ykaxYB9CbF/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/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 11:53:43 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 11:53:43 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 11:53:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VORdO4OMjB/Render', 11:53:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:53:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:53:43 INFO - 'HOME': '/Users/cltbld', 11:53:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:53:43 INFO - 'LOGNAME': 'cltbld', 11:53:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:53:43 INFO - 'MOZ_NO_REMOTE': '1', 11:53:43 INFO - 'NO_EM_RESTART': '1', 11:53:43 INFO - 'PAGER': '/bin/cat', 11:53:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:53:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:53:43 INFO - 'PWD': '/builds/slave/test', 11:53:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:53:43 INFO - 'SHELL': '/bin/bash', 11:53:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ykaxYB9CbF/Listeners', 11:53:43 INFO - 'TMPDIR': '/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/', 11:53:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:53:43 INFO - 'USER': 'cltbld', 11:53:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:53:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:53:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:53:43 INFO - 'XPC_FLAGS': '0x0', 11:53:43 INFO - 'XPC_SERVICE_NAME': '0', 11:53:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:53:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:53:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:53:44 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-oGi0V_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:53:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:53:44 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-aignq5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:53:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:53:44 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-d_xweu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:53:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:53:44 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-XmsPxK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:53:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:53:44 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-rMxzGu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:53:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:53:44 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-ehbw5Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:53:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:53:44 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-Psfrcm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:53:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:53:44 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-4WWUPA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:53:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:53:44 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-5wzXd2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:53:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:53:44 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-uVgtd5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:53:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:53:45 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-OV1a4o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:53:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:53:45 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-DlZ4Fa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:53:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:53:45 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-JxL1ZU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:53:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:53:45 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-sDNiTV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:53:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:53:45 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-SOsSd7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:53:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:53:45 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-Jy9JAF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:53:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:53:45 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-n0VUM5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:53:45 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:53:45 INFO - Running setup.py install for manifestparser 11:53:45 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:53:45 INFO - Running setup.py install for mozcrash 11:53:46 INFO - Running setup.py install for mozdebug 11:53:46 INFO - Running setup.py install for mozdevice 11:53:46 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 11:53:46 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:53:46 INFO - Running setup.py install for mozfile 11:53:46 INFO - Running setup.py install for mozhttpd 11:53:46 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:53:46 INFO - Running setup.py install for mozinfo 11:53:46 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:53:46 INFO - Running setup.py install for mozInstall 11:53:46 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:53:46 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:53:46 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:53:46 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:53:46 INFO - Running setup.py install for mozleak 11:53:47 INFO - Running setup.py install for mozlog 11:53:47 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:53:47 INFO - Running setup.py install for moznetwork 11:53:47 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:53:47 INFO - Running setup.py install for mozprocess 11:53:47 INFO - Running setup.py install for mozprofile 11:53:47 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:53:47 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:53:47 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:53:47 INFO - Running setup.py install for mozrunner 11:53:47 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:53:47 INFO - Running setup.py install for mozscreenshot 11:53:48 INFO - Running setup.py install for moztest 11:53:48 INFO - Running setup.py install for mozversion 11:53:48 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:53:48 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:53:48 INFO - Cleaning up... 11:53:48 INFO - Return code: 0 11:53:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:53:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:53:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:53:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:53:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:53:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:53:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:53:48 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 0x10bb09490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ba7f570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff200cb6110>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b91dd30>, '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 0x10b783db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b915b20>, '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.VORdO4OMjB/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.ykaxYB9CbF/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/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 11:53:48 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 11:53:48 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 11:53:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VORdO4OMjB/Render', 11:53:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:53:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:53:48 INFO - 'HOME': '/Users/cltbld', 11:53:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:53:48 INFO - 'LOGNAME': 'cltbld', 11:53:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:53:48 INFO - 'MOZ_NO_REMOTE': '1', 11:53:48 INFO - 'NO_EM_RESTART': '1', 11:53:48 INFO - 'PAGER': '/bin/cat', 11:53:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:53:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:53:48 INFO - 'PWD': '/builds/slave/test', 11:53:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:53:48 INFO - 'SHELL': '/bin/bash', 11:53:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ykaxYB9CbF/Listeners', 11:53:48 INFO - 'TMPDIR': '/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/', 11:53:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:53:48 INFO - 'USER': 'cltbld', 11:53:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:53:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:53:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:53:48 INFO - 'XPC_FLAGS': '0x0', 11:53:48 INFO - 'XPC_SERVICE_NAME': '0', 11:53:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:53:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:53:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:53:48 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-1nvueA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:53:48 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)) 11:53:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:53:48 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-XVTWBl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:53:48 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)) 11:53:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:53:48 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-DCJSP7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:53:48 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)) 11:53:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:53:49 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-nyAGAt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:53:49 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)) 11:53:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:53:49 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-tBC29v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:53:49 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)) 11:53:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:53:49 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-uT4bSG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:53:49 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)) 11:53:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:53:49 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-Xh3Q__-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:53:49 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)) 11:53:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:53:49 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-O1_4zH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:53:49 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)) 11:53:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:53:49 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-6MktJN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:53:49 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)) 11:53:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:53:49 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-dNoe_F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:53:49 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)) 11:53:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:53:49 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-qhJLAx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:53:49 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)) 11:53:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:53:49 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-uxw66A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:53:49 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)) 11:53:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:53:49 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-QLWW7u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:53:50 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)) 11:53:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:53:50 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-06alC9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:53:50 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)) 11:53:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:53:50 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-0S8Kpy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:53:50 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)) 11:53:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:53:50 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-eG_ftE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:53:50 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)) 11:53:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:53:50 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-clrUuO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:53:50 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)) 11:53:50 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)) 11:53:50 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)) 11:53:50 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)) 11:53:50 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)) 11:53:50 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)) 11:53:50 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:53:50 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 11:53:50 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 11:53:50 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 11:53:50 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 11:53:50 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 11:53:50 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 11:53:53 INFO - Downloading blessings-1.6.tar.gz 11:53:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:53:53 INFO - Installing collected packages: blessings 11:53:53 INFO - Running setup.py install for blessings 11:53:53 INFO - Successfully installed blessings 11:53:53 INFO - Cleaning up... 11:53:53 INFO - Return code: 0 11:53:53 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:53:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:53:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:53:53 INFO - Reading from file tmpfile_stdout 11:53:53 INFO - Current package versions: 11:53:53 INFO - blessings == 1.6 11:53:53 INFO - blobuploader == 1.2.4 11:53:53 INFO - docopt == 0.6.1 11:53:53 INFO - functools32 == 3.2.3-2 11:53:53 INFO - jsonschema == 2.5.1 11:53:53 INFO - manifestparser == 1.1 11:53:53 INFO - mozInstall == 1.12 11:53:53 INFO - mozcrash == 0.17 11:53:53 INFO - mozdebug == 0.1 11:53:53 INFO - mozdevice == 0.48 11:53:53 INFO - mozfile == 1.2 11:53:53 INFO - mozhttpd == 0.7 11:53:53 INFO - mozinfo == 0.9 11:53:53 INFO - mozleak == 0.1 11:53:53 INFO - mozlog == 3.4 11:53:53 INFO - moznetwork == 0.27 11:53:53 INFO - mozprocess == 0.23 11:53:53 INFO - mozprofile == 0.28 11:53:53 INFO - mozrunner == 6.12 11:53:53 INFO - mozscreenshot == 0.1 11:53:53 INFO - mozsystemmonitor == 0.3 11:53:53 INFO - moztest == 0.7 11:53:53 INFO - mozversion == 1.4 11:53:53 INFO - psutil == 3.1.1 11:53:53 INFO - requests == 1.2.3 11:53:53 INFO - wsgiref == 0.1.2 11:53:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:53: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')]} 11:53:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:53:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:53: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')]} 11:53:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:53:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:53:53 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 0x10bb09490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ba7f570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff200cb6110>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b91dd30>, '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 0x10b783db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b915b20>, '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.VORdO4OMjB/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.ykaxYB9CbF/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/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 11:53:53 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 11:53:53 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 11:53:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VORdO4OMjB/Render', 11:53:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:53:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:53:53 INFO - 'HOME': '/Users/cltbld', 11:53:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:53:53 INFO - 'LOGNAME': 'cltbld', 11:53:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:53:53 INFO - 'MOZ_NO_REMOTE': '1', 11:53:53 INFO - 'NO_EM_RESTART': '1', 11:53:53 INFO - 'PAGER': '/bin/cat', 11:53:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:53:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:53:53 INFO - 'PWD': '/builds/slave/test', 11:53:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:53:53 INFO - 'SHELL': '/bin/bash', 11:53:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ykaxYB9CbF/Listeners', 11:53:53 INFO - 'TMPDIR': '/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/', 11:53:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:53:53 INFO - 'USER': 'cltbld', 11:53:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:53:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:53:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:53:53 INFO - 'XPC_FLAGS': '0x0', 11:53:53 INFO - 'XPC_SERVICE_NAME': '0', 11:53:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:53:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:53:53 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)) 11:53:53 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)) 11:53:53 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)) 11:53:53 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)) 11:53:53 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)) 11:53:53 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)) 11:53:53 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)) 11:53:53 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)) 11:53:53 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)) 11:53:53 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)) 11:53:53 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)) 11:53:53 INFO - Cleaning up... 11:53:53 INFO - Return code: 0 11:53:53 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:53: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')]} 11:53:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:53:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:53: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')]} 11:53:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:53:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:53: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10bb09490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ba7f570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff200cb6110>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b91dd30>, '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 0x10b783db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b915b20>, '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.VORdO4OMjB/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.ykaxYB9CbF/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/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 11:53: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', 'jsonschema'] in /builds/slave/test/build 11:53: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 jsonschema 11:53:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VORdO4OMjB/Render', 11:53:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:53:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:53:53 INFO - 'HOME': '/Users/cltbld', 11:53:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:53:53 INFO - 'LOGNAME': 'cltbld', 11:53:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:53:53 INFO - 'MOZ_NO_REMOTE': '1', 11:53:53 INFO - 'NO_EM_RESTART': '1', 11:53:53 INFO - 'PAGER': '/bin/cat', 11:53:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:53:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:53:53 INFO - 'PWD': '/builds/slave/test', 11:53:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:53:53 INFO - 'SHELL': '/bin/bash', 11:53:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ykaxYB9CbF/Listeners', 11:53:53 INFO - 'TMPDIR': '/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/', 11:53:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:53:53 INFO - 'USER': 'cltbld', 11:53:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:53:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:53:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:53:53 INFO - 'XPC_FLAGS': '0x0', 11:53:53 INFO - 'XPC_SERVICE_NAME': '0', 11:53:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:53:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:53:54 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 11:53:54 INFO - Cleaning up... 11:53:54 INFO - Return code: 0 11:53:54 INFO - Running post-action listener: _resource_record_post_action 11:53:54 INFO - Running post-action listener: _start_resource_monitoring 11:53:54 INFO - Starting resource monitoring. 11:53:54 INFO - [mozharness: 2016-11-20 19:53:54.259451Z] Finished create-virtualenv step (success) 11:53:54 INFO - [mozharness: 2016-11-20 19:53:54.260504Z] Running install step. 11:53:54 INFO - Running pre-action listener: _resource_record_pre_action 11:53:54 INFO - Running main action method: install 11:53:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:53:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:53:54 INFO - Reading from file tmpfile_stdout 11:53:54 INFO - Detecting whether we're running mozinstall >=1.0... 11:53:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:53:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:53:54 INFO - Reading from file tmpfile_stdout 11:53:54 INFO - Output received: 11:53:54 INFO - Usage: mozinstall [options] installer 11:53:54 INFO - Options: 11:53:54 INFO - -h, --help show this help message and exit 11:53:54 INFO - -d DEST, --destination=DEST 11:53:54 INFO - Directory to install application into. [default: 11:53:54 INFO - "/builds/slave/test"] 11:53:54 INFO - --app=APP Application being installed. [default: firefox] 11:53:54 INFO - mkdir: /builds/slave/test/build/application 11:53:54 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'] 11:53:54 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 11:54:16 INFO - Reading from file tmpfile_stdout 11:54:16 INFO - Output received: 11:54:16 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 11:54:16 INFO - Running post-action listener: _resource_record_post_action 11:54:16 INFO - [mozharness: 2016-11-20 19:54:16.198228Z] Finished install step (success) 11:54:16 INFO - [mozharness: 2016-11-20 19:54:16.198379Z] Running run-tests step. 11:54:16 INFO - Running pre-action listener: _resource_record_pre_action 11:54:16 INFO - Running main action method: run_tests 11:54:16 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 11:54:16 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 11:54:16 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 11:54:16 INFO - 2016-11-20 11:54:16.210 screenresolution[1628:8189] starting screenresolution argv=screenresolution get 11:54:16 INFO - 2016-11-20 11:54:16.213 screenresolution[1628:8189] Display 0: 1600x1200x32@60 11:54:16 INFO - 2016-11-20 11:54:16.218 screenresolution[1629:8192] starting screenresolution argv=screenresolution list 11:54:16 INFO - Available Modes on Display 0 11:54:16 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 11:54:16 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 11:54:16 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 11:54:16 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 11:54:16 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 11:54:16 INFO - Intel Iris: 11:54:16 INFO - Chipset Model: Intel Iris 11:54:16 INFO - Type: GPU 11:54:16 INFO - Bus: Built-In 11:54:16 INFO - VRAM (Dynamic, Max): 1536 MB 11:54:16 INFO - Vendor: Intel (0x8086) 11:54:16 INFO - Device ID: 0x0a2e 11:54:16 INFO - Revision ID: 0x0009 11:54:16 INFO - Displays: 11:54:16 INFO - Display: 11:54:16 INFO - Resolution: 1600 x 1200 @ 60 Hz 11:54:16 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 11:54:16 INFO - Display Serial Number: 1600x1200 60 11:54:16 INFO - Main Display: Yes 11:54:16 INFO - Mirror: Off 11:54:16 INFO - Online: Yes 11:54:16 INFO - Rotation: Supported 11:54:16 INFO - Return code: 0 11:54:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:54:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:54:16 INFO - Python 2.7.3 11:54:16 INFO - Return code: 0 11:54:16 INFO - grabbing minidump binary from tooltool 11:54:16 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')]} 11:54:16 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 0x10b91dd30>, '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 0x10b783db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b915b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:54:16 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 11:54:16 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 11:54:16 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 11:54:16 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:54:16 INFO - Return code: 0 11:54:16 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 11:54:16 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:54:16 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:54:16 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 11:54:16 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:54:16 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/BjkGeLi-Q5mgtI6hirYroQ/artifacts/public/build/firefox-51.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0028', '--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 11:54:16 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/BjkGeLi-Q5mgtI6hirYroQ/artifacts/public/build/firefox-51.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0028 --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 11:54:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VORdO4OMjB/Render', 11:54:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:54:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:54:16 INFO - 'HOME': '/Users/cltbld', 11:54:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:54:16 INFO - 'LOGNAME': 'cltbld', 11:54:16 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:54:16 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 11:54:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:54:16 INFO - 'MOZ_NO_REMOTE': '1', 11:54:16 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:54:16 INFO - 'NO_EM_RESTART': '1', 11:54:16 INFO - 'PAGER': '/bin/cat', 11:54:16 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:54:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:54:16 INFO - 'PWD': '/builds/slave/test', 11:54:16 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:54:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:54:16 INFO - 'SHELL': '/bin/bash', 11:54:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ykaxYB9CbF/Listeners', 11:54:16 INFO - 'TMPDIR': '/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/', 11:54:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:54:16 INFO - 'USER': 'cltbld', 11:54:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:54:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:54:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:54:16 INFO - 'XPC_FLAGS': '0x0', 11:54:16 INFO - 'XPC_SERVICE_NAME': '0', 11:54:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:54:16 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/BjkGeLi-Q5mgtI6hirYroQ/artifacts/public/build/firefox-51.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0028', '--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 11:54:16 INFO - mozversion application_buildid: 20161120103921 11:54:16 INFO - mozversion application_changeset: 52b63dfdef59f12010e68534021a8a7a2dfbfde6 11:54:16 INFO - mozversion application_display_name: Firefox 11:54:16 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:54:16 INFO - mozversion application_name: Firefox 11:54:16 INFO - mozversion application_remotingname: firefox 11:54:16 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 11:54:16 INFO - mozversion application_vendor: Mozilla 11:54:16 INFO - mozversion application_version: 51.0 11:54:16 INFO - mozversion platform_buildid: 20161120103921 11:54:16 INFO - mozversion platform_changeset: 52b63dfdef59f12010e68534021a8a7a2dfbfde6 11:54:16 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 11:54:16 INFO - mozversion platform_version: 51.0 11:54:16 INFO - using testdate: 1479671656 11:54:16 INFO - actual date: 1479671656 11:54:16 INFO - starting webserver on 'localhost:49237' 11:54:16 INFO - SUITE-START | Running 2 tests 11:54:16 INFO - TEST-START | dromaeo_css 11:54:16 INFO - operating with platform_type : mac_ 11:54:16 INFO - Initialising browser for dromaeo_css test... 11:54:16 INFO - TEST-INFO | started process 1639 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/tmpCeDtXq/profile http://localhost:49237/getInfo.html) 11:54:19 INFO - PROCESS | 1639 | __metrics Screen width/height:1600/1200 11:54:19 INFO - PROCESS | 1639 | colorDepth:24 11:54:19 INFO - PROCESS | 1639 | Browser inner width/height: 1024/689 11:54:19 INFO - PROCESS | 1639 | __metrics 11:54:19 INFO - PROCESS | 1639 | 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" 11:54:19 INFO - PROCESS | 1639 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:54:19 INFO - TEST-INFO | 1639: exit 0 11:54:19 INFO - Browser initialized. 11:54:19 INFO - Running cycle 1/1 for dromaeo_css test... 11:54:19 INFO - TEST-INFO | started process 1643 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/tmpCeDtXq/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:54:31 INFO - PROCESS | 1643 | RSS: Main: 168517632 11:54:31 INFO - PROCESS | 1643 | 11:55:23 INFO - PROCESS | 1643 | 1479671723454 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] 11:57:33 INFO - PROCESS | 1643 | Cycle 1(1): loaded http://localhost:49237/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49237/tests/dromaeo/cssquery-ext.html) 11:57:34 INFO - PROCESS | 1643 | RSS: Main: 272719872 11:57:34 INFO - PROCESS | 1643 | 12:00:37 INFO - PROCESS | 1643 | Cycle 1(1): loaded http://localhost:49237/tests/dromaeo/cssquery-ext.html (next: http://localhost:49237/tests/dromaeo/cssquery-jquery.html) 12:00:38 INFO - PROCESS | 1643 | RSS: Main: 300613632 12:00:38 INFO - PROCESS | 1643 | 12:03:40 INFO - PROCESS | 1643 | Cycle 1(1): loaded http://localhost:49237/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49237/tests/dromaeo/cssquery-mootools.html) 12:03:41 INFO - PROCESS | 1643 | RSS: Main: 268591104 12:03:41 INFO - PROCESS | 1643 | 12:06:43 INFO - PROCESS | 1643 | Cycle 1(1): loaded http://localhost:49237/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49237/tests/dromaeo/cssquery-prototype.html) 12:06:44 INFO - PROCESS | 1643 | RSS: Main: 265826304 12:06:44 INFO - PROCESS | 1643 | 12:09:47 INFO - PROCESS | 1643 | Cycle 1(1): loaded http://localhost:49237/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49237/tests/dromaeo/cssquery-yui.html) 12:09:48 INFO - PROCESS | 1643 | RSS: Main: 260354048 12:09:48 INFO - PROCESS | 1643 | 12:12:50 INFO - PROCESS | 1643 | Cycle 1(1): loaded http://localhost:49237/tests/dromaeo/cssquery-yui.html (next: http://localhost:49237/tests/dromaeo/cssquery-dojo.html) 12:12:51 INFO - PROCESS | 1643 | RSS: Main: 362823680 12:12:51 INFO - PROCESS | 1643 | 12:12:51 INFO - PROCESS | 1643 | __start_tp_report 12:12:51 INFO - PROCESS | 1643 | _x_x_mozilla_page_load 12:12:51 INFO - PROCESS | 1643 | _x_x_mozilla_page_load_details 12:12:51 INFO - PROCESS | 1643 | |i|pagename|runs| 12:12:51 INFO - PROCESS | 1643 | |0;dojo.html;2876.784241181911;3444.362792883316;3491.231928975626;3523.0663874073357;3536.8408421621025;5646.887062258757;5694.914576281359;5740.56945729071;5744.79893203738;5760.884782304352;5680.914786278209;5774.3936886626825;5774.855628609276;5776.884462310762;5783.5951483396175;4772.403449568804;4988.077205716954;5186.844394668166;5193.221016847484;5210.7655155518;5151.098557752378;5159.58723302135;5278.419373868871;5283.128283833163;5329.200619907026;5119.923201151985;5156.175011998081;5184.766685499143;5209.244659524366;5210.270562121306;5176.990486855065;5180.04169228692;5240.816571419982;5252.6323157379;5256.526912577886;5080.212567052113;5111.591072714211;5194.065068287707;5206.271122042879;5220.216967454874;5607.130894711327;5636.379998200195;5636.830895073154;5671.262735844314;5671.489565939044;6115.938840611581;6134.4172303631085;6164.907526387108;6184.319724830265;6204.7828326008375;5120.411152717411;6122.367660829195;6204.441600255998;6207.224096987877;6241.594296370767;4894.167991441393;5703.258576385085;5717.971410142923;5798.9130163047585;5846.093855452412;6168.001872109082;6214.471769899609;6215.192025036807;6226.097215903668;6247.0629405589525;6112.113743507255;6128.295246046672;6143.784967526115;6150.292716337678;6164.383561643889;6104.337893874325;6143.481172719164;6144.064619644798;6173.197484327009;6175.660338681416;6194.659293738798;6195.473384762256;6203.16257305258;6213.5339849511465;6215.96892015537;5936.9406305937255;6140.92533806591;6141.280441476394;6214.40963108504;6223.066540018943;4830.492798256203;4885.487023862514;4899.510048995072;4966.180580204298;4972.279019542146;4423.248047831877;4471.441069866267;4488.820447182076;4496.258117410656;4542.273236282179;5755.798547050833;5759.136129580513;5769;5769.913451298234;5777.0467872801355;6078.969605151946;6190.102435146879;6209.751609935552;6227.314995350508;6229.906551401733;5667.036603777367;5667.348254950651;5701.543876489871;5721.5136713379;5726.055200891889;5396.568274538027;5416.458354164552;5417.377001644862;5431.972840135774;5435.646682965595;6269.153664255358;6272.153259310117;6273.592216505913;6281.434670879551;6430.967845160838;6107.61364822091;6111.86523267538;6130.111133885473;6141.36327073057;6194.34959329282;6241.032639940817;6254.186955695731;6254.21822272216;6255.437010669061;6269.937300626935;6081.5742897996715;6159.29168145669;6161.72272247741;6162.322144564184;6177.135201071944;4578.862634120982;5588.996539106098;6116.944513560587;6144.893919094606;6186.969065154825;5210.947890521046;6041.426064523863;6135.93706321624;6147.323794382703;6151.630902145886;5149.794008239628;6119.296280927751;6126.417990290915;6129.203203583684;6148.262208535004;5729.9713501432225;5877.059670452707;5987.880242395215;5994.880102398015;6012.729427175875;6040.879182416239;6063.9547617625885;6086.239220097488;6107.786227482017;6139.140520327069;6028.668423236764;6031.7587296507645;6046.818595442144;6064.211652485149;6076.78731244422 12:12:51 INFO - PROCESS | 1643 | |1;ext.html;470.90346478971816;500.68206688752633;509.19547115557424;535.6652092442224;547.1928904865322;27536.17391478254;31875.681243187562;32686.855960041405;32789.836050819744;41543.961400964916;44259.33610995838;45022.09955800882;45038.54961450385;45069.774651126696;45147.77426112873;9938.354006989559;10113.848292275621;10114.848277275847;10116.645917392892;10134.13859821916;9303.488308143049;9533.47565883876;9763.511824408786;9868.161206297438;12029.278243305385;12216.755664886698;12422.440990155465;12428.875711242907;12451.813222801666;12469.189502682297;12288.139830211889;12351.19717218378;12375.381230938507;12381.380930953417;12415.379231038458;12214.938925305405;12285.754284914252;12302.692432689164;12304.569340073054;12337.074719396081;41552.58447415518;41902.161956760996;41961;41976.16047679029;42098.78950605258;3425.6745609167087;3689.4281386384887;3766.3785475396526;3903.0827755477726;4180.038591124028;31396.21509462259;31442.685573144205;31620.525692114636;31825.840870795728;32059.51910721341;3352.346292472969;3430.5540279763472;3456.9283522108226;3463.0476618929742;3479.1476088358513;514071;514364.9999999963;514540;515571;517894;62049.75900481965;62526.687366562874;62548;62562.374376256565;62751.68624156941;36501;37172.88481345564;37187.07032324159;37995.430068548994;38433.42349864754;17848.821511784718;18028.909855450638;18052.729209061876;18055.277788888296;18058.909705451388;13742.519011834738;13840.584782456543;13858.307084645727;13861.099028563312;13900.235487048107;15434.6141346465;17889.910550447425;19294.03529823503;19309.03928064381;20378.490537736674;6636.767713130017;8062.7581172564915;8066.919330806734;8094.635741391651;8173.305269052078;879.3800370738614;1021.2493817044466;1108.661858133261;1125.7391721272227;1150.223599070624;30297.697023029927;30386.936457224332;30970.84514577413;31080.378392432478;31187.532187017212;1064.796779639003;1122.6912599035331;1130.3218069158438;1149.5401839264362;1167.3112863410458;14071.507497237548;16194.514164575081;16198.433054843024;16240.59398515023;16593.41923032688;683917;686186;687583;687988;689579;61634;62151.378486215464;62186.75626487445;62257.06614400788;62277.06584401237;1320.6368248731676;1352.0670737191504;1397.0988712280725;1448.0877047460244;1473.3222717549834;30469;32458.513122302713;32465.513017304285;32629;33352.49971250482;50841.49158508368;58263.70868145632;60036.69981650064;60351.698241508515;64152.03771943518;628765;628924;633564;635959;637579;35991;37528.437073443376;38764.80617596894;41761.95595110147;45021.77489112534;47584.52415475801;49060.75469622629;49246.753766232374;49405.75297123491;49624.25563616621;34700.47949280712;39683.80158099191;40231.79304620866;40500.39249411202;41907;40337;40852.59147408488;40911.7954410226;41412;42560.36159457549;38215.42676859905;39047;39131.282528159776;39132;39175.80412097921;31121.91073312423;31502.52746208763;32766.672333277314;33761.96038472092;37893.05267368338;24323.513529729662;26275.948962041304;26656;26902.596461052708;26904.32739181536 12:12:51 INFO - PROCESS | 1643 | |2;jquery.html;383.8349509710823;384.0166570908039;384.32359048075386;394.56794809683385;412.23736088236745;14675.77986330206;20249.8862562559;20933.371998840023;21590.568188636218;21646.89176554117;16773.91613041933;19854.50363740907;21147.682784758203;21345.679814802792;21412.785872141274;6017.909731354033;6362.5546211765195;6362.650054247015;6370.872582548346;6391.392817682313;6090.451859332659;6097.3292937776805;6147.323794382614;6282.7172777224905;6319.273283572379;6254.312025677172;6255.40573645503;6255.655938923357;6278.0269058296035;6281.560290779625;5950.613210141349;6150.907736383958;6210.565260431772;6217.68911554425;6233.625982441068;5430.809921652763;5432.891342173174;5443.101888188444;5444.6188766786345;5447.400785913546;25101;26185.083522076635;26407;26609.866950665317;26661;2170.3163503496507;2233.6761169630477;2298.7816157465013;2303.1823702585507;2907.941841163165;10242.48787560619;10256.538455769509;10304.227182961233;10384.428856412895;10713.196510261761;1931.9130639121274;1950.3856285270235;1981.6333978213931;1982.5638359560874;1994.980050199494;101626.47560286602;113830;127291.36354318261;127913;129001.35499322537;11205.43972801373;11272.154588405903;11710.473028713557;11893.643190704293;12132.636020919386;15047.623809404633;15066.472673456596;15080.924595376953;15094.094354338775;15107.093574385572;8002.279794818494;8330.166983301622;8338.749837504885;8601.22588966996;8799.648014079365;8918;9049.638014479347;9049.77375565616;9052.683156089506;9171.678991235274;4112.218678451144;4446.42196514451;4624;4641.767911604406;4691.997121842024;1834.1379551610721;1853.5644123630937;1853.981460185381;1897.870766893696;1947.1335255811027;929.3680297397699;980.1717548671361;1017.2777328097134;1025.0057444279037;1026.9691909242736;20694.379168624964;22016.559668806534;22043.559128817335;22063.44841378946;22065.889670551544;946.3233787841726;949.6818565780541;954.4702690006974;968.3608818179968;1016.5476363018533;11037.668869933916;11627.186096973131;11779.528818847322;11819.290842549302;11832.70418239551;636585;639593;646467.7676611681;647762;654179;106108.46945765222;109589;118521;121727;128056;985.3348989432104;1046.586598293685;1060.6499855047816;1061.8407238914224;1062.7024433158729;19324.8067519323;19417.70873436928;20020.49948751293;20023.399298021082;20068;55381.446185539244;55637.88724225412;56181.71909140592;57837.84324313574;59307.703461482415;70209.64895175492;70543;81157.59421203092;83121;83398.16601833903;7899.0521137463875;8058.19418058213;8141.145179756278;8203.261706446448;8297.25324720778;11380.829287560528;11802.58690945847;12031;12531.624051278477;12917.253996340956;9558.713238602853;10755.838662419914;10831.891681083089;10930.672079837617;11311.943440282746;10687.625933092304;10702.571897124028;10820.080293174853;10861.565537378416;11318.32090074598;11193;11462;11475.827862582235;11661.6501504955;11670.533178673099;7900.644470998704;7972.441929065142;8255.174482551696;8265.793355166168;8335.58295089824;8976.371653984159;11044;11148.944255278671;11201.66395008151;11271.267367621078 12:12:51 INFO - PROCESS | 1643 | |3;mootools.html;1423.864732850379;1588.3487770014292;1612.459825958304;1822.6628073806346;1935.5161209697567;8349.874751878719;8914.910850891489;9074.863877041842;9388.671396501124;9394.295427842904;8536.445131066477;9046.3667543272;9109.180173784358;9416.529173541312;9419.387739796908;2226.3432287475234;2454.3864033991504;2490.2155820916355;2492.476579918219;2504.962425563618;2443.8289319747623;2481.528509583173;2485.005997600965;2485.9378515537073;2488.8382255153447;2447.5349683560157;2476.232367965927;2476.455179860428;2486.3038349262147;2493.925182244536;2423.745506721795;2448.571499987495;2455.2143314139485;2465.124880667373;2467.432490527171;2222.3666255117214;2427.682350012447;2460.8646524441147;2464.112919349033;2467.469494058786;9137.543122843832;9293.58178881952;9462.479563623998;9464.148226659634;9490.098440648197;5554.389017208104;5811.883762324772;5820.912686309709;5826.796062137847;5835.824925252206;3497.8600855965733;3804.1821008483034;3847.4998250227572;3866.149447121657;3884.3008258513455;1014.2697257974247;1122.4556090296282;1126.5831642292405;1145.0953746540224;1155.4915837031679;12439.75120497585;12448.066395020409;12590.37048147589;12597.244165350017;12600.621981340575;4939.185034469344;4939.2097264438235;5035.823746168867;5119.846404607868;5140.280360749498;10855.457227138611;10860.348379097122;10863.51114199863;10863.945680271549;10885.891141088647;5764.221830052973;5771.59598828078;5771.942280577225;5773.566982476331;5779.826605201851;4471.998882748475;4719.905601887943;4813.278008298783;5197.558207552324;5236.188390799432;4257.106007738348;4282.336237883133;4372.606465418127;4381.255186618282;4385.539518350591;1317.7957416600443;1334.5129027904745;1339.7990301454665;1346.037583128068;1355.1868878672717;811.5130921447203;844.273924424994;911.3119594705954;951.9190868776093;963.3689933093834;5990.131430942576;6064.241969753781;6174.135621013062;6185.319614842364;6319.842003949938;984.1683777208248;994.8656931314325;996.1731762636994;1052.147760314148;1073.6242315189777;3959.2081583682802;4091.284025295561;4131.421600975866;4191.036061705764;4213.768242746678;11449.542018319175;11768.94115529417;11816.35010074437;11823.113266505046;11831.645050648494;11729.296242225493;11757.647270581896;11768.88231117695;11771.293722376684;11810.527578896748;8379.994400671958;8863.778405539784;8974.641014359353;9002.819943601091;9023.142801433853;6094.8171554853425;6113.23584551931;6324.747010119544;6342.556021078664;6348.365163483615;9199.954000230224;10565.26043177001;10575.576976920836;10878.184136189659;10882.12942964545;10023.54894029785;10323.277370583986;10359.533820977924;10728.785424291314;10778.461076945965;7463.888041679271;7650.426218033558;7650.426218033781;7668.501547399401;7810;7644.273793989562;8642.178992995656;8790.94508658965;8795.296376290009;8886.155815197546;7711.768646940601;7795.103563090317;7892.526448413114;7933.9603301983125;8022.638981245741;7666.425018123775;7729.729459468892;7745.845083098419;7771.727989520566;7892.802679933047;7247.818804529929;7307.451941104545;7375.11498620169;7401.407887369105;7462.888056679263;5319.46805319465;5340.145576707708;5342.839714808562;5361.678299302054;5391.487808658171;5243.842684719464;5263.394709608444;5305.522502974596;5309.893802124013;5363.5440987516495 12:12:51 INFO - PROCESS | 1643 | |4;prototype.html;311.28715242095603;318.53652934979607;320.92137426330544;324.90740139060375;328.66968696460054;4781.804548862784;5121.873187898661;5343;5357.598180136486;5436.673799572029;4418.315161150019;5036.647434679574;5189.247559103927;5294.1529355303155;5359.347123174034;3161.5889934308566;3919.451276821247;3997.800109994503;4039.8788036358956;4094.4267802507675;4037.9394309085387;4041.6864519031287;4055.574164712707;4080.2655522006025;4095.324271495215;3711.66380103164;3752.785856344756;4014.417909403149;4015.1969606078756;4017.5781542938007;3402.519903841837;3540.858365665383;3891.610838916114;4064.756114633117;4068.9186216275803;2983.9104826855228;3153.495440729472;3538.8053657048854;3558.1104723819044;3573.8927832165077;4550.658700597469;4802.183628783116;4897.681650692693;5099.770510327045;5124.769385377667;3710.628937106295;4661.90445245367;4670.7664616769025;4676.976615116937;4699.342092107107;4389.956100438987;4822.180229361017;5415.810446634349;5514.310711161105;5545.306836645419;3908.609139086097;3917.6278253565865;3919.333713268751;3936.193080418507;3975.582563830785;5464.743109084933;5828.300603927513;5830.591858569902;5840.766369345221;5863.5016023638045;3359.8656053757577;3968.3849003404516;3974.741641793274;3980.5422376426504;3989.5810939851476;3589.433555008182;4030.858919937788;4044.170944956277;4063.776492292893;4079.4900637420324;4234.0523359255085;4291.270484017662;4560.4071470708595;4652.232381657056;4685.882852928704;4728.692634978715;4951.90096198074;5374.52200644818;5568.6101972862325;5571.66570005801;1353.64128505946;1378.1730961423266;1381.8756311931975;1387.0983860490762;1387.438087574534;742.324484718914;804.7384600005022;812.5815205169342;857.9790049840669;862.1507814802414;3954.5254569451276;4759.738214398172;4842.910345172308;5013.521011301602;5177.508136727005;5682.52810027631;5684.516816070598;5703.828885133453;5705.942940570624;5759.963206622764;4325.853648783075;4732.313814496879;5135.460776618476;5152.793888244429;5153.3558305211845;2922.3570814420796;2969.3170570768843;2970.643522777237;2977.985110074479;2989.536621823621;4929.500054961018;5836.445537673914;5866.501347385435;5887.558433117533;5897.64614123154;4693.741844198534;5558.277423934863;5821.438567030493;5866.765329386777;5878.911816322759;4986.401631804207;5675.574331925122;5967.731452084667;6001.459868611759;6016.556026553596;4603.263477843529;4916.950830491649;5134.974325128351;5757.631785405585;5803.970980145073;4311.827526898889;4753.6672432930745;4756.643251756202;5184.922226166535;5671.489565939085;5901.616394934315;5920.348761636131;5944.970275148597;6040.969795150996;6062.757489700362;3773.660370566662;3874.6706529945272;3883.3980732986433;3911;3911.4328422379167;4782.187028205144;4838.177509823268;5862.853428664317;5864.472197502245;5866.765329386777;4963.851084467472;5620.875824834968;5652.745626446902;5672.631278966854;5684.7441865117;4819;5294.417614062527;5549.028919939075;5563.415841336763;5576.275084239023;5503.147012213113;5539.556835453073;5541.861453463695;5588.329400471806;5617.185508101385;5175.534201921845;5331.733413329395;5419;5559.444055594408;5693;4750.812296925768;5078.908034772541;5301.443348448357;5450.91823622638;5497.422770609189 12:12:51 INFO - PROCESS | 1643 | |5;yui.html;658.338369938212;714.8597986211993;787.6770524085126;817.3665409307786;852.1435956863353;16084.517464476055;17144.228509717093;17178.82821171788;17179.226934787934;17184.82815171848;15416.845831541681;15458.381664733397;15464.149471779048;15482.84517154828;15490;717.386634427566;741.8219627289438;753.3370633842211;874.1520724896872;911.1617312072909;904.6019751309435;919.4896832258094;922.4695799915042;926.305271046715;931.6925414613195;985.0051448037462;985.2807450561095;987.4815721746069;987.9922479071342;989.1246247071322;978.3445091788483;978.5009645080988;982.5774916785779;983.4590974963742;985.7042887133903;732.9010583571203;734.7281505842819;735.1766022055278;739.5451797144771;748.3713680508399;15420.151891645955;15598.298076586581;15630.843691563052;15636.687266254612;15641.296141673653;12312.876871231263;15233.695326093526;15299.617509562238;15321;15346.07923524581;11995.16033877629;12063.93968030163;12198.451069701885;12398.31809250491;12451.750964980649;3904.4728961590104;3972.8013599320207;4021.9195616087513;4036.6568841648495;4044.5550989391145;102212.93361199176;102536;102867;102976.48511757469;103928.99999999924;11571.305721656727;11581.363025033705;11963.581274655346;11996.040316774637;12010.459529321202;24271;24337.63493547598;24364.634530482057;24500.509989800103;24561.631575526382;6878.312168783082;7854.450188486751;7979.72070977513;8110.716124935599;8305.211004954519;4522.570355816192;4568.406107206042;4637.842567916951;4643.3731446255;4657.557532034519;3584.2473080653353;3731.0858839584475;3733.6266373362446;3736;3736.663700266989;670.1154476091609;674.3458844920419;677.7187467201155;679.5616827146463;680.0886811672383;477.51770711581554;624.5815303746501;662.4303099334569;663.4857985061519;665.5208250059949;8934.374593778373;9019.549022548847;9484.762880927894;9624.807503850025;9783.510824458748;591.3288417645916;670.276101810044;692.4149094015548;709.2517394149222;752.3341842469345;4263.893402664959;4842.903141937141;4941.48114447985;4946.3817022872145;4963.131451995886;94686;95017.09965800645;124252;150794;160354.19822900812;124136.75863241432;130882;130892.3455382717;130934;137442;89721.55139224262;97481.51259243659;106834.46582767037;115465.84534154719;116544;9907.015723521361;9959.800803984024;10133.594656213963;10437.904020077782;10573;57361.565960851316;58606.413935860095;59907;60924.69537652283;67492.662536687;92564.53717731369;95443;96950.51524742332;98545;101502.49248753709;11874;13828.861711382757;13844.515441959484;13872;13905.791413128609;14963.627642991187;15219.239038047832;15315.61710957235;15759.606009849846;16011.919940400223;14441.205733684748;14611.269436528344;14971.251437428304;15162.469313573973;15551.84448155504;12224.266544007389;14583.85416145825;14772.261386930395;15312.693746125238;15367.538973830802;14131.64670883236;14166.362513686703;14409.973905479967;15175.16536590498;15210.695786084438;9703.5148242589;11351.318920864775;11561;12022.879771202175;12366.381680916098;11030.669079927615;11808.527658893892;11971.760564788481;12060.939695301468;12069.698257543632 12:12:51 INFO - PROCESS | 1643 | __end_tp_report 12:12:51 INFO - PROCESS | 1643 | __start_cc_report 12:12:51 INFO - PROCESS | 1643 | _x_x_mozilla_cycle_collect,1371 12:12:51 INFO - PROCESS | 1643 | __end_cc_report 12:12:51 INFO - PROCESS | 1643 | __startTimestamp1479672771083__endTimestamp 12:12:51 INFO - PROCESS | 1643 | 12:12:51 INFO - PROCESS | 1643 | ------- Summary: start ------- 12:12:51 INFO - PROCESS | 1643 | Number of tests: 6 12:12:51 INFO - PROCESS | 1643 | 12:12:51 INFO - PROCESS | 1643 | [#0] dojo.html Cycles:165 Average:5693.92 Median:5936.94 stddev:635.73 (10.7%) stddev-sans-first:598.03 12:12:51 INFO - PROCESS | 1643 | Values: 2876.8 3444.4 3491.2 3523.1 3536.8 5646.9 5694.9 5740.6 5744.8 5760.9 5680.9 5774.4 5774.9 5776.9 5783.6 4772.4 4988.1 5186.8 5193.2 5210.8 5151.1 5159.6 5278.4 5283.1 5329.2 5119.9 5156.2 5184.8 5209.2 5210.3 5177.0 5180.0 5240.8 5252.6 5256.5 5080.2 5111.6 5194.1 5206.3 5220.2 5607.1 5636.4 5636.8 5671.3 5671.5 6115.9 6134.4 6164.9 6184.3 6204.8 5120.4 6122.4 6204.4 6207.2 6241.6 4894.2 5703.3 5718.0 5798.9 5846.1 6168.0 6214.5 6215.2 6226.1 6247.1 6112.1 6128.3 6143.8 6150.3 6164.4 6104.3 6143.5 6144.1 6173.2 6175.7 6194.7 6195.5 6203.2 6213.5 6216.0 5936.9 6140.9 6141.3 6214.4 6223.1 4830.5 4885.5 4899.5 4966.2 4972.3 4423.2 4471.4 4488.8 4496.3 4542.3 5755.8 5759.1 5769.0 5769.9 5777.0 6079.0 6190.1 6209.8 6227.3 6229.9 5667.0 5667.3 5701.5 5721.5 5726.1 5396.6 5416.5 5417.4 5432.0 5435.6 6269.2 6272.2 6273.6 6281.4 6431.0 6107.6 6111.9 6130.1 6141.4 6194.3 6241.0 6254.2 6254.2 6255.4 6269.9 6081.6 6159.3 6161.7 6162.3 6177.1 4578.9 5589.0 6116.9 6144.9 6187.0 5210.9 6041.4 6135.9 6147.3 6151.6 5149.8 6119.3 6126.4 6129.2 6148.3 5730.0 5877.1 5987.9 5994.9 6012.7 6040.9 6064.0 6086.2 6107.8 6139.1 6028.7 6031.8 6046.8 6064.2 6076.8 12:12:51 INFO - PROCESS | 1643 | 12:12:51 INFO - PROCESS | 1643 | [#1] ext.html Cycles:180 Average:74483.53 Median:20095.21 stddev:164730.07 (819.7%) stddev-sans-first:165098.45 12:12:51 INFO - PROCESS | 1643 | Values: 470.9 500.7 509.2 535.7 547.2 27536.2 31875.7 32686.9 32789.8 41544.0 44259.3 45022.1 45038.5 45069.8 45147.8 9938.4 10113.8 10114.8 10116.6 10134.1 9303.5 9533.5 9763.5 9868.2 12029.3 12216.8 12422.4 12428.9 12451.8 12469.2 12288.1 12351.2 12375.4 12381.4 12415.4 12214.9 12285.8 12302.7 12304.6 12337.1 41552.6 41902.2 41961.0 41976.2 42098.8 3425.7 3689.4 3766.4 3903.1 4180.0 31396.2 31442.7 31620.5 31825.8 32059.5 3352.3 3430.6 3456.9 3463.0 3479.1 514071.0 514365.0 514540.0 515571.0 517894.0 62049.8 62526.7 62548.0 62562.4 62751.7 36501.0 37172.9 37187.1 37995.4 38433.4 17848.8 18028.9 18052.7 18055.3 18058.9 13742.5 13840.6 13858.3 13861.1 13900.2 15434.6 17889.9 19294.0 19309.0 20378.5 6636.8 8062.8 8066.9 8094.6 8173.3 879.4 1021.2 1108.7 1125.7 1150.2 30297.7 30386.9 30970.8 31080.4 31187.5 1064.8 1122.7 1130.3 1149.5 1167.3 14071.5 16194.5 16198.4 16240.6 16593.4 683917.0 686186.0 687583.0 687988.0 689579.0 61634.0 62151.4 62186.8 62257.1 62277.1 1320.6 1352.1 1397.1 1448.1 1473.3 30469.0 32458.5 32465.5 32629.0 33352.5 50841.5 58263.7 60036.7 60351.7 64152.0 628765.0 628924.0 633564.0 635959.0 637579.0 35991.0 37528.4 38764.8 41762.0 45021.8 47584.5 49060.8 49246.8 49405.8 49624.3 34700.5 39683.8 40231.8 40500.4 41907.0 40337.0 40852.6 40911.8 41412.0 42560.4 38215.4 39047.0 39131.3 39132.0 39175.8 31121.9 31502.5 32766.7 33762.0 37893.1 24323.5 26275.9 26656.0 26902.6 26904.3 12:12:51 INFO - PROCESS | 1643 | 12:12:51 INFO - PROCESS | 1643 | [#2] jquery.html Cycles:180 Average:36297.42 Median:22064.67 stddev:107034.56 (485.1%) stddev-sans-first:107300.85 12:12:51 INFO - PROCESS | 1643 | Values: 383.8 384.0 384.3 394.6 412.2 14675.8 20249.9 20933.4 21590.6 21646.9 16773.9 19854.5 21147.7 21345.7 21412.8 6017.9 6362.6 6362.7 6370.9 6391.4 6090.5 6097.3 6147.3 6282.7 6319.3 6254.3 6255.4 6255.7 6278.0 6281.6 5950.6 6150.9 6210.6 6217.7 6233.6 5430.8 5432.9 5443.1 5444.6 5447.4 25101.0 26185.1 26407.0 26609.9 26661.0 2170.3 2233.7 2298.8 2303.2 2907.9 10242.5 10256.5 10304.2 10384.4 10713.2 1931.9 1950.4 1981.6 1982.6 1995.0 101626.5 113830.0 127291.4 127913.0 129001.4 11205.4 11272.2 11710.5 11893.6 12132.6 15047.6 15066.5 15080.9 15094.1 15107.1 8002.3 8330.2 8338.7 8601.2 8799.6 8918.0 9049.6 9049.8 9052.7 9171.7 4112.2 4446.4 4624.0 4641.8 4692.0 1834.1 1853.6 1854.0 1897.9 1947.1 929.4 980.2 1017.3 1025.0 1027.0 20694.4 22016.6 22043.6 22063.4 22065.9 946.3 949.7 954.5 968.4 1016.5 11037.7 11627.2 11779.5 11819.3 11832.7 636585.0 639593.0 646467.8 647762.0 654179.0 106108.5 109589.0 118521.0 121727.0 128056.0 985.3 1046.6 1060.6 1061.8 1062.7 19324.8 19417.7 20020.5 20023.4 20068.0 55381.4 55637.9 56181.7 57837.8 59307.7 70209.6 70543.0 81157.6 83121.0 83398.2 7899.1 8058.2 8141.1 8203.3 8297.3 11380.8 11802.6 12031.0 12531.6 12917.3 9558.7 10755.8 10831.9 10930.7 11311.9 10687.6 10702.6 10820.1 10861.6 11318.3 11193.0 11462.0 11475.8 11661.7 11670.5 7900.6 7972.4 8255.2 8265.8 8335.6 8976.4 11044.0 11148.9 11201.7 11271.3 12:12:51 INFO - PROCESS | 1643 | 12:12:51 INFO - PROCESS | 1643 | [#3] mootools.html Cycles:180 Average:6064.99 Median:4987.52 stddev:3431.83 (68.8%) stddev-sans-first:3423.74 12:12:51 INFO - PROCESS | 1643 | Values: 1423.9 1588.3 1612.5 1822.7 1935.5 8349.9 8914.9 9074.9 9388.7 9394.3 8536.4 9046.4 9109.2 9416.5 9419.4 2226.3 2454.4 2490.2 2492.5 2505.0 2443.8 2481.5 2485.0 2485.9 2488.8 2447.5 2476.2 2476.5 2486.3 2493.9 2423.7 2448.6 2455.2 2465.1 2467.4 2222.4 2427.7 2460.9 2464.1 2467.5 9137.5 9293.6 9462.5 9464.1 9490.1 5554.4 5811.9 5820.9 5826.8 5835.8 3497.9 3804.2 3847.5 3866.1 3884.3 1014.3 1122.5 1126.6 1145.1 1155.5 12439.8 12448.1 12590.4 12597.2 12600.6 4939.2 4939.2 5035.8 5119.8 5140.3 10855.5 10860.3 10863.5 10863.9 10885.9 5764.2 5771.6 5771.9 5773.6 5779.8 4472.0 4719.9 4813.3 5197.6 5236.2 4257.1 4282.3 4372.6 4381.3 4385.5 1317.8 1334.5 1339.8 1346.0 1355.2 811.5 844.3 911.3 951.9 963.4 5990.1 6064.2 6174.1 6185.3 6319.8 984.2 994.9 996.2 1052.1 1073.6 3959.2 4091.3 4131.4 4191.0 4213.8 11449.5 11768.9 11816.4 11823.1 11831.6 11729.3 11757.6 11768.9 11771.3 11810.5 8380.0 8863.8 8974.6 9002.8 9023.1 6094.8 6113.2 6324.7 6342.6 6348.4 9200.0 10565.3 10575.6 10878.2 10882.1 10023.5 10323.3 10359.5 10728.8 10778.5 7463.9 7650.4 7650.4 7668.5 7810.0 7644.3 8642.2 8790.9 8795.3 8886.2 7711.8 7795.1 7892.5 7934.0 8022.6 7666.4 7729.7 7745.8 7771.7 7892.8 7247.8 7307.5 7375.1 7401.4 7462.9 5319.5 5340.1 5342.8 5361.7 5391.5 5243.8 5263.4 5305.5 5309.9 5363.5 12:12:51 INFO - PROCESS | 1643 | 12:12:51 INFO - PROCESS | 1643 | [#4] prototype.html Cycles:180 Average:4482.06 Median:4870.30 stddev:1373.70 (28.2%) stddev-sans-first:1341.40 12:12:51 INFO - PROCESS | 1643 | Values: 311.3 318.5 320.9 324.9 328.7 4781.8 5121.9 5343.0 5357.6 5436.7 4418.3 5036.6 5189.2 5294.2 5359.3 3161.6 3919.5 3997.8 4039.9 4094.4 4037.9 4041.7 4055.6 4080.3 4095.3 3711.7 3752.8 4014.4 4015.2 4017.6 3402.5 3540.9 3891.6 4064.8 4068.9 2983.9 3153.5 3538.8 3558.1 3573.9 4550.7 4802.2 4897.7 5099.8 5124.8 3710.6 4661.9 4670.8 4677.0 4699.3 4390.0 4822.2 5415.8 5514.3 5545.3 3908.6 3917.6 3919.3 3936.2 3975.6 5464.7 5828.3 5830.6 5840.8 5863.5 3359.9 3968.4 3974.7 3980.5 3989.6 3589.4 4030.9 4044.2 4063.8 4079.5 4234.1 4291.3 4560.4 4652.2 4685.9 4728.7 4951.9 5374.5 5568.6 5571.7 1353.6 1378.2 1381.9 1387.1 1387.4 742.3 804.7 812.6 858.0 862.2 3954.5 4759.7 4842.9 5013.5 5177.5 5682.5 5684.5 5703.8 5705.9 5760.0 4325.9 4732.3 5135.5 5152.8 5153.4 2922.4 2969.3 2970.6 2978.0 2989.5 4929.5 5836.4 5866.5 5887.6 5897.6 4693.7 5558.3 5821.4 5866.8 5878.9 4986.4 5675.6 5967.7 6001.5 6016.6 4603.3 4917.0 5135.0 5757.6 5804.0 4311.8 4753.7 4756.6 5184.9 5671.5 5901.6 5920.3 5945.0 6041.0 6062.8 3773.7 3874.7 3883.4 3911.0 3911.4 4782.2 4838.2 5862.9 5864.5 5866.8 4963.9 5620.9 5652.7 5672.6 5684.7 4819.0 5294.4 5549.0 5563.4 5576.3 5503.1 5539.6 5541.9 5588.3 5617.2 5175.5 5331.7 5419.0 5559.4 5693.0 4750.8 5078.9 5301.4 5450.9 5497.4 12:12:51 INFO - PROCESS | 1643 | 12:12:51 INFO - PROCESS | 1643 | [#5] yui.html Cycles:180 Average:24466.75 Median:3732.36 stddev:37525.50 (1005.4%) stddev-sans-first:37588.19 12:12:51 INFO - PROCESS | 1643 | Values: 658.3 714.9 787.7 817.4 852.1 16084.5 17144.2 17178.8 17179.2 17184.8 15416.8 15458.4 15464.1 15482.8 15490.0 717.4 741.8 753.3 874.2 911.2 904.6 919.5 922.5 926.3 931.7 985.0 985.3 987.5 988.0 989.1 978.3 978.5 982.6 983.5 985.7 732.9 734.7 735.2 739.5 748.4 15420.2 15598.3 15630.8 15636.7 15641.3 12312.9 15233.7 15299.6 15321.0 15346.1 11995.2 12063.9 12198.5 12398.3 12451.8 3904.5 3972.8 4021.9 4036.7 4044.6 102212.9 102536.0 102867.0 102976.5 103929.0 11571.3 11581.4 11963.6 11996.0 12010.5 24271.0 24337.6 24364.6 24500.5 24561.6 6878.3 7854.5 7979.7 8110.7 8305.2 4522.6 4568.4 4637.8 4643.4 4657.6 3584.2 3731.1 3733.6 3736.0 3736.7 670.1 674.3 677.7 679.6 680.1 477.5 624.6 662.4 663.5 665.5 8934.4 9019.5 9484.8 9624.8 9783.5 591.3 670.3 692.4 709.3 752.3 4263.9 4842.9 4941.5 4946.4 4963.1 94686.0 95017.1 124252.0 150794.0 160354.2 124136.8 130882.0 130892.3 130934.0 137442.0 89721.6 97481.5 106834.5 115465.8 116544.0 9907.0 9959.8 10133.6 10437.9 10573.0 57361.6 58606.4 59907.0 60924.7 67492.7 92564.5 95443.0 96950.5 98545.0 101502.5 11874.0 13828.9 13844.5 13872.0 13905.8 14963.6 15219.2 15315.6 15759.6 16011.9 14441.2 14611.3 14971.3 15162.5 15551.8 12224.3 14583.9 14772.3 15312.7 15367.5 14131.6 14166.4 14410.0 15175.2 15210.7 9703.5 11351.3 11561.0 12022.9 12366.4 11030.7 11808.5 11971.8 12060.9 12069.7 12:12:51 INFO - PROCESS | 1643 | -------- Summary: end -------- 12:12:51 INFO - PROCESS | 1643 | 12:12:51 INFO - TEST-INFO | 1643: exit 0 12:12:51 INFO - TEST-OK | dromaeo_css | took 1114868ms 12:12:51 INFO - TEST-START | kraken 12:12:51 INFO - operating with platform_type : mac_ 12:12:51 INFO - Initialising browser for kraken test... 12:12:51 INFO - TEST-INFO | started process 1650 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/tmpFz1zne/profile http://localhost:49237/getInfo.html) 12:12:53 INFO - PROCESS | 1650 | __metrics Screen width/height:1600/1200 12:12:53 INFO - PROCESS | 1650 | colorDepth:24 12:12:53 INFO - PROCESS | 1650 | Browser inner width/height: 1024/689 12:12:53 INFO - PROCESS | 1650 | __metrics 12:12:53 INFO - PROCESS | 1650 | 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" 12:12:53 INFO - PROCESS | 1650 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 12:12:54 INFO - TEST-INFO | 1650: exit 0 12:12:54 INFO - Browser initialized. 12:12:54 INFO - Running cycle 1/1 for kraken test... 12:12:54 INFO - TEST-INFO | started process 1652 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/tmpFz1zne/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:13:06 INFO - PROCESS | 1652 | RSS: Main: 168288256 12:13:06 INFO - PROCESS | 1652 | 12:13:09 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49237/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49237/tests/kraken/driver.html?testName=audio-beat-detection) 12:13:09 INFO - PROCESS | 1652 | RSS: Main: 218865664 12:13:09 INFO - PROCESS | 1652 | 12:13:12 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49237/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49237/tests/kraken/driver.html?testName=audio-dft) 12:13:12 INFO - PROCESS | 1652 | RSS: Main: 228286464 12:13:12 INFO - PROCESS | 1652 | 12:13:16 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49237/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49237/tests/kraken/driver.html?testName=audio-fft) 12:13:16 INFO - PROCESS | 1652 | RSS: Main: 325079040 12:13:16 INFO - PROCESS | 1652 | 12:13:18 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49237/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49237/tests/kraken/driver.html?testName=audio-oscillator) 12:13:19 INFO - PROCESS | 1652 | RSS: Main: 228585472 12:13:19 INFO - PROCESS | 1652 | 12:13:21 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49237/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49237/tests/kraken/driver.html?testName=imaging-gaussian-blur) 12:13:21 INFO - PROCESS | 1652 | RSS: Main: 229294080 12:13:21 INFO - PROCESS | 1652 | 12:13:24 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49237/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49237/tests/kraken/driver.html?testName=imaging-darkroom) 12:13:25 INFO - PROCESS | 1652 | RSS: Main: 267259904 12:13:25 INFO - PROCESS | 1652 | 12:13:28 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49237/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49237/tests/kraken/driver.html?testName=imaging-desaturate) 12:13:28 INFO - PROCESS | 1652 | RSS: Main: 267501568 12:13:28 INFO - PROCESS | 1652 | 12:13:31 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49237/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49237/tests/kraken/driver.html?testName=json-parse-financial) 12:13:31 INFO - PROCESS | 1652 | RSS: Main: 265195520 12:13:31 INFO - PROCESS | 1652 | 12:13:33 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49237/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49237/tests/kraken/driver.html?testName=json-stringify-tinderbox) 12:13:34 INFO - PROCESS | 1652 | RSS: Main: 241057792 12:13:34 INFO - PROCESS | 1652 | 12:13:35 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49237/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49237/tests/kraken/driver.html?testName=stanford-crypto-aes) 12:13:36 INFO - PROCESS | 1652 | RSS: Main: 245039104 12:13:36 INFO - PROCESS | 1652 | 12:13:38 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49237/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49237/tests/kraken/driver.html?testName=stanford-crypto-ccm) 12:13:39 INFO - PROCESS | 1652 | RSS: Main: 255877120 12:13:39 INFO - PROCESS | 1652 | 12:13:42 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49237/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49237/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 12:13:42 INFO - PROCESS | 1652 | RSS: Main: 266010624 12:13:42 INFO - PROCESS | 1652 | 12:13:45 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49237/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49237/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 12:13:46 INFO - PROCESS | 1652 | RSS: Main: 259710976 12:13:46 INFO - PROCESS | 1652 | 12:13:47 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49237/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49237/tests/kraken/driver.html?testName=ai-astar) 12:13:48 INFO - PROCESS | 1652 | RSS: Main: 303988736 12:13:48 INFO - PROCESS | 1652 | 12:13:48 INFO - PROCESS | 1652 | __start_tp_report 12:13:48 INFO - PROCESS | 1652 | _x_x_mozilla_page_load 12:13:48 INFO - PROCESS | 1652 | _x_x_mozilla_page_load_details 12:13:48 INFO - PROCESS | 1652 | |i|pagename|runs| 12:13:48 INFO - PROCESS | 1652 | |0;ai-astar;114;113;114;113;113;110;112;113;112;113 12:13:48 INFO - PROCESS | 1652 | |1;audio-beat-detection;139;107;105;141;107;107;106;106;134;105 12:13:48 INFO - PROCESS | 1652 | |2;audio-dft;185;183;186;184;182;183;184;184;185;183 12:13:48 INFO - PROCESS | 1652 | |3;audio-fft;81;57;58;99;81;79;72;58;81;58 12:13:48 INFO - PROCESS | 1652 | |4;audio-oscillator;88;71;94;71;68;71;90;69;55;90 12:13:48 INFO - PROCESS | 1652 | |5;imaging-gaussian-blur;86;86;87;88;120;83;87;83;87;83 12:13:48 INFO - PROCESS | 1652 | |6;imaging-darkroom;91;92;92;93;93;92;93;93;92;92 12:13:48 INFO - PROCESS | 1652 | |7;imaging-desaturate;86;84;84;85;86;86;85;82;84;85 12:13:48 INFO - PROCESS | 1652 | |8;json-parse-financial;53;50;51;50;54;54;56;55;54;55 12:13:48 INFO - PROCESS | 1652 | |9;json-stringify-tinderbox;63;73;63;73;71;67;72;68;68;71 12:13:48 INFO - PROCESS | 1652 | |10;stanford-crypto-aes;84;83;83;84;81;82;85;84;97;96 12:13:48 INFO - PROCESS | 1652 | |11;stanford-crypto-ccm;136;134;139;143;137;141;141;146;170;165 12:13:48 INFO - PROCESS | 1652 | |12;stanford-crypto-pbkdf2;159;158;157;157;161;158;158;155;159;158 12:13:48 INFO - PROCESS | 1652 | |13;stanford-crypto-sha256-iterative;65;65;66;63;64;63;64;65;64;64 12:13:48 INFO - PROCESS | 1652 | __end_tp_report 12:13:48 INFO - PROCESS | 1652 | __start_cc_report 12:13:48 INFO - PROCESS | 1652 | _x_x_mozilla_cycle_collect,1883 12:13:48 INFO - PROCESS | 1652 | __end_cc_report 12:13:48 INFO - PROCESS | 1652 | __startTimestamp1479672828198__endTimestamp 12:13:48 INFO - PROCESS | 1652 | 12:13:48 INFO - PROCESS | 1652 | ------- Summary: start ------- 12:13:48 INFO - PROCESS | 1652 | Number of tests: 14 12:13:48 INFO - PROCESS | 1652 | 12:13:48 INFO - PROCESS | 1652 | [#0] ai-astar Cycles:10 Average:112.70 Median:113.00 stddev:1.16 (1.0%) stddev-sans-first:1.13 12:13:48 INFO - PROCESS | 1652 | Values: 114.0 113.0 114.0 113.0 113.0 110.0 112.0 113.0 112.0 113.0 12:13:48 INFO - PROCESS | 1652 | 12:13:48 INFO - PROCESS | 1652 | [#1] audio-beat-detection Cycles:10 Average:115.70 Median:107.00 stddev:15.50 (14.5%) stddev-sans-first:13.96 12:13:48 INFO - PROCESS | 1652 | Values: 139.0 107.0 105.0 141.0 107.0 107.0 106.0 106.0 134.0 105.0 12:13:48 INFO - PROCESS | 1652 | 12:13:48 INFO - PROCESS | 1652 | [#2] audio-dft Cycles:10 Average:183.90 Median:184.00 stddev:1.20 (0.7%) stddev-sans-first:1.20 12:13:48 INFO - PROCESS | 1652 | Values: 185.0 183.0 186.0 184.0 182.0 183.0 184.0 184.0 185.0 183.0 12:13:48 INFO - PROCESS | 1652 | 12:13:48 INFO - PROCESS | 1652 | [#3] audio-fft Cycles:10 Average:72.40 Median:80.00 stddev:14.27 (17.8%) stddev-sans-first:14.79 12:13:48 INFO - PROCESS | 1652 | Values: 81.0 57.0 58.0 99.0 81.0 79.0 72.0 58.0 81.0 58.0 12:13:48 INFO - PROCESS | 1652 | 12:13:48 INFO - PROCESS | 1652 | [#4] audio-oscillator Cycles:10 Average:76.70 Median:79.50 stddev:12.84 (16.2%) stddev-sans-first:12.95 12:13:48 INFO - PROCESS | 1652 | Values: 88.0 71.0 94.0 71.0 68.0 71.0 90.0 69.0 55.0 90.0 12:13:48 INFO - PROCESS | 1652 | 12:13:48 INFO - PROCESS | 1652 | [#5] imaging-gaussian-blur Cycles:10 Average:89.00 Median:86.50 stddev:11.06 (12.8%) stddev-sans-first:11.67 12:13:48 INFO - PROCESS | 1652 | Values: 86.0 86.0 87.0 88.0 120.0 83.0 87.0 83.0 87.0 83.0 12:13:48 INFO - PROCESS | 1652 | 12:13:48 INFO - PROCESS | 1652 | [#6] imaging-darkroom Cycles:10 Average:92.30 Median:92.50 stddev:0.67 (0.7%) stddev-sans-first:0.53 12:13:48 INFO - PROCESS | 1652 | Values: 91.0 92.0 92.0 93.0 93.0 92.0 93.0 93.0 92.0 92.0 12:13:48 INFO - PROCESS | 1652 | 12:13:48 INFO - PROCESS | 1652 | [#7] imaging-desaturate Cycles:10 Average:84.70 Median:85.00 stddev:1.25 (1.5%) stddev-sans-first:1.24 12:13:48 INFO - PROCESS | 1652 | Values: 86.0 84.0 84.0 85.0 86.0 86.0 85.0 82.0 84.0 85.0 12:13:48 INFO - PROCESS | 1652 | 12:13:48 INFO - PROCESS | 1652 | [#8] json-parse-financial Cycles:10 Average:53.20 Median:54.00 stddev:2.15 (4.0%) stddev-sans-first:2.28 12:13:48 INFO - PROCESS | 1652 | Values: 53.0 50.0 51.0 50.0 54.0 54.0 56.0 55.0 54.0 55.0 12:13:48 INFO - PROCESS | 1652 | 12:13:48 INFO - PROCESS | 1652 | [#9] json-stringify-tinderbox Cycles:10 Average:68.90 Median:71.00 stddev:3.75 (5.3%) stddev-sans-first:3.32 12:13:48 INFO - PROCESS | 1652 | Values: 63.0 73.0 63.0 73.0 71.0 67.0 72.0 68.0 68.0 71.0 12:13:48 INFO - PROCESS | 1652 | 12:13:48 INFO - PROCESS | 1652 | [#10] stanford-crypto-aes Cycles:10 Average:85.90 Median:84.00 stddev:5.70 (6.8%) stddev-sans-first:6.01 12:13:48 INFO - PROCESS | 1652 | Values: 84.0 83.0 83.0 84.0 81.0 82.0 85.0 84.0 97.0 96.0 12:13:48 INFO - PROCESS | 1652 | 12:13:48 INFO - PROCESS | 1652 | [#11] stanford-crypto-ccm Cycles:10 Average:145.20 Median:142.00 stddev:12.31 (8.7%) stddev-sans-first:12.60 12:13:48 INFO - PROCESS | 1652 | Values: 136.0 134.0 139.0 143.0 137.0 141.0 141.0 146.0 170.0 165.0 12:13:48 INFO - PROCESS | 1652 | 12:13:48 INFO - PROCESS | 1652 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:158.00 Median:158.00 stddev:1.56 (1.0%) stddev-sans-first:1.62 12:13:48 INFO - PROCESS | 1652 | Values: 159.0 158.0 157.0 157.0 161.0 158.0 158.0 155.0 159.0 158.0 12:13:48 INFO - PROCESS | 1652 | 12:13:48 INFO - PROCESS | 1652 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.30 Median:64.50 stddev:0.95 (1.5%) stddev-sans-first:0.97 12:13:48 INFO - PROCESS | 1652 | Values: 65.0 65.0 66.0 63.0 64.0 63.0 64.0 65.0 64.0 64.0 12:13:48 INFO - PROCESS | 1652 | -------- Summary: end -------- 12:13:48 INFO - PROCESS | 1652 | 12:13:48 INFO - TEST-INFO | 1652: exit 0 12:13:49 INFO - TEST-OK | kraken | took 57346ms 12:13:49 INFO - SUITE-END | took 1172s 12:13:49 INFO - Completed test suite (00:19:32) 12:13:49 INFO - javascript benchmark 12:13:49 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2876.784241181911, 3444.362792883316, 3491.231928975626, 3523.0663874073357, 3536.8408421621025, 5646.887062258757, 5694.914576281359, 5740.56945729071, 5744.79893203738, 5760.884782304352, 5680.914786278209, 5774.3936886626825, 5774.855628609276, 5776.884462310762, 5783.5951483396175, 4772.403449568804, 4988.077205716954, 5186.844394668166, 5193.221016847484, 5210.7655155518, 5151.098557752378, 5159.58723302135, 5278.419373868871, 5283.128283833163, 5329.200619907026, 5119.923201151985, 5156.175011998081, 5184.766685499143, 5209.244659524366, 5210.270562121306, 5176.990486855065, 5180.04169228692, 5240.816571419982, 5252.6323157379, 5256.526912577886, 5080.212567052113, 5111.591072714211, 5194.065068287707, 5206.271122042879, 5220.216967454874, 5607.130894711327, 5636.379998200195, 5636.830895073154, 5671.262735844314, 5671.489565939044, 6115.938840611581, 6134.4172303631085, 6164.907526387108, 6184.319724830265, 6204.7828326008375, 5120.411152717411, 6122.367660829195, 6204.441600255998, 6207.224096987877, 6241.594296370767, 4894.167991441393, 5703.258576385085, 5717.971410142923, 5798.9130163047585, 5846.093855452412, 6168.001872109082, 6214.471769899609, 6215.192025036807, 6226.097215903668, 6247.0629405589525, 6112.113743507255, 6128.295246046672, 6143.784967526115, 6150.292716337678, 6164.383561643889, 6104.337893874325, 6143.481172719164, 6144.064619644798, 6173.197484327009, 6175.660338681416, 6194.659293738798, 6195.473384762256, 6203.16257305258, 6213.5339849511465, 6215.96892015537, 5936.9406305937255, 6140.92533806591, 6141.280441476394, 6214.40963108504, 6223.066540018943, 4830.492798256203, 4885.487023862514, 4899.510048995072, 4966.180580204298, 4972.279019542146, 4423.248047831877, 4471.441069866267, 4488.820447182076, 4496.258117410656, 4542.273236282179, 5755.798547050833, 5759.136129580513, 5769.0, 5769.913451298234, 5777.0467872801355, 6078.969605151946, 6190.102435146879, 6209.751609935552, 6227.314995350508, 6229.906551401733, 5667.036603777367, 5667.348254950651, 5701.543876489871, 5721.5136713379, 5726.055200891889, 5396.568274538027, 5416.458354164552, 5417.377001644862, 5431.972840135774, 5435.646682965595, 6269.153664255358, 6272.153259310117, 6273.592216505913, 6281.434670879551, 6430.967845160838, 6107.61364822091, 6111.86523267538, 6130.111133885473, 6141.36327073057, 6194.34959329282, 6241.032639940817, 6254.186955695731, 6254.21822272216, 6255.437010669061, 6269.937300626935, 6081.5742897996715, 6159.29168145669, 6161.72272247741, 6162.322144564184, 6177.135201071944, 4578.862634120982, 5588.996539106098, 6116.944513560587, 6144.893919094606, 6186.969065154825, 5210.947890521046, 6041.426064523863, 6135.93706321624, 6147.323794382703, 6151.630902145886, 5149.794008239628, 6119.296280927751, 6126.417990290915, 6129.203203583684, 6148.262208535004, 5729.9713501432225, 5877.059670452707, 5987.880242395215, 5994.880102398015, 6012.729427175875, 6040.879182416239, 6063.9547617625885, 6086.239220097488, 6107.786227482017, 6139.140520327069, 6028.668423236764, 6031.7587296507645, 6046.818595442144, 6064.211652485149, 6076.78731244422], "value": 5655.467505099405, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [470.90346478971816, 500.68206688752633, 509.19547115557424, 535.6652092442224, 547.1928904865322, 27536.17391478254, 31875.681243187562, 32686.855960041405, 32789.836050819744, 41543.961400964916, 44259.33610995838, 45022.09955800882, 45038.54961450385, 45069.774651126696, 45147.77426112873, 9938.354006989559, 10113.848292275621, 10114.848277275847, 10116.645917392892, 10134.13859821916, 9303.488308143049, 9533.47565883876, 9763.511824408786, 9868.161206297438, 12029.278243305385, 12216.755664886698, 12422.440990155465, 12428.875711242907, 12451.813222801666, 12469.189502682297, 12288.139830211889, 12351.19717218378, 12375.381230938507, 12381.380930953417, 12415.379231038458, 12214.938925305405, 12285.754284914252, 12302.692432689164, 12304.569340073054, 12337.074719396081, 41552.58447415518, 41902.161956760996, 41961.0, 41976.16047679029, 42098.78950605258, 3425.6745609167087, 3689.4281386384887, 3766.3785475396526, 3903.0827755477726, 4180.038591124028, 31396.21509462259, 31442.685573144205, 31620.525692114636, 31825.840870795728, 32059.51910721341, 3352.346292472969, 3430.5540279763472, 3456.9283522108226, 3463.0476618929742, 3479.1476088358513, 514071.0, 514364.9999999963, 514540.0, 515571.0, 517894.0, 62049.75900481965, 62526.687366562874, 62548.0, 62562.374376256565, 62751.68624156941, 36501.0, 37172.88481345564, 37187.07032324159, 37995.430068548994, 38433.42349864754, 17848.821511784718, 18028.909855450638, 18052.729209061876, 18055.277788888296, 18058.909705451388, 13742.519011834738, 13840.584782456543, 13858.307084645727, 13861.099028563312, 13900.235487048107, 15434.6141346465, 17889.910550447425, 19294.03529823503, 19309.03928064381, 20378.490537736674, 6636.767713130017, 8062.7581172564915, 8066.919330806734, 8094.635741391651, 8173.305269052078, 879.3800370738614, 1021.2493817044466, 1108.661858133261, 1125.7391721272227, 1150.223599070624, 30297.697023029927, 30386.936457224332, 30970.84514577413, 31080.378392432478, 31187.532187017212, 1064.796779639003, 1122.6912599035331, 1130.3218069158438, 1149.5401839264362, 1167.3112863410458, 14071.507497237548, 16194.514164575081, 16198.433054843024, 16240.59398515023, 16593.41923032688, 683917.0, 686186.0, 687583.0, 687988.0, 689579.0, 61634.0, 62151.378486215464, 62186.75626487445, 62257.06614400788, 62277.06584401237, 1320.6368248731676, 1352.0670737191504, 1397.0988712280725, 1448.0877047460244, 1473.3222717549834, 30469.0, 32458.513122302713, 32465.513017304285, 32629.0, 33352.49971250482, 50841.49158508368, 58263.70868145632, 60036.69981650064, 60351.698241508515, 64152.03771943518, 628765.0, 628924.0, 633564.0, 635959.0, 637579.0, 35991.0, 37528.437073443376, 38764.80617596894, 41761.95595110147, 45021.77489112534, 47584.52415475801, 49060.75469622629, 49246.753766232374, 49405.75297123491, 49624.25563616621, 34700.47949280712, 39683.80158099191, 40231.79304620866, 40500.39249411202, 41907.0, 40337.0, 40852.59147408488, 40911.7954410226, 41412.0, 42560.36159457549, 38215.42676859905, 39047.0, 39131.282528159776, 39132.0, 39175.80412097921, 31121.91073312423, 31502.52746208763, 32766.672333277314, 33761.96038472092, 37893.05267368338, 24323.513529729662, 26275.948962041304, 26656.0, 26902.596461052708, 26904.32739181536], "value": 21130.669861784638, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [383.8349509710823, 384.0166570908039, 384.32359048075386, 394.56794809683385, 412.23736088236745, 14675.77986330206, 20249.8862562559, 20933.371998840023, 21590.568188636218, 21646.89176554117, 16773.91613041933, 19854.50363740907, 21147.682784758203, 21345.679814802792, 21412.785872141274, 6017.909731354033, 6362.5546211765195, 6362.650054247015, 6370.872582548346, 6391.392817682313, 6090.451859332659, 6097.3292937776805, 6147.323794382614, 6282.7172777224905, 6319.273283572379, 6254.312025677172, 6255.40573645503, 6255.655938923357, 6278.0269058296035, 6281.560290779625, 5950.613210141349, 6150.907736383958, 6210.565260431772, 6217.68911554425, 6233.625982441068, 5430.809921652763, 5432.891342173174, 5443.101888188444, 5444.6188766786345, 5447.400785913546, 25101.0, 26185.083522076635, 26407.0, 26609.866950665317, 26661.0, 2170.3163503496507, 2233.6761169630477, 2298.7816157465013, 2303.1823702585507, 2907.941841163165, 10242.48787560619, 10256.538455769509, 10304.227182961233, 10384.428856412895, 10713.196510261761, 1931.9130639121274, 1950.3856285270235, 1981.6333978213931, 1982.5638359560874, 1994.980050199494, 101626.47560286602, 113830.0, 127291.36354318261, 127913.0, 129001.35499322537, 11205.43972801373, 11272.154588405903, 11710.473028713557, 11893.643190704293, 12132.636020919386, 15047.623809404633, 15066.472673456596, 15080.924595376953, 15094.094354338775, 15107.093574385572, 8002.279794818494, 8330.166983301622, 8338.749837504885, 8601.22588966996, 8799.648014079365, 8918.0, 9049.638014479347, 9049.77375565616, 9052.683156089506, 9171.678991235274, 4112.218678451144, 4446.42196514451, 4624.0, 4641.767911604406, 4691.997121842024, 1834.1379551610721, 1853.5644123630937, 1853.981460185381, 1897.870766893696, 1947.1335255811027, 929.3680297397699, 980.1717548671361, 1017.2777328097134, 1025.0057444279037, 1026.9691909242736, 20694.379168624964, 22016.559668806534, 22043.559128817335, 22063.44841378946, 22065.889670551544, 946.3233787841726, 949.6818565780541, 954.4702690006974, 968.3608818179968, 1016.5476363018533, 11037.668869933916, 11627.186096973131, 11779.528818847322, 11819.290842549302, 11832.70418239551, 636585.0, 639593.0, 646467.7676611681, 647762.0, 654179.0, 106108.46945765222, 109589.0, 118521.0, 121727.0, 128056.0, 985.3348989432104, 1046.586598293685, 1060.6499855047816, 1061.8407238914224, 1062.7024433158729, 19324.8067519323, 19417.70873436928, 20020.49948751293, 20023.399298021082, 20068.0, 55381.446185539244, 55637.88724225412, 56181.71909140592, 57837.84324313574, 59307.703461482415, 70209.64895175492, 70543.0, 81157.59421203092, 83121.0, 83398.16601833903, 7899.0521137463875, 8058.19418058213, 8141.145179756278, 8203.261706446448, 8297.25324720778, 11380.829287560528, 11802.58690945847, 12031.0, 12531.624051278477, 12917.253996340956, 9558.713238602853, 10755.838662419914, 10831.891681083089, 10930.672079837617, 11311.943440282746, 10687.625933092304, 10702.571897124028, 10820.080293174853, 10861.565537378416, 11318.32090074598, 11193.0, 11462.0, 11475.827862582235, 11661.6501504955, 11670.533178673099, 7900.644470998704, 7972.441929065142, 8255.174482551696, 8265.793355166168, 8335.58295089824, 8976.371653984159, 11044.0, 11148.944255278671, 11201.66395008151, 11271.267367621078], "value": 9766.137231850069, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1423.864732850379, 1588.3487770014292, 1612.459825958304, 1822.6628073806346, 1935.5161209697567, 8349.874751878719, 8914.910850891489, 9074.863877041842, 9388.671396501124, 9394.295427842904, 8536.445131066477, 9046.3667543272, 9109.180173784358, 9416.529173541312, 9419.387739796908, 2226.3432287475234, 2454.3864033991504, 2490.2155820916355, 2492.476579918219, 2504.962425563618, 2443.8289319747623, 2481.528509583173, 2485.005997600965, 2485.9378515537073, 2488.8382255153447, 2447.5349683560157, 2476.232367965927, 2476.455179860428, 2486.3038349262147, 2493.925182244536, 2423.745506721795, 2448.571499987495, 2455.2143314139485, 2465.124880667373, 2467.432490527171, 2222.3666255117214, 2427.682350012447, 2460.8646524441147, 2464.112919349033, 2467.469494058786, 9137.543122843832, 9293.58178881952, 9462.479563623998, 9464.148226659634, 9490.098440648197, 5554.389017208104, 5811.883762324772, 5820.912686309709, 5826.796062137847, 5835.824925252206, 3497.8600855965733, 3804.1821008483034, 3847.4998250227572, 3866.149447121657, 3884.3008258513455, 1014.2697257974247, 1122.4556090296282, 1126.5831642292405, 1145.0953746540224, 1155.4915837031679, 12439.75120497585, 12448.066395020409, 12590.37048147589, 12597.244165350017, 12600.621981340575, 4939.185034469344, 4939.2097264438235, 5035.823746168867, 5119.846404607868, 5140.280360749498, 10855.457227138611, 10860.348379097122, 10863.51114199863, 10863.945680271549, 10885.891141088647, 5764.221830052973, 5771.59598828078, 5771.942280577225, 5773.566982476331, 5779.826605201851, 4471.998882748475, 4719.905601887943, 4813.278008298783, 5197.558207552324, 5236.188390799432, 4257.106007738348, 4282.336237883133, 4372.606465418127, 4381.255186618282, 4385.539518350591, 1317.7957416600443, 1334.5129027904745, 1339.7990301454665, 1346.037583128068, 1355.1868878672717, 811.5130921447203, 844.273924424994, 911.3119594705954, 951.9190868776093, 963.3689933093834, 5990.131430942576, 6064.241969753781, 6174.135621013062, 6185.319614842364, 6319.842003949938, 984.1683777208248, 994.8656931314325, 996.1731762636994, 1052.147760314148, 1073.6242315189777, 3959.2081583682802, 4091.284025295561, 4131.421600975866, 4191.036061705764, 4213.768242746678, 11449.542018319175, 11768.94115529417, 11816.35010074437, 11823.113266505046, 11831.645050648494, 11729.296242225493, 11757.647270581896, 11768.88231117695, 11771.293722376684, 11810.527578896748, 8379.994400671958, 8863.778405539784, 8974.641014359353, 9002.819943601091, 9023.142801433853, 6094.8171554853425, 6113.23584551931, 6324.747010119544, 6342.556021078664, 6348.365163483615, 9199.954000230224, 10565.26043177001, 10575.576976920836, 10878.184136189659, 10882.12942964545, 10023.54894029785, 10323.277370583986, 10359.533820977924, 10728.785424291314, 10778.461076945965, 7463.888041679271, 7650.426218033558, 7650.426218033781, 7668.501547399401, 7810.0, 7644.273793989562, 8642.178992995656, 8790.94508658965, 8795.296376290009, 8886.155815197546, 7711.768646940601, 7795.103563090317, 7892.526448413114, 7933.9603301983125, 8022.638981245741, 7666.425018123775, 7729.729459468892, 7745.845083098419, 7771.727989520566, 7892.802679933047, 7247.818804529929, 7307.451941104545, 7375.11498620169, 7401.407887369105, 7462.888056679263, 5319.46805319465, 5340.145576707708, 5342.839714808562, 5361.678299302054, 5391.487808658171, 5243.842684719464, 5263.394709608444, 5305.522502974596, 5309.893802124013, 5363.5440987516495], "value": 4853.360921951976, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [311.28715242095603, 318.53652934979607, 320.92137426330544, 324.90740139060375, 328.66968696460054, 4781.804548862784, 5121.873187898661, 5343.0, 5357.598180136486, 5436.673799572029, 4418.315161150019, 5036.647434679574, 5189.247559103927, 5294.1529355303155, 5359.347123174034, 3161.5889934308566, 3919.451276821247, 3997.800109994503, 4039.8788036358956, 4094.4267802507675, 4037.9394309085387, 4041.6864519031287, 4055.574164712707, 4080.2655522006025, 4095.324271495215, 3711.66380103164, 3752.785856344756, 4014.417909403149, 4015.1969606078756, 4017.5781542938007, 3402.519903841837, 3540.858365665383, 3891.610838916114, 4064.756114633117, 4068.9186216275803, 2983.9104826855228, 3153.495440729472, 3538.8053657048854, 3558.1104723819044, 3573.8927832165077, 4550.658700597469, 4802.183628783116, 4897.681650692693, 5099.770510327045, 5124.769385377667, 3710.628937106295, 4661.90445245367, 4670.7664616769025, 4676.976615116937, 4699.342092107107, 4389.956100438987, 4822.180229361017, 5415.810446634349, 5514.310711161105, 5545.306836645419, 3908.609139086097, 3917.6278253565865, 3919.333713268751, 3936.193080418507, 3975.582563830785, 5464.743109084933, 5828.300603927513, 5830.591858569902, 5840.766369345221, 5863.5016023638045, 3359.8656053757577, 3968.3849003404516, 3974.741641793274, 3980.5422376426504, 3989.5810939851476, 3589.433555008182, 4030.858919937788, 4044.170944956277, 4063.776492292893, 4079.4900637420324, 4234.0523359255085, 4291.270484017662, 4560.4071470708595, 4652.232381657056, 4685.882852928704, 4728.692634978715, 4951.90096198074, 5374.52200644818, 5568.6101972862325, 5571.66570005801, 1353.64128505946, 1378.1730961423266, 1381.8756311931975, 1387.0983860490762, 1387.438087574534, 742.324484718914, 804.7384600005022, 812.5815205169342, 857.9790049840669, 862.1507814802414, 3954.5254569451276, 4759.738214398172, 4842.910345172308, 5013.521011301602, 5177.508136727005, 5682.52810027631, 5684.516816070598, 5703.828885133453, 5705.942940570624, 5759.963206622764, 4325.853648783075, 4732.313814496879, 5135.460776618476, 5152.793888244429, 5153.3558305211845, 2922.3570814420796, 2969.3170570768843, 2970.643522777237, 2977.985110074479, 2989.536621823621, 4929.500054961018, 5836.445537673914, 5866.501347385435, 5887.558433117533, 5897.64614123154, 4693.741844198534, 5558.277423934863, 5821.438567030493, 5866.765329386777, 5878.911816322759, 4986.401631804207, 5675.574331925122, 5967.731452084667, 6001.459868611759, 6016.556026553596, 4603.263477843529, 4916.950830491649, 5134.974325128351, 5757.631785405585, 5803.970980145073, 4311.827526898889, 4753.6672432930745, 4756.643251756202, 5184.922226166535, 5671.489565939085, 5901.616394934315, 5920.348761636131, 5944.970275148597, 6040.969795150996, 6062.757489700362, 3773.660370566662, 3874.6706529945272, 3883.3980732986433, 3911.0, 3911.4328422379167, 4782.187028205144, 4838.177509823268, 5862.853428664317, 5864.472197502245, 5866.765329386777, 4963.851084467472, 5620.875824834968, 5652.745626446902, 5672.631278966854, 5684.7441865117, 4819.0, 5294.417614062527, 5549.028919939075, 5563.415841336763, 5576.275084239023, 5503.147012213113, 5539.556835453073, 5541.861453463695, 5588.329400471806, 5617.185508101385, 5175.534201921845, 5331.733413329395, 5419.0, 5559.444055594408, 5693.0, 4750.812296925768, 5078.908034772541, 5301.443348448357, 5450.91823622638, 5497.422770609189], "value": 4049.6589067252035, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [658.338369938212, 714.8597986211993, 787.6770524085126, 817.3665409307786, 852.1435956863353, 16084.517464476055, 17144.228509717093, 17178.82821171788, 17179.226934787934, 17184.82815171848, 15416.845831541681, 15458.381664733397, 15464.149471779048, 15482.84517154828, 15490.0, 717.386634427566, 741.8219627289438, 753.3370633842211, 874.1520724896872, 911.1617312072909, 904.6019751309435, 919.4896832258094, 922.4695799915042, 926.305271046715, 931.6925414613195, 985.0051448037462, 985.2807450561095, 987.4815721746069, 987.9922479071342, 989.1246247071322, 978.3445091788483, 978.5009645080988, 982.5774916785779, 983.4590974963742, 985.7042887133903, 732.9010583571203, 734.7281505842819, 735.1766022055278, 739.5451797144771, 748.3713680508399, 15420.151891645955, 15598.298076586581, 15630.843691563052, 15636.687266254612, 15641.296141673653, 12312.876871231263, 15233.695326093526, 15299.617509562238, 15321.0, 15346.07923524581, 11995.16033877629, 12063.93968030163, 12198.451069701885, 12398.31809250491, 12451.750964980649, 3904.4728961590104, 3972.8013599320207, 4021.9195616087513, 4036.6568841648495, 4044.5550989391145, 102212.93361199176, 102536.0, 102867.0, 102976.48511757469, 103928.99999999924, 11571.305721656727, 11581.363025033705, 11963.581274655346, 11996.040316774637, 12010.459529321202, 24271.0, 24337.63493547598, 24364.634530482057, 24500.509989800103, 24561.631575526382, 6878.312168783082, 7854.450188486751, 7979.72070977513, 8110.716124935599, 8305.211004954519, 4522.570355816192, 4568.406107206042, 4637.842567916951, 4643.3731446255, 4657.557532034519, 3584.2473080653353, 3731.0858839584475, 3733.6266373362446, 3736.0, 3736.663700266989, 670.1154476091609, 674.3458844920419, 677.7187467201155, 679.5616827146463, 680.0886811672383, 477.51770711581554, 624.5815303746501, 662.4303099334569, 663.4857985061519, 665.5208250059949, 8934.374593778373, 9019.549022548847, 9484.762880927894, 9624.807503850025, 9783.510824458748, 591.3288417645916, 670.276101810044, 692.4149094015548, 709.2517394149222, 752.3341842469345, 4263.893402664959, 4842.903141937141, 4941.48114447985, 4946.3817022872145, 4963.131451995886, 94686.0, 95017.09965800645, 124252.0, 150794.0, 160354.19822900812, 124136.75863241432, 130882.0, 130892.3455382717, 130934.0, 137442.0, 89721.55139224262, 97481.51259243659, 106834.46582767037, 115465.84534154719, 116544.0, 9907.015723521361, 9959.800803984024, 10133.594656213963, 10437.904020077782, 10573.0, 57361.565960851316, 58606.413935860095, 59907.0, 60924.69537652283, 67492.662536687, 92564.53717731369, 95443.0, 96950.51524742332, 98545.0, 101502.49248753709, 11874.0, 13828.861711382757, 13844.515441959484, 13872.0, 13905.791413128609, 14963.627642991187, 15219.239038047832, 15315.61710957235, 15759.606009849846, 16011.919940400223, 14441.205733684748, 14611.269436528344, 14971.251437428304, 15162.469313573973, 15551.84448155504, 12224.266544007389, 14583.85416145825, 14772.261386930395, 15312.693746125238, 15367.538973830802, 14131.64670883236, 14166.362513686703, 14409.973905479967, 15175.16536590498, 15210.695786084438, 9703.5148242589, 11351.318920864775, 11561.0, 12022.879771202175, 12366.381680916098, 11030.669079927615, 11808.527658893892, 11971.760564788481, 12060.939695301468, 12069.698257543632], "value": 8120.849398512557, "unit": "score"}], "name": "dromaeo_css", "value": 7557.341532625074, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 113.0, 114.0, 113.0, 113.0, 110.0, 112.0, 113.0, 112.0, 113.0], "value": 112.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 107.0, 105.0, 141.0, 107.0, 107.0, 106.0, 106.0, 134.0, 105.0], "value": 115.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [185.0, 183.0, 186.0, 184.0, 182.0, 183.0, 184.0, 184.0, 185.0, 183.0], "value": 183.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 57.0, 58.0, 99.0, 81.0, 79.0, 72.0, 58.0, 81.0, 58.0], "value": 72.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 71.0, 94.0, 71.0, 68.0, 71.0, 90.0, 69.0, 55.0, 90.0], "value": 76.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 86.0, 87.0, 88.0, 120.0, 83.0, 87.0, 83.0, 87.0, 83.0], "value": 89.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 92.0, 92.0, 93.0, 93.0, 92.0, 93.0, 93.0, 92.0, 92.0], "value": 92.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 84.0, 84.0, 85.0, 86.0, 86.0, 85.0, 82.0, 84.0, 85.0], "value": 84.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 50.0, 51.0, 50.0, 54.0, 54.0, 56.0, 55.0, 54.0, 55.0], "value": 53.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 73.0, 63.0, 73.0, 71.0, 67.0, 72.0, 68.0, 68.0, 71.0], "value": 68.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 83.0, 83.0, 84.0, 81.0, 82.0, 85.0, 84.0, 97.0, 96.0], "value": 85.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [136.0, 134.0, 139.0, 143.0, 137.0, 141.0, 141.0, 146.0, 170.0, 165.0], "value": 145.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 158.0, 157.0, 157.0, 161.0, 158.0, 158.0, 155.0, 159.0, 158.0], "value": 158.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 66.0, 63.0, 64.0, 63.0, 64.0, 65.0, 64.0, 64.0], "value": 64.3, "unit": "score"}], "name": "kraken", "value": 1402.9, "alertThreshold": 2.0}]} 12:13:49 INFO - Return code: 0 12:13:49 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 12:13:49 INFO - # TBPL SUCCESS # 12:13:49 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 12:13:49 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 12:13:49 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 12:13:49 INFO - 2016-11-20 12:13:49.516 screenresolution[1656:10428] starting screenresolution argv=screenresolution get 12:13:49 INFO - 2016-11-20 12:13:49.519 screenresolution[1656:10428] Display 0: 1600x1200x32@60 12:13:49 INFO - 2016-11-20 12:13:49.525 screenresolution[1657:10431] starting screenresolution argv=screenresolution list 12:13:49 INFO - Available Modes on Display 0 12:13:49 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 12:13:49 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 12:13:49 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 12:13:49 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 12:13:49 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 12:13:49 INFO - Intel Iris: 12:13:49 INFO - Chipset Model: Intel Iris 12:13:49 INFO - Type: GPU 12:13:49 INFO - Bus: Built-In 12:13:49 INFO - VRAM (Dynamic, Max): 1536 MB 12:13:49 INFO - Vendor: Intel (0x8086) 12:13:49 INFO - Device ID: 0x0a2e 12:13:49 INFO - Revision ID: 0x0009 12:13:49 INFO - Displays: 12:13:49 INFO - Display: 12:13:49 INFO - Resolution: 1600 x 1200 @ 60 Hz 12:13:49 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 12:13:49 INFO - Display Serial Number: 1600x1200 60 12:13:49 INFO - Main Display: Yes 12:13:49 INFO - Mirror: Off 12:13:49 INFO - Online: Yes 12:13:49 INFO - Rotation: Supported 12:13:49 INFO - Return code: 0 12:13:49 INFO - Running post-action listener: _resource_record_post_action 12:13:49 INFO - [mozharness: 2016-11-20 20:13:49.757628Z] Finished run-tests step (success) 12:13:49 INFO - Running post-run listener: _resource_record_post_run 12:13:49 INFO - Total resource usage - Wall time: 1195s; CPU: 53.0%; Read bytes: 33569792; Write bytes: 496513536; Read time: 311; Write time: 1569 12:13:49 INFO - TinderboxPrint: CPU usage
53.4% 12:13:49 INFO - TinderboxPrint: I/O read bytes / time
33,569,792 / 311 12:13:49 INFO - TinderboxPrint: I/O write bytes / time
496,513,536 / 1,569 12:13:49 INFO - TinderboxPrint: CPU idle
2,228.9 (46.6%) 12:13:49 INFO - TinderboxPrint: CPU system
957.1 (20.0%) 12:13:49 INFO - TinderboxPrint: CPU user
1,595.6 (33.4%) 12:13:49 INFO - TinderboxPrint: Swap in / out
225,210,368 / 0 12:13:49 INFO - install - Wall time: 22s; CPU: 54.0%; Read bytes: 183489024; Write bytes: 177628672; Read time: 16578; Write time: 403 12:13:49 INFO - run-tests - Wall time: 1174s; CPU: 53.0%; Read bytes: 32640000; Write bytes: 298826752; Read time: 297; Write time: 1108 12:13:50 INFO - Running post-run listener: _upload_blobber_files 12:13:50 INFO - Blob upload gear active. 12:13:50 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 12:13:50 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 12:13:50 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'] 12:13:50 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 12:13:50 INFO - (blobuploader) - INFO - Open directory for files ... 12:13:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 12:13:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:13:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:13:51 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 12:13:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:13:51 INFO - (blobuploader) - INFO - Done attempting. 12:13:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 12:13:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:13:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:13:52 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 12:13:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:13:52 INFO - (blobuploader) - INFO - Done attempting. 12:13:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 12:13:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:13:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:13:54 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 12:13:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:13:54 INFO - (blobuploader) - INFO - Done attempting. 12:13:54 INFO - (blobuploader) - INFO - Iteration through files over. 12:13:54 INFO - Return code: 0 12:13:54 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 12:13:54 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 12:13:54 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/d12e533c1d4bab5ce18ccd52dc308c0978bc7d075c4ae01b4d4bfca09373899ec15c7b37658938c567d91b797661384115c4afa0a1e4e20dd5a17031002eed82", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/cda943aaaaa71bc4450421e36e99f03f8e7f796a8dacea79741c05215dfb5392adc909eefae786f3be2a0fa7e4e454f7f1fa4279795e58107b2bb3602d8bc770", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/7f985bdd63b6f0dc4879dbbe882cdfbf2025a114710554404db92426fdbf8b74d5971db4fbec93e66655c00927d94fbaacff1f5ce6c4f2089c3491cfbcec555e"} 12:13:54 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 12:13:54 INFO - Writing to file /builds/slave/test/properties/blobber_files 12:13:54 INFO - Contents: 12:13:54 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/d12e533c1d4bab5ce18ccd52dc308c0978bc7d075c4ae01b4d4bfca09373899ec15c7b37658938c567d91b797661384115c4afa0a1e4e20dd5a17031002eed82", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/cda943aaaaa71bc4450421e36e99f03f8e7f796a8dacea79741c05215dfb5392adc909eefae786f3be2a0fa7e4e454f7f1fa4279795e58107b2bb3602d8bc770", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/7f985bdd63b6f0dc4879dbbe882cdfbf2025a114710554404db92426fdbf8b74d5971db4fbec93e66655c00927d94fbaacff1f5ce6c4f2089c3491cfbcec555e"} 12:13:54 INFO - Running post-run listener: copy_logs_to_upload_dir 12:13:54 INFO - Copying logs to upload dir... 12:13:54 INFO - mkdir: /builds/slave/test/build/upload/logs 12:13:54 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1255.097237 ========= master_lag: 1.38 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 20 mins, 56 secs) (at 2016-11-20 12:13:55.865311) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-20 12:13:55.868414) ========= 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.VORdO4OMjB/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.ykaxYB9CbF/Listeners TMPDIR=/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/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/d12e533c1d4bab5ce18ccd52dc308c0978bc7d075c4ae01b4d4bfca09373899ec15c7b37658938c567d91b797661384115c4afa0a1e4e20dd5a17031002eed82", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/cda943aaaaa71bc4450421e36e99f03f8e7f796a8dacea79741c05215dfb5392adc909eefae786f3be2a0fa7e4e454f7f1fa4279795e58107b2bb3602d8bc770", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/7f985bdd63b6f0dc4879dbbe882cdfbf2025a114710554404db92426fdbf8b74d5971db4fbec93e66655c00927d94fbaacff1f5ce6c4f2089c3491cfbcec555e"} build_url:https://queue.taskcluster.net/v1/task/BjkGeLi-Q5mgtI6hirYroQ/artifacts/public/build/firefox-51.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011113 build_url: 'https://queue.taskcluster.net/v1/task/BjkGeLi-Q5mgtI6hirYroQ/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/d12e533c1d4bab5ce18ccd52dc308c0978bc7d075c4ae01b4d4bfca09373899ec15c7b37658938c567d91b797661384115c4afa0a1e4e20dd5a17031002eed82", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/cda943aaaaa71bc4450421e36e99f03f8e7f796a8dacea79741c05215dfb5392adc909eefae786f3be2a0fa7e4e454f7f1fa4279795e58107b2bb3602d8bc770", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/7f985bdd63b6f0dc4879dbbe882cdfbf2025a114710554404db92426fdbf8b74d5971db4fbec93e66655c00927d94fbaacff1f5ce6c4f2089c3491cfbcec555e"}' ========= master_lag: 0.11 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-20 12:13:55.986666) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-20 12:13:55.986993) ========= 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.VORdO4OMjB/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.ykaxYB9CbF/Listeners TMPDIR=/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/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.005093 ========= master_lag: 0.02 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-20 12:13:56.014763) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-20 12:13:56.015446) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-20 12:13:56.016113) ========= ========= Total master_lag: 1.59 =========