builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0140 starttime: 1473177042.43 results: success (0) buildid: 20160906062654 builduid: 3f6cf8c2b9e148b39835402e033e481e revision: fd0c612048b76cb2ed1cfaa03e9f22b3ab6eb4d0 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-09-06 08:50:42.432560) ========= master: http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-09-06 08:50:42.432927) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-06 08:50:42.433194) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-06 08:50:42.468320) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-06 08:50:42.468672) ========= 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.VIFF5sX7rA/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.ZPY2AV9eJo/Listeners TMPDIR=/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/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-09-06 08:50:42-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 14.1M=0.001s 2016-09-06 08:50:42 (14.1 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.157443 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-06 08:50:42.648055) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-06 08:50:42.648361) ========= 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.VIFF5sX7rA/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.ZPY2AV9eJo/Listeners TMPDIR=/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/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.027734 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-06 08:50:42.718703) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-09-06 08:50:42.719042) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev fd0c612048b76cb2ed1cfaa03e9f22b3ab6eb4d0 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev fd0c612048b76cb2ed1cfaa03e9f22b3ab6eb4d0 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.VIFF5sX7rA/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.ZPY2AV9eJo/Listeners TMPDIR=/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/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-09-06 08:50:42,806 truncating revision to first 12 chars 2016-09-06 08:50:42,806 Setting DEBUG logging. 2016-09-06 08:50:42,806 attempt 1/10 2016-09-06 08:50:42,806 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/fd0c612048b7?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-09-06 08:50:44,607 unpacking tar archive at: mozilla-central-fd0c612048b7/testing/mozharness/ program finished with exit code 0 elapsedTime=2.070582 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-09-06 08:50:44.819100) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-06 08:50:44.819383) ========= script_repo_revision: fd0c612048b76cb2ed1cfaa03e9f22b3ab6eb4d0 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-06 08:50:44.819741) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-06 08:50:44.820002) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-06 08:50:44.838390) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 12 secs) (at 2016-09-06 08:50:44.838658) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.VIFF5sX7rA/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.ZPY2AV9eJo/Listeners TMPDIR=/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 08:50:45 INFO - MultiFileLogger online at 20160906 08:50:45 in /builds/slave/test 08:50:45 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 08:50:45 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:50:45 INFO - {'append_to_log': False, 08:50:45 INFO - 'base_work_dir': '/builds/slave/test', 08:50:45 INFO - 'blob_upload_branch': 'Firefox', 08:50:45 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:50:45 INFO - 'branch': 'Firefox', 08:50:45 INFO - 'buildbot_json_path': 'buildprops.json', 08:50:45 INFO - 'config_files': ('talos/mac_config.py',), 08:50:45 INFO - 'default_actions': ('clobber', 08:50:45 INFO - 'read-buildbot-config', 08:50:45 INFO - 'download-and-extract', 08:50:45 INFO - 'populate-webroot', 08:50:45 INFO - 'create-virtualenv', 08:50:45 INFO - 'install', 08:50:45 INFO - 'run-tests'), 08:50:45 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:50:45 INFO - 'download_minidump_stackwalk': True, 08:50:45 INFO - 'download_symbols': 'ondemand', 08:50:45 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:50:45 INFO - 'tooltool.py': '/tools/tooltool.py', 08:50:45 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:50:45 INFO - '/tools/misc-python/virtualenv.py')}, 08:50:45 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:50:45 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:50:45 INFO - 'installer_path': 'installer.exe', 08:50:45 INFO - 'log_level': 'info', 08:50:45 INFO - 'log_name': 'talos', 08:50:45 INFO - 'log_to_console': True, 08:50:45 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 08:50:45 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 08:50:45 INFO - 'opt_config_files': (), 08:50:45 INFO - 'pip_index': False, 08:50:45 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 08:50:45 INFO - 'cmd': ('bash', 08:50:45 INFO - '-c', 08:50:45 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 08:50:45 INFO - 'enabled': True, 08:50:45 INFO - 'halt_on_failure': False, 08:50:45 INFO - 'name': 'check_screen_resolution'},), 08:50:45 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 08:50:45 INFO - 'cmd': ('bash', 08:50:45 INFO - '-c', 08:50:45 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 08:50:45 INFO - 'enabled': True, 08:50:45 INFO - 'halt_on_failure': False, 08:50:45 INFO - 'name': 'check_screen_resolution'},), 08:50:45 INFO - 'run_cmd_checks_enabled': True, 08:50:45 INFO - 'sps_profile': False, 08:50:45 INFO - 'sps_profile_interval': 0, 08:50:45 INFO - 'suite': 'dromaeojs', 08:50:45 INFO - 'system_bits': '32', 08:50:45 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:50:45 INFO - 'title': 't-yosemite-r7-0140', 08:50:45 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:50:45 INFO - 'use_talos_json': True, 08:50:45 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:50:45 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:50:45 INFO - 'work_dir': 'build'} 08:50:45 INFO - [mozharness: 2016-09-06 15:50:45.038984Z] Running clobber step. 08:50:45 INFO - Running pre-action listener: _resource_record_pre_action 08:50:45 INFO - Running main action method: clobber 08:50:45 INFO - rmtree: /builds/slave/test/build 08:50:45 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:50:47 INFO - Running post-action listener: _resource_record_post_action 08:50:47 INFO - [mozharness: 2016-09-06 15:50:47.206299Z] Finished clobber step (success) 08:50:47 INFO - [mozharness: 2016-09-06 15:50:47.206569Z] Running read-buildbot-config step. 08:50:47 INFO - Running pre-action listener: _resource_record_pre_action 08:50:47 INFO - Running main action method: read_buildbot_config 08:50:47 INFO - Using buildbot properties: 08:50:47 INFO - { 08:50:47 INFO - "project": "", 08:50:47 INFO - "product": "firefox", 08:50:47 INFO - "script_repo_revision": "production", 08:50:47 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 08:50:47 INFO - "repository": "", 08:50:47 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 08:50:47 INFO - "buildid": "20160906062654", 08:50:47 INFO - "pgo_build": "False", 08:50:47 INFO - "basedir": "/builds/slave/test", 08:50:47 INFO - "buildnumber": 19, 08:50:47 INFO - "slavename": "t-yosemite-r7-0140", 08:50:47 INFO - "master": "http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/", 08:50:47 INFO - "platform": "yosemite_r7", 08:50:47 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 08:50:47 INFO - "branch": "mozilla-central", 08:50:47 INFO - "repo_path": "mozilla-central", 08:50:47 INFO - "revision": "fd0c612048b76cb2ed1cfaa03e9f22b3ab6eb4d0", 08:50:47 INFO - "stage_platform": "macosx64", 08:50:47 INFO - "builduid": "3f6cf8c2b9e148b39835402e033e481e", 08:50:47 INFO - "slavebuilddir": "test" 08:50:47 INFO - } 08:50:47 INFO - Found installer url https://queue.taskcluster.net/v1/task/EfMONJ7AT4OuX_IOgVe4rA/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg. 08:50:47 INFO - Running post-action listener: _resource_record_post_action 08:50:47 INFO - [mozharness: 2016-09-06 15:50:47.212706Z] Finished read-buildbot-config step (success) 08:50:47 INFO - [mozharness: 2016-09-06 15:50:47.212928Z] Running download-and-extract step. 08:50:47 INFO - Running pre-action listener: _resource_record_pre_action 08:50:47 INFO - Running main action method: download_and_extract 08:50:47 INFO - mkdir: /builds/slave/test/build/tests 08:50:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:50:47 INFO - trying https://queue.taskcluster.net/v1/task/EfMONJ7AT4OuX_IOgVe4rA/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json 08:50:47 INFO - Downloading https://queue.taskcluster.net/v1/task/EfMONJ7AT4OuX_IOgVe4rA/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json 08:50:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/EfMONJ7AT4OuX_IOgVe4rA/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json'}, attempt #1 08:50:48 INFO - Downloaded 1199 bytes. 08:50:48 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json 08:50:48 INFO - Using the following test package requirements: 08:50:48 INFO - {u'common': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 08:50:48 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 08:50:48 INFO - u'firefox-51.0a1.en-US.mac.cppunittest.tests.zip'], 08:50:48 INFO - u'gtest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 08:50:48 INFO - u'firefox-51.0a1.en-US.mac.gtest.tests.zip'], 08:50:48 INFO - u'jittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 08:50:48 INFO - u'jsshell-mac.zip'], 08:50:48 INFO - u'mochitest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 08:50:48 INFO - u'firefox-51.0a1.en-US.mac.mochitest.tests.zip'], 08:50:48 INFO - u'mozbase': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 08:50:48 INFO - u'reftest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 08:50:48 INFO - u'firefox-51.0a1.en-US.mac.reftest.tests.zip'], 08:50:48 INFO - u'talos': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 08:50:48 INFO - u'firefox-51.0a1.en-US.mac.talos.tests.zip'], 08:50:48 INFO - u'web-platform': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 08:50:48 INFO - u'firefox-51.0a1.en-US.mac.web-platform.tests.zip'], 08:50:48 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 08:50:48 INFO - u'firefox-51.0a1.en-US.mac.xpcshell.tests.zip']} 08:50:48 INFO - Downloading packages: [u'firefox-51.0a1.en-US.mac.common.tests.zip'] for test suite category: common 08:50:48 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/EfMONJ7AT4OuX_IOgVe4rA/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 08:50:48 INFO - retry: Calling unzip with args: (), kwargs: {'file_object': >, 'verbose': False, 'extract_dirs': '*', 'extract_to': '/builds/slave/test/build/tests'}, attempt #1 08:50:55 INFO - Downloading packages: [u'firefox-51.0a1.en-US.mac.common.tests.zip', u'firefox-51.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 08:50:56 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/EfMONJ7AT4OuX_IOgVe4rA/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 08:50:56 INFO - retry: Calling unzip with args: (), kwargs: {'file_object': >, 'verbose': False, 'extract_dirs': '*', 'extract_to': '/builds/slave/test/build/tests'}, attempt #1 08:51:04 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/EfMONJ7AT4OuX_IOgVe4rA/artifacts/public/build/firefox-51.0a1.en-US.mac.talos.tests.zip 08:51:04 INFO - retry: Calling unzip with args: (), kwargs: {'file_object': >, 'verbose': False, 'extract_dirs': '*', 'extract_to': '/builds/slave/test/build/tests'}, attempt #1 08:51:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:51:05 INFO - trying https://queue.taskcluster.net/v1/task/EfMONJ7AT4OuX_IOgVe4rA/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 08:51:05 INFO - Downloading https://queue.taskcluster.net/v1/task/EfMONJ7AT4OuX_IOgVe4rA/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg 08:51:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/EfMONJ7AT4OuX_IOgVe4rA/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg'}, attempt #1 08:51:07 INFO - Downloaded 111522231 bytes. 08:51:07 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/EfMONJ7AT4OuX_IOgVe4rA/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 08:51:07 INFO - mkdir: /builds/slave/test/properties 08:51:07 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:51:07 INFO - Writing to file /builds/slave/test/properties/build_url 08:51:07 INFO - Contents: 08:51:07 INFO - build_url:https://queue.taskcluster.net/v1/task/EfMONJ7AT4OuX_IOgVe4rA/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 08:51:08 INFO - Running post-action listener: _resource_record_post_action 08:51:08 INFO - Running post-action listener: set_extra_try_arguments 08:51:08 INFO - [mozharness: 2016-09-06 15:51:08.409235Z] Finished download-and-extract step (success) 08:51:08 INFO - [mozharness: 2016-09-06 15:51:08.409361Z] Running populate-webroot step. 08:51:08 INFO - Running pre-action listener: _resource_record_pre_action 08:51:08 INFO - Running main action method: populate_webroot 08:51:08 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:51:08 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:51:08 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:51:08 INFO - '--tppagecycles', 08:51:08 INFO - '7'], 08:51:08 INFO - 'tests': ['tsvgm']}}, 08:51:08 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:51:08 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:51:08 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:51:08 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:51:08 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:51:08 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:51:08 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:51:08 INFO - 'talos_options': ['--disable-e10s'], 08:51:08 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:51:08 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:51:08 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:51:08 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:51:08 INFO - 'talos_options': ['--disable-e10s'], 08:51:08 INFO - 'tests': ['damp', 'tps']}, 08:51:08 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:51:08 INFO - 'tests': ['damp', 'tps']}, 08:51:08 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:51:08 INFO - 'tests': ['dromaeo_dom']}, 08:51:08 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:51:08 INFO - 'g4': {'talos_options': ['--disable-e10s'], 08:51:08 INFO - 'tests': ['basic_compositor_video']}, 08:51:08 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 08:51:08 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:51:08 INFO - 'tests': ['a11yr', 08:51:08 INFO - 'ts_paint', 08:51:08 INFO - 'tpaint', 08:51:08 INFO - 'sessionrestore', 08:51:08 INFO - 'sessionrestore_no_auto_restore', 08:51:08 INFO - 'tabpaint']}, 08:51:08 INFO - 'other-e10s': {'tests': ['a11yr', 08:51:08 INFO - 'ts_paint', 08:51:08 INFO - 'tpaint', 08:51:08 INFO - 'sessionrestore', 08:51:08 INFO - 'sessionrestore_no_auto_restore', 08:51:08 INFO - 'tabpaint']}, 08:51:08 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:51:08 INFO - 'ts_paint', 08:51:08 INFO - 'tpaint', 08:51:08 INFO - 'sessionrestore', 08:51:08 INFO - 'sessionrestore_no_auto_restore', 08:51:08 INFO - 'tabpaint']}, 08:51:08 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:51:08 INFO - 'ts_paint', 08:51:08 INFO - 'tpaint', 08:51:08 INFO - 'sessionrestore', 08:51:08 INFO - 'sessionrestore_no_auto_restore', 08:51:08 INFO - 'tabpaint']}, 08:51:08 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:51:08 INFO - 'tests': ['a11yr', 08:51:08 INFO - 'ts_paint', 08:51:08 INFO - 'tpaint', 08:51:08 INFO - 'sessionrestore', 08:51:08 INFO - 'sessionrestore_no_auto_restore', 08:51:08 INFO - 'tabpaint']}, 08:51:08 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:51:08 INFO - 'tests': ['a11yr', 08:51:08 INFO - 'ts_paint', 08:51:08 INFO - 'tpaint', 08:51:08 INFO - 'sessionrestore', 08:51:08 INFO - 'sessionrestore_no_auto_restore', 08:51:08 INFO - 'tabpaint']}, 08:51:08 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:51:08 INFO - 'tests': ['tsvgx', 08:51:08 INFO - 'tsvgr_opacity', 08:51:08 INFO - 'tart', 08:51:08 INFO - 'tscrollx', 08:51:08 INFO - 'cart']}, 08:51:08 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:51:08 INFO - 'tsvgr_opacity', 08:51:08 INFO - 'tart', 08:51:08 INFO - 'tscrollx', 08:51:08 INFO - 'cart']}, 08:51:08 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:51:08 INFO - 'talos_options': ['--disable-e10s'], 08:51:08 INFO - 'tests': ['tp5o']}, 08:51:08 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:51:08 INFO - 'tests': ['tp5o']}, 08:51:08 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:51:08 INFO - 'talos_options': ['--disable-e10s', 08:51:08 INFO - '--xperf_path', 08:51:08 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:51:08 INFO - 'tests': ['tp5n']}, 08:51:08 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:51:08 INFO - 'talos_options': ['--xperf_path', 08:51:08 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:51:08 INFO - 'tests': ['tp5n']}}, 08:51:08 INFO - 'talos.zip': {'path': '', 08:51:08 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:51:08 INFO - Running post-action listener: _resource_record_post_action 08:51:08 INFO - [mozharness: 2016-09-06 15:51:08.429282Z] Finished populate-webroot step (success) 08:51:08 INFO - [mozharness: 2016-09-06 15:51:08.429422Z] Running create-virtualenv step. 08:51:08 INFO - Running pre-action listener: _resource_record_pre_action 08:51:08 INFO - Running main action method: create_virtualenv 08:51:08 INFO - Creating virtualenv /builds/slave/test/build/venv 08:51:08 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 08:51:08 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:51:08 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:51:08 INFO - Using real prefix '/tools/python27' 08:51:08 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:51:09 INFO - Installing distribute.............................................................................................................................................................................................done. 08:51:12 INFO - Installing pip.................done. 08:51:12 INFO - Return code: 0 08:51:12 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:51:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:51:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:51:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:51:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:51:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:51:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:51:12 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x102344a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1023d9618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8f48476880>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1022a8d30>, '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 0x10200ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1022a0b20>, '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.VIFF5sX7rA/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.ZPY2AV9eJo/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:51:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 08:51:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 08:51:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VIFF5sX7rA/Render', 08:51:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:51:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:51:12 INFO - 'HOME': '/Users/cltbld', 08:51:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:51:12 INFO - 'LOGNAME': 'cltbld', 08:51:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:51:12 INFO - 'MOZ_NO_REMOTE': '1', 08:51:12 INFO - 'NO_EM_RESTART': '1', 08:51:12 INFO - 'PAGER': '/bin/cat', 08:51:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:51:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:51:12 INFO - 'PWD': '/builds/slave/test', 08:51:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:51:12 INFO - 'SHELL': '/bin/bash', 08:51:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ZPY2AV9eJo/Listeners', 08:51:12 INFO - 'TMPDIR': '/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/', 08:51:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:51:12 INFO - 'USER': 'cltbld', 08:51:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:51:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:51:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:51:12 INFO - 'XPC_FLAGS': '0x0', 08:51:12 INFO - 'XPC_SERVICE_NAME': '0', 08:51:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:51:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:51:12 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 08:51:12 INFO - Cleaning up... 08:51:12 INFO - Return code: 0 08:51:12 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:51:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:51:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:51:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:51:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:51:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:51:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:51:12 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x102344a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1023d9618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8f48476880>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1022a8d30>, '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 0x10200ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1022a0b20>, '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.VIFF5sX7rA/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.ZPY2AV9eJo/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:51:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 08:51:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 08:51:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VIFF5sX7rA/Render', 08:51:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:51:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:51:12 INFO - 'HOME': '/Users/cltbld', 08:51:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:51:12 INFO - 'LOGNAME': 'cltbld', 08:51:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:51:12 INFO - 'MOZ_NO_REMOTE': '1', 08:51:12 INFO - 'NO_EM_RESTART': '1', 08:51:12 INFO - 'PAGER': '/bin/cat', 08:51:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:51:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:51:12 INFO - 'PWD': '/builds/slave/test', 08:51:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:51:12 INFO - 'SHELL': '/bin/bash', 08:51:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ZPY2AV9eJo/Listeners', 08:51:12 INFO - 'TMPDIR': '/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/', 08:51:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:51:12 INFO - 'USER': 'cltbld', 08:51:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:51:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:51:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:51:12 INFO - 'XPC_FLAGS': '0x0', 08:51:12 INFO - 'XPC_SERVICE_NAME': '0', 08:51:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:51:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:51:12 INFO - Downloading/unpacking psutil>=3.1.1 08:51:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:51:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:51:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:51:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:51:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:51:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:51:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:51:16 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:51:16 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:51:16 INFO - Installing collected packages: psutil 08:51:16 INFO - Running setup.py install for psutil 08:51:16 INFO - building 'psutil._psutil_osx' extension 08:51:16 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 08:51:17 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 08:51:17 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 08:51:17 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 08:51:17 INFO - building 'psutil._psutil_posix' extension 08:51:17 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 08:51:17 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 08:51:17 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 08:51:17 INFO - ^ 08:51:17 INFO - 1 warning generated. 08:51:17 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 08:51:17 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:51:17 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:51:17 INFO - Successfully installed psutil 08:51:17 INFO - Cleaning up... 08:51:17 INFO - Return code: 0 08:51:17 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:51:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:51:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:51:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:51:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:51:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:51:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:51:17 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 0x102344a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1023d9618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8f48476880>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1022a8d30>, '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 0x10200ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1022a0b20>, '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.VIFF5sX7rA/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.ZPY2AV9eJo/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:51:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 08:51:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 08:51:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VIFF5sX7rA/Render', 08:51:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:51:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:51:17 INFO - 'HOME': '/Users/cltbld', 08:51:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:51:17 INFO - 'LOGNAME': 'cltbld', 08:51:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:51:17 INFO - 'MOZ_NO_REMOTE': '1', 08:51:17 INFO - 'NO_EM_RESTART': '1', 08:51:17 INFO - 'PAGER': '/bin/cat', 08:51:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:51:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:51:17 INFO - 'PWD': '/builds/slave/test', 08:51:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:51:17 INFO - 'SHELL': '/bin/bash', 08:51:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ZPY2AV9eJo/Listeners', 08:51:17 INFO - 'TMPDIR': '/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/', 08:51:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:51:17 INFO - 'USER': 'cltbld', 08:51:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:51:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:51:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:51:17 INFO - 'XPC_FLAGS': '0x0', 08:51:17 INFO - 'XPC_SERVICE_NAME': '0', 08:51:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:51:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:51:17 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:51:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:51:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:51:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:51:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:51:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:51:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:51:20 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:51:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:51:20 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:51:20 INFO - Installing collected packages: mozsystemmonitor 08:51:20 INFO - Running setup.py install for mozsystemmonitor 08:51:20 INFO - Successfully installed mozsystemmonitor 08:51:20 INFO - Cleaning up... 08:51:20 INFO - Return code: 0 08:51:20 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:51:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:51:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:51:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:51:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:51:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:51:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:51:20 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x102344a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1023d9618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8f48476880>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1022a8d30>, '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 0x10200ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1022a0b20>, '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.VIFF5sX7rA/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.ZPY2AV9eJo/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:51:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 08:51:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 08:51:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VIFF5sX7rA/Render', 08:51:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:51:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:51:20 INFO - 'HOME': '/Users/cltbld', 08:51:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:51:20 INFO - 'LOGNAME': 'cltbld', 08:51:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:51:20 INFO - 'MOZ_NO_REMOTE': '1', 08:51:20 INFO - 'NO_EM_RESTART': '1', 08:51:20 INFO - 'PAGER': '/bin/cat', 08:51:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:51:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:51:20 INFO - 'PWD': '/builds/slave/test', 08:51:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:51:20 INFO - 'SHELL': '/bin/bash', 08:51:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ZPY2AV9eJo/Listeners', 08:51:20 INFO - 'TMPDIR': '/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/', 08:51:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:51:20 INFO - 'USER': 'cltbld', 08:51:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:51:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:51:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:51:20 INFO - 'XPC_FLAGS': '0x0', 08:51:20 INFO - 'XPC_SERVICE_NAME': '0', 08:51:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:51:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:51:20 INFO - Downloading/unpacking jsonschema==2.5.1 08:51:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:51:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:51:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:51:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:51:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:51:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:51:23 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:51:23 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:51:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:51:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:51:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:51:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:51:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:51:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:51:23 INFO - Downloading functools32-3.2.3-2.tar.gz 08:51:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:51:23 INFO - warning: no files found matching '*.txt' 08:51:23 INFO - no previously-included directories found matching 'build' 08:51:23 INFO - no previously-included directories found matching 'dist' 08:51:23 INFO - no previously-included directories found matching '.git*' 08:51:23 INFO - Installing collected packages: jsonschema, functools32 08:51:24 INFO - Running setup.py install for functools32 08:51:24 INFO - warning: no files found matching '*.txt' 08:51:24 INFO - no previously-included directories found matching 'build' 08:51:24 INFO - no previously-included directories found matching 'dist' 08:51:24 INFO - no previously-included directories found matching '.git*' 08:51:24 INFO - Successfully installed jsonschema functools32 08:51:24 INFO - Cleaning up... 08:51:24 INFO - Return code: 0 08:51:24 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 08:51:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:51:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:51:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:51:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:51:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:51:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:51:24 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x102344a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1023d9618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8f48476880>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1022a8d30>, '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 0x10200ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1022a0b20>, '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.VIFF5sX7rA/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.ZPY2AV9eJo/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:51:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 08:51:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 08:51:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VIFF5sX7rA/Render', 08:51:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:51:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:51:24 INFO - 'HOME': '/Users/cltbld', 08:51:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:51:24 INFO - 'LOGNAME': 'cltbld', 08:51:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:51:24 INFO - 'MOZ_NO_REMOTE': '1', 08:51:24 INFO - 'NO_EM_RESTART': '1', 08:51:24 INFO - 'PAGER': '/bin/cat', 08:51:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:51:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:51:24 INFO - 'PWD': '/builds/slave/test', 08:51:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:51:24 INFO - 'SHELL': '/bin/bash', 08:51:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ZPY2AV9eJo/Listeners', 08:51:24 INFO - 'TMPDIR': '/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/', 08:51:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:51:24 INFO - 'USER': 'cltbld', 08:51:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:51:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:51:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:51:24 INFO - 'XPC_FLAGS': '0x0', 08:51:24 INFO - 'XPC_SERVICE_NAME': '0', 08:51:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:51:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:51:24 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 08:51:24 INFO - Cleaning up... 08:51:24 INFO - Return code: 0 08:51:24 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:51:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:51:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:51:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:51:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:51:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:51:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:51:24 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x102344a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1023d9618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8f48476880>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1022a8d30>, '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 0x10200ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1022a0b20>, '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.VIFF5sX7rA/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.ZPY2AV9eJo/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:51:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 08:51:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 08:51:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VIFF5sX7rA/Render', 08:51:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:51:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:51:24 INFO - 'HOME': '/Users/cltbld', 08:51:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:51:24 INFO - 'LOGNAME': 'cltbld', 08:51:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:51:24 INFO - 'MOZ_NO_REMOTE': '1', 08:51:24 INFO - 'NO_EM_RESTART': '1', 08:51:24 INFO - 'PAGER': '/bin/cat', 08:51:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:51:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:51:24 INFO - 'PWD': '/builds/slave/test', 08:51:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:51:24 INFO - 'SHELL': '/bin/bash', 08:51:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ZPY2AV9eJo/Listeners', 08:51:24 INFO - 'TMPDIR': '/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/', 08:51:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:51:24 INFO - 'USER': 'cltbld', 08:51:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:51:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:51:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:51:24 INFO - 'XPC_FLAGS': '0x0', 08:51:24 INFO - 'XPC_SERVICE_NAME': '0', 08:51:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:51:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:51:24 INFO - Downloading/unpacking blobuploader==1.2.4 08:51:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:51:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:51:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:51:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:51:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:51:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:51:27 INFO - Downloading blobuploader-1.2.4.tar.gz 08:51:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:51:27 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:51:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:51:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:51:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:51:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:51:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:51:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:51:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:51:27 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:51:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:51:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:51:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:51:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:51:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:51:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:51:28 INFO - Downloading docopt-0.6.1.tar.gz 08:51:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:51:28 INFO - Installing collected packages: blobuploader, requests, docopt 08:51:28 INFO - Running setup.py install for blobuploader 08:51:28 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:51:28 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:51:28 INFO - Running setup.py install for requests 08:51:29 INFO - Running setup.py install for docopt 08:51:29 INFO - Successfully installed blobuploader requests docopt 08:51:29 INFO - Cleaning up... 08:51:29 INFO - Return code: 0 08:51:29 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:51:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:51:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:51:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:51:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:51:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:51:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:51:29 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 0x102344a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1023d9618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8f48476880>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1022a8d30>, '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 0x10200ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1022a0b20>, '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.VIFF5sX7rA/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.ZPY2AV9eJo/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:51:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 08:51:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:51:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VIFF5sX7rA/Render', 08:51:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:51:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:51:29 INFO - 'HOME': '/Users/cltbld', 08:51:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:51:29 INFO - 'LOGNAME': 'cltbld', 08:51:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:51:29 INFO - 'MOZ_NO_REMOTE': '1', 08:51:29 INFO - 'NO_EM_RESTART': '1', 08:51:29 INFO - 'PAGER': '/bin/cat', 08:51:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:51:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:51:29 INFO - 'PWD': '/builds/slave/test', 08:51:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:51:29 INFO - 'SHELL': '/bin/bash', 08:51:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ZPY2AV9eJo/Listeners', 08:51:29 INFO - 'TMPDIR': '/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/', 08:51:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:51:29 INFO - 'USER': 'cltbld', 08:51:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:51:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:51:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:51:29 INFO - 'XPC_FLAGS': '0x0', 08:51:29 INFO - 'XPC_SERVICE_NAME': '0', 08:51:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:51:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:51:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:51:29 INFO - Running setup.py (path:/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/pip-1IDOM1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:51:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:51:29 INFO - Running setup.py (path:/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/pip-eE1lkJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:51:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:51:29 INFO - Running setup.py (path:/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/pip-Ti3Hwv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:51:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:51:29 INFO - Running setup.py (path:/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/pip-6PAQ8f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:51:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:51:30 INFO - Running setup.py (path:/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/pip-kLI9xv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:51:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:51:30 INFO - Running setup.py (path:/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/pip-avD_b0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:51:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:51:30 INFO - Running setup.py (path:/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/pip-3zTaEO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:51:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:51:30 INFO - Running setup.py (path:/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/pip-3CwcPL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:51:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:51:30 INFO - Running setup.py (path:/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/pip-XgLRq4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:51:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:51:30 INFO - Running setup.py (path:/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/pip-G1bxow-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:51:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:51:30 INFO - Running setup.py (path:/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/pip-zZ3Wo0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:51:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:51:30 INFO - Running setup.py (path:/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/pip-UnPm1s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:51:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:51:30 INFO - Running setup.py (path:/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/pip-VhtyO6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:51:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:51:30 INFO - Running setup.py (path:/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/pip-p4GxxA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:51:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:51:31 INFO - Running setup.py (path:/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/pip-ZpU4Fo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:51:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:51:31 INFO - Running setup.py (path:/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/pip-e3Wpkr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:51:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:51:31 INFO - Running setup.py (path:/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/pip-btCD0E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:51:31 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:51:31 INFO - Running setup.py install for manifestparser 08:51:31 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:51:31 INFO - Running setup.py install for mozcrash 08:51:31 INFO - Running setup.py install for mozdebug 08:51:31 INFO - Running setup.py install for mozdevice 08:51:31 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:51:31 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:51:31 INFO - Running setup.py install for mozfile 08:51:32 INFO - Running setup.py install for mozhttpd 08:51:32 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:51:32 INFO - Running setup.py install for mozinfo 08:51:32 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:51:32 INFO - Running setup.py install for mozInstall 08:51:32 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:51:32 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:51:32 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:51:32 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:51:32 INFO - Running setup.py install for mozleak 08:51:32 INFO - Running setup.py install for mozlog 08:51:32 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:51:32 INFO - Running setup.py install for moznetwork 08:51:32 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:51:32 INFO - Running setup.py install for mozprocess 08:51:33 INFO - Running setup.py install for mozprofile 08:51:33 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:51:33 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:51:33 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:51:33 INFO - Running setup.py install for mozrunner 08:51:33 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:51:33 INFO - Running setup.py install for mozscreenshot 08:51:33 INFO - Running setup.py install for moztest 08:51:33 INFO - Running setup.py install for mozversion 08:51:33 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:51:33 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:51:33 INFO - Cleaning up... 08:51:33 INFO - Return code: 0 08:51:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:51:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:51:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:51:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:51:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:51:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:51:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:51:33 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 0x102344a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1023d9618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8f48476880>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1022a8d30>, '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 0x10200ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1022a0b20>, '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.VIFF5sX7rA/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.ZPY2AV9eJo/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:51:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 08:51:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:51:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VIFF5sX7rA/Render', 08:51:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:51:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:51:33 INFO - 'HOME': '/Users/cltbld', 08:51:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:51:33 INFO - 'LOGNAME': 'cltbld', 08:51:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:51:33 INFO - 'MOZ_NO_REMOTE': '1', 08:51:33 INFO - 'NO_EM_RESTART': '1', 08:51:33 INFO - 'PAGER': '/bin/cat', 08:51:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:51:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:51:33 INFO - 'PWD': '/builds/slave/test', 08:51:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:51:33 INFO - 'SHELL': '/bin/bash', 08:51:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ZPY2AV9eJo/Listeners', 08:51:33 INFO - 'TMPDIR': '/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/', 08:51:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:51:33 INFO - 'USER': 'cltbld', 08:51:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:51:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:51:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:51:33 INFO - 'XPC_FLAGS': '0x0', 08:51:33 INFO - 'XPC_SERVICE_NAME': '0', 08:51:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:51:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:51:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:51:34 INFO - Running setup.py (path:/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/pip-h1tNhi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:51:34 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 08:51:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:51:34 INFO - Running setup.py (path:/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/pip-3s1uV2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:51:34 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)) 08:51:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:51:34 INFO - Running setup.py (path:/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/pip-SzJZit-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:51:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 08:51:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:51:34 INFO - Running setup.py (path:/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/pip-uvOl55-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:51:34 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)) 08:51:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:51:34 INFO - Running setup.py (path:/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/pip-Tkqint-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:51:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 08:51:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:51:34 INFO - Running setup.py (path:/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/pip-SHRLGt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:51:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 08:51:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:51:34 INFO - Running setup.py (path:/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/pip-u6S6yu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:51:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 08:51:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:51:34 INFO - Running setup.py (path:/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/pip-3adlSt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:51:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 08:51:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:51:35 INFO - Running setup.py (path:/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/pip-c0msMU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:51:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 08:51:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:51:35 INFO - Running setup.py (path:/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/pip-WbM6vB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:51:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.3 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:51:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:51:35 INFO - Running setup.py (path:/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/pip-jnlXM_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:51:35 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 08:51:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:51:35 INFO - Running setup.py (path:/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/pip-mWG9_r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:51:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 08:51:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:51:35 INFO - Running setup.py (path:/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/pip-OdlI2c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:51:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 08:51:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:51:35 INFO - Running setup.py (path:/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/pip-naTKIm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:51:35 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)) 08:51:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:51:35 INFO - Running setup.py (path:/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/pip-Awk0KK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:51:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 08:51:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:51:35 INFO - Running setup.py (path:/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/pip-TZxG32-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:51:35 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 08:51:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:51:35 INFO - Running setup.py (path:/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/pip-VHXUmF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:51:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 08:51:36 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)) 08:51:36 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)) 08:51:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 08:51:36 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)) 08:51:36 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)) 08:51:36 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:51:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:51:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:51:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:51:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:51:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:51:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:51:38 INFO - Downloading blessings-1.6.tar.gz 08:51:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:51:38 INFO - Installing collected packages: blessings 08:51:38 INFO - Running setup.py install for blessings 08:51:38 INFO - Successfully installed blessings 08:51:38 INFO - Cleaning up... 08:51:38 INFO - Return code: 0 08:51:38 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:51:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:51:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:51:39 INFO - Reading from file tmpfile_stdout 08:51:39 INFO - Current package versions: 08:51:39 INFO - blessings == 1.6 08:51:39 INFO - blobuploader == 1.2.4 08:51:39 INFO - docopt == 0.6.1 08:51:39 INFO - functools32 == 3.2.3-2 08:51:39 INFO - jsonschema == 2.5.1 08:51:39 INFO - manifestparser == 1.1 08:51:39 INFO - mozInstall == 1.12 08:51:39 INFO - mozcrash == 0.17 08:51:39 INFO - mozdebug == 0.1 08:51:39 INFO - mozdevice == 0.48 08:51:39 INFO - mozfile == 1.2 08:51:39 INFO - mozhttpd == 0.7 08:51:39 INFO - mozinfo == 0.9 08:51:39 INFO - mozleak == 0.1 08:51:39 INFO - mozlog == 3.3 08:51:39 INFO - moznetwork == 0.27 08:51:39 INFO - mozprocess == 0.23 08:51:39 INFO - mozprofile == 0.28 08:51:39 INFO - mozrunner == 6.12 08:51:39 INFO - mozscreenshot == 0.1 08:51:39 INFO - mozsystemmonitor == 0.3 08:51:39 INFO - moztest == 0.7 08:51:39 INFO - mozversion == 1.4 08:51:39 INFO - psutil == 3.1.1 08:51:39 INFO - requests == 1.2.3 08:51:39 INFO - wsgiref == 0.1.2 08:51:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:51:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:51:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:51:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:51:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:51:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:51:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:51:39 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 0x102344a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1023d9618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8f48476880>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1022a8d30>, '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 0x10200ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1022a0b20>, '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.VIFF5sX7rA/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.ZPY2AV9eJo/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:51:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 08:51:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:51:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VIFF5sX7rA/Render', 08:51:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:51:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:51:39 INFO - 'HOME': '/Users/cltbld', 08:51:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:51:39 INFO - 'LOGNAME': 'cltbld', 08:51:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:51:39 INFO - 'MOZ_NO_REMOTE': '1', 08:51:39 INFO - 'NO_EM_RESTART': '1', 08:51:39 INFO - 'PAGER': '/bin/cat', 08:51:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:51:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:51:39 INFO - 'PWD': '/builds/slave/test', 08:51:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:51:39 INFO - 'SHELL': '/bin/bash', 08:51:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ZPY2AV9eJo/Listeners', 08:51:39 INFO - 'TMPDIR': '/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/', 08:51:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:51:39 INFO - 'USER': 'cltbld', 08:51:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:51:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:51:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:51:39 INFO - 'XPC_FLAGS': '0x0', 08:51:39 INFO - 'XPC_SERVICE_NAME': '0', 08:51:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:51:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:51:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 08:51:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 08:51:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 08:51:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 08:51:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 08:51:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 08:51:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 08:51:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 08:51:39 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 08:51:39 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 08:51:39 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 08:51:39 INFO - Cleaning up... 08:51:39 INFO - Return code: 0 08:51:39 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:51:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:51:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:51:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:51:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:51:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:51:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:51:39 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 0x102344a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1023d9618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8f48476880>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1022a8d30>, '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 0x10200ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1022a0b20>, '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.VIFF5sX7rA/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.ZPY2AV9eJo/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:51:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 08:51:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 08:51:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VIFF5sX7rA/Render', 08:51:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:51:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:51:39 INFO - 'HOME': '/Users/cltbld', 08:51:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:51:39 INFO - 'LOGNAME': 'cltbld', 08:51:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:51:39 INFO - 'MOZ_NO_REMOTE': '1', 08:51:39 INFO - 'NO_EM_RESTART': '1', 08:51:39 INFO - 'PAGER': '/bin/cat', 08:51:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:51:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:51:39 INFO - 'PWD': '/builds/slave/test', 08:51:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:51:39 INFO - 'SHELL': '/bin/bash', 08:51:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ZPY2AV9eJo/Listeners', 08:51:39 INFO - 'TMPDIR': '/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/', 08:51:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:51:39 INFO - 'USER': 'cltbld', 08:51:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:51:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:51:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:51:39 INFO - 'XPC_FLAGS': '0x0', 08:51:39 INFO - 'XPC_SERVICE_NAME': '0', 08:51:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:51:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:51:39 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:51:39 INFO - Cleaning up... 08:51:39 INFO - Return code: 0 08:51:39 INFO - Running post-action listener: _resource_record_post_action 08:51:39 INFO - Running post-action listener: _start_resource_monitoring 08:51:39 INFO - Starting resource monitoring. 08:51:39 INFO - [mozharness: 2016-09-06 15:51:39.740070Z] Finished create-virtualenv step (success) 08:51:39 INFO - [mozharness: 2016-09-06 15:51:39.741096Z] Running install step. 08:51:39 INFO - Running pre-action listener: _resource_record_pre_action 08:51:39 INFO - Running main action method: install 08:51:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:51:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:51:39 INFO - Reading from file tmpfile_stdout 08:51:39 INFO - Detecting whether we're running mozinstall >=1.0... 08:51:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:51:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:51:40 INFO - Reading from file tmpfile_stdout 08:51:40 INFO - Output received: 08:51:40 INFO - Usage: mozinstall [options] installer 08:51:40 INFO - Options: 08:51:40 INFO - -h, --help show this help message and exit 08:51:40 INFO - -d DEST, --destination=DEST 08:51:40 INFO - Directory to install application into. [default: 08:51:40 INFO - "/builds/slave/test"] 08:51:40 INFO - --app=APP Application being installed. [default: firefox] 08:51:40 INFO - mkdir: /builds/slave/test/build/application 08:51:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 08:51:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 08:52:14 INFO - Reading from file tmpfile_stdout 08:52:14 INFO - Output received: 08:52:14 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 08:52:14 INFO - Running post-action listener: _resource_record_post_action 08:52:14 INFO - [mozharness: 2016-09-06 15:52:14.353823Z] Finished install step (success) 08:52:14 INFO - [mozharness: 2016-09-06 15:52:14.353979Z] Running run-tests step. 08:52:14 INFO - Running pre-action listener: _resource_record_pre_action 08:52:14 INFO - Running main action method: run_tests 08:52:14 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 08:52:14 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 08:52:14 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 08:52:14 INFO - 2016-09-06 08:52:14.368 screenresolution[1652:8800] starting screenresolution argv=screenresolution get 08:52:14 INFO - 2016-09-06 08:52:14.371 screenresolution[1652:8800] Display 0: 1600x1200x32@60 08:52:14 INFO - 2016-09-06 08:52:14.377 screenresolution[1653:8802] starting screenresolution argv=screenresolution list 08:52:14 INFO - Available Modes on Display 0 08:52:14 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 08:52:14 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 08:52:14 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 08:52:14 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 08:52:14 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 08:52:14 INFO - Intel Iris: 08:52:14 INFO - Chipset Model: Intel Iris 08:52:14 INFO - Type: GPU 08:52:14 INFO - Bus: Built-In 08:52:14 INFO - VRAM (Dynamic, Max): 1536 MB 08:52:14 INFO - Vendor: Intel (0x8086) 08:52:14 INFO - Device ID: 0x0a2e 08:52:14 INFO - Revision ID: 0x0009 08:52:14 INFO - Displays: 08:52:14 INFO - Display: 08:52:14 INFO - Resolution: 1600 x 1200 @ 60 Hz 08:52:14 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 08:52:14 INFO - Display Serial Number: 1600x1200 60 08:52:14 INFO - Main Display: Yes 08:52:14 INFO - Mirror: Off 08:52:14 INFO - Online: Yes 08:52:14 INFO - Rotation: Supported 08:52:14 INFO - Return code: 0 08:52:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:52:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:52:14 INFO - Python 2.7.3 08:52:14 INFO - Return code: 0 08:52:14 INFO - grabbing minidump binary from tooltool 08:52:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:52:14 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 0x1022a8d30>, '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 0x10200ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1022a0b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:52:14 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 08:52:14 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 08:52:14 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 08:52:14 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:52:14 INFO - Return code: 0 08:52:14 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 08:52:14 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:52:14 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:52:14 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 08:52:14 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:52:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/EfMONJ7AT4OuX_IOgVe4rA/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0140', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 08:52:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/EfMONJ7AT4OuX_IOgVe4rA/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0140 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 08:52:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VIFF5sX7rA/Render', 08:52:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:52:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:52:14 INFO - 'HOME': '/Users/cltbld', 08:52:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:52:14 INFO - 'LOGNAME': 'cltbld', 08:52:14 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:52:14 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 08:52:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:52:14 INFO - 'MOZ_NO_REMOTE': '1', 08:52:14 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:52:14 INFO - 'NO_EM_RESTART': '1', 08:52:14 INFO - 'PAGER': '/bin/cat', 08:52:14 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:52:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:52:14 INFO - 'PWD': '/builds/slave/test', 08:52:14 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:52:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:52:14 INFO - 'SHELL': '/bin/bash', 08:52:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ZPY2AV9eJo/Listeners', 08:52:14 INFO - 'TMPDIR': '/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/', 08:52:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:52:14 INFO - 'USER': 'cltbld', 08:52:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:52:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:52:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:52:14 INFO - 'XPC_FLAGS': '0x0', 08:52:14 INFO - 'XPC_SERVICE_NAME': '0', 08:52:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:52:14 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/EfMONJ7AT4OuX_IOgVe4rA/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0140', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 08:52:14 INFO - mozversion application_buildid: 20160906062654 08:52:14 INFO - mozversion application_changeset: fd0c612048b76cb2ed1cfaa03e9f22b3ab6eb4d0 08:52:14 INFO - mozversion application_display_name: Nightly 08:52:14 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:52:14 INFO - mozversion application_name: Firefox 08:52:14 INFO - mozversion application_remotingname: firefox 08:52:14 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 08:52:14 INFO - mozversion application_vendor: Mozilla 08:52:14 INFO - mozversion application_version: 51.0a1 08:52:14 INFO - mozversion platform_buildid: 20160906062654 08:52:14 INFO - mozversion platform_changeset: fd0c612048b76cb2ed1cfaa03e9f22b3ab6eb4d0 08:52:14 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 08:52:14 INFO - mozversion platform_version: 51.0a1 08:52:14 INFO - using testdate: 1473177134 08:52:14 INFO - actual date: 1473177134 08:52:14 INFO - starting webserver on 'localhost:49272' 08:52:14 INFO - SUITE-START | Running 2 tests 08:52:14 INFO - TEST-START | dromaeo_css 08:52:14 INFO - operating with platform_type : mac_ 08:52:14 INFO - Initialising browser for dromaeo_css test... 08:52:14 INFO - TEST-INFO | started process 1663 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/tmpK0uuKe/profile http://localhost:49272/getInfo.html) 08:52:17 INFO - PROCESS | 1663 | __metrics Screen width/height:1600/1200 08:52:17 INFO - PROCESS | 1663 | colorDepth:24 08:52:17 INFO - PROCESS | 1663 | Browser inner width/height: 1024/689 08:52:17 INFO - PROCESS | 1663 | __metrics 08:52:17 INFO - PROCESS | 1663 | 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" 08:52:17 INFO - PROCESS | 1663 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:52:18 INFO - TEST-INFO | 1663: exit 0 08:52:18 INFO - Browser initialized. 08:52:18 INFO - Running cycle 1/1 for dromaeo_css test... 08:52:18 INFO - TEST-INFO | started process 1666 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/tmpK0uuKe/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:52:30 INFO - PROCESS | 1666 | RSS: Main: 232239104 08:52:30 INFO - PROCESS | 1666 | 08:53:21 INFO - PROCESS | 1666 | 1473177201665 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 08:55:33 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49272/tests/dromaeo/cssquery-ext.html) 08:55:34 INFO - PROCESS | 1666 | RSS: Main: 344690688 08:55:34 INFO - PROCESS | 1666 | 08:58:37 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-ext.html (next: http://localhost:49272/tests/dromaeo/cssquery-jquery.html) 08:58:38 INFO - PROCESS | 1666 | RSS: Main: 378343424 08:58:38 INFO - PROCESS | 1666 | 09:01:40 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49272/tests/dromaeo/cssquery-mootools.html) 09:01:41 INFO - PROCESS | 1666 | RSS: Main: 335998976 09:01:41 INFO - PROCESS | 1666 | 09:04:43 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49272/tests/dromaeo/cssquery-prototype.html) 09:04:44 INFO - PROCESS | 1666 | RSS: Main: 351539200 09:04:44 INFO - PROCESS | 1666 | 09:07:47 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49272/tests/dromaeo/cssquery-yui.html) 09:07:48 INFO - PROCESS | 1666 | RSS: Main: 320040960 09:07:48 INFO - PROCESS | 1666 | 09:10:51 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-yui.html (next: http://localhost:49272/tests/dromaeo/cssquery-dojo.html) 09:10:51 INFO - PROCESS | 1666 | RSS: Main: 456060928 09:10:51 INFO - PROCESS | 1666 | 09:10:51 INFO - PROCESS | 1666 | __start_tp_report 09:10:51 INFO - PROCESS | 1666 | _x_x_mozilla_page_load 09:10:51 INFO - PROCESS | 1666 | _x_x_mozilla_page_load_details 09:10:51 INFO - PROCESS | 1666 | |i|pagename|runs| 09:10:51 INFO - PROCESS | 1666 | |0;dojo.html;3325.368180045791;3328.334333133373;3333.733301335892;3353.7484688648356;3394.6944774970248;5506.724663766816;5598.4961353478175;5648.830535083949;5693.9715301423485;5702.8289151325425;4443.60007599316;5616.438356164392;5639.802606908759;5704.258446401983;5784.884302313952;5090.592752579803;5097.260897169908;5175.767090480937;5184.922226166592;5352.197170424429;5279.102552566073;5280.656757310781;5293.39126000511;5311.123664595337;5318.6011049171275;4222.725522841006;5120.692758434506;5157.277981082651;5164.431912489623;5289.444608316129;5131.076406246874;5139.794408223666;5140.74296285188;5201;5312.096943519572;5115.923261151086;5150.562202212779;5170.146925757245;5181.326427564392;5227.47725227478;4823.252395878644;4951.405831300267;5662.631928924607;5683.175939488751;5693.231413759131;5266.578673706094;6084.305145821375;6104.847378815521;6114.11345354921;6222.81331560054;6287.811365659038;6326.956052251373;6331.461825744817;6341.968290158519;6363.236411630588;5621.156826476062;5777.277840269966;5782.161586570008;5803.738831752581;5806.59353845231;6223.066540019034;6273.309935907047;6311.715972781236;6313.305536390993;6352.7776527822225;6133.355997620275;6144.692765361714;6146.877062458815;6147.200863887666;6156.384361563808;6186.10301506288;6206.007038873759;6262;6287.276963149205;6296.5592408530965;4935.851924442272;6042.939570604238;6106.460667179974;6120.69094295093;6148.754049838046;6205.689715514206;6213.943629582982;6220.098085777537;6232.906506402408;6234.438900498977;4900.142475066849;4903.632227582874;4911.066897289504;4912.926306105412;4951.480094590088;4299.355096735452;4343.956560434419;4368.475782906008;4433.401490798701;4459.219636563588;5764.452377024176;5798.391168927286;5816.76732930678;5829.621074630136;5858.5898987070495;6253.781117660951;6275.3724627537795;6286.591371560834;6297.811065668037;6309.211348581427;5631.859203519863;5682.7442765075675;5692.686902220335;5794.420557944172;5806.2451881255165;5366.087765079946;5391.245225668409;5391.865203369947;5445.83662490126;5449.264349312872;6306.274778400542;6355.841103972252;6356.904646430215;6361.395667411589;6365.490760739222;6130.061839217998;6134.681043575652;6266.467350275278;6275.3724627536885;6277.372262773686;5387.353517577916;6269.435750782452;6330.39861213184;6333.113364129118;6342.49260059185;6205.03821907605;6212.378762123752;6221.5333849962335;6232.657203853651;6235.875282494416;6131.0803379491645;6151.8926593213655;6317.557770955989;6322.399372059647;6331.556791024584;6017.187679663364;6102.298235702773;6103.42017508336;6110.6195130195665;6143.047827586731;6081.239845019372;6096.146539484387;6104.481119104926;6117.265928088658;6124.8162555121635;5772.220750198838;5902.498287645427;5917.053271476543;5923.022701254245;5942.7920022799;6074;6109.083637454418;6159.1377207190135;6174.907376389448;6176.166217560572;5944.702764861826;5949.196858424058;5965.761369545169;5985.700714964148;6017.969910150421 09:10:51 INFO - PROCESS | 1666 | |1;ext.html;430.44687576464247;535.3281631552401;546.1725485888877;560.0059893688704;563.1974436428089;34432.48351274733;39269;41579.376309355386;43404;43472.565274347246;42660.786696066476;43088;43129.784351078204;43152.352714709305;43268.701938941806;8669.046404895473;8681.175288347597;9890.604375824958;9899.851502227437;9908.355956862817;8662.220400163984;11912.285262884212;12132.454039568196;12150.392480375946;12347.629571112837;12189.573364932228;12261.019118470545;12264.853650611107;12274.693132671666;12325.93837030818;12156.51373945041;12233.510659573607;12254.080943929197;12254.693632659166;12260.570880019157;11678.708032299175;11796.587119450864;11954.342511161884;12020.939895300555;12039.337836418994;40509.189816203805;40750;40785.59214407847;40885;40903.7954810227;3298.4062868683627;3341.7159541439005;3361;3378.223008708011;3473.548438702978;24135.741674873843;29691.85154074216;30677.539836902466;30840;30947.916822911317;3017.788754787166;3170.5719727836677;3250.7399408047536;3322.5182348559565;3334;421168;488735.1126488761;495150;499597;646280;56955;57325.713371432874;57515.699372024654;57515.84968300694;57716.84566308734;58375;58707.70646146742;58803;59132.40867591355;59206.703966479894;15226.314815833313;15345.0025748326;15350.846491534941;15364.61588460275;15375.077495350315;9227.53862306882;11597.6520704379;12351.320677362832;12416.192947458387;12500.874991250153;15304.311305991258;15612.453564125428;15629.765553516707;15637.296321665324;15853.68292634141;6551.868962620721;6591.373819487141;6631.33686631333;6678.799636010927;6734.259231484532;876.7632739160391;914.5015966298383;985.802250265916;1042.1610603464285;1053.6364954090827;29050.7094929048;29501.96743113981;29699.693544435937;29734.107976760733;29870.85064574707;986.4032260482448;1017.7862648843677;1034.4827586206898;1071.0949247885524;1113.17068783755;14661.706765864836;15157.317920693375;15307.387704491695;15468.5359439217;15619.297131629104;665953;667482;668494;669135;671462;56573.43426565764;56663.71668141633;56691.86616267652;56732;56848.715756420956;1218.9817152742717;1318.960431187085;1353.1339942436848;1367.1591970938;1369.342715496587;24058.39854003664;29005.83976640995;31039.689603104584;31157.90947316833;31598.684013160495;47851;48344;48451.75774121107;48510.5148948506;48714.051437943504;519336;522087;522134;522772;523574;25071.498570028863;25899;25938;26530.60204096979;26680.59979100276;45899;46512.53487465217;47195.764021179675;47265;47706.761466192445;34039.638414463145;35245.82377088098;37926.051848704;37979.02440487529;38416.84749457521;38128.809355953046;38291.42562861615;38472.230555389295;39198.804005979786;39639.20721585494;37046.25907481889;37459.6254037467;38075.61924380721;38152.61847381491;38175.427368588935;26548.867255664372;31189.220269493446;33569.328613428086;33940;34063.48904766381;22518;24477.75522244826;25038.62442063334;25119.74880251174;25507.23478295654 09:10:51 INFO - PROCESS | 1666 | |2;jquery.html;354.2295507271683;371.5949614919738;373.12874438186833;382.1706896035602;403.96364327210546;14897.180655063981;14969.251537423126;20217.39347819564;20502;20593.485162870937;18783.62432751344;20195.091220895058;20664.586708265826;20666;21062.473438164052;5565.2486914266465;5982.461578457927;6218.8445288867915;6265.780697675582;6274.058891166316;6070.57505974582;6216.440520353167;6232.781852635158;6239.781607643733;6247.687615619224;5912.320083190423;6059.242594675666;6077.908831367533;6078.270607527103;6196.38036196379;6030.216071910623;6106.175666285061;6117.724702388358;6137.079438084301;6137.447629713325;5142.948570514284;5243.2659427680155;5299.178627312773;5312.415634280226;5316.867078323035;26309;26330.815113319946;26383.868080659475;26440;26675.46649067027;2251.6735073414425;2332.498512819735;2374.4894847607848;2432.5134973005293;2495.292607520842;15190.848091519165;15829.68340633181;16071.785642871473;16125.516234512867;16718.24767885448;1864.7482589850333;1895.3745264062964;1941.6602094633524;1991.1040031985665;2016.596680663873;114357;118388;118429.22356164665;119024;119849.80150198474;10021.448820314952;10257.230707696803;10997;11430.314181149157;11443.54225830974;13906.791398129037;13908.721825563433;13917.095388799899;13947.95390345728;13952.790708139386;8398.286145677564;8724.214820666044;8726.738197854074;8854.911450885409;8898.199162075443;6224.603527641891;8738.737837864874;8745.256653184424;8762.824743505094;8931.464112153291;6687.799366019027;6744.8983103341325;6776.15298087739;6835.316468353125;6911.6889739961825;1519.566923426818;1765.1968354398718;1809.4571628511394;1846.796852346241;1849.6670599292256;865.1953683074801;876.2824863267939;945.7210123013728;983.306768728045;1060.5280650110626;14676.779848302283;21635.13459461604;21711.457213569473;21853.67219491709;21854.89072554627;885.8095509465496;914;927.4481683398367;958.1472489484364;960.351762560269;10059.582374005557;10795;11610.477528511237;11836.76326473483;11854.525818967317;551491;569870.1506492441;578990;581649;588193;92921;95097.17992522662;122075;122302.38848805877;124499.75500244882;979.9167070799062;987.1658448610768;1006.2101250518308;1043.1915265669015;1043.8068957242933;19528.168415579945;20310.955333872706;20486.468653463184;20489.897550512153;20499.590008199455;52014.21978670399;52100;53126.734366327924;53941.73029134829;55373.446265536826;83560.74658880243;83829;84694.57652711944;85218;86328.56835716033;7119.857602848017;7396.260373962561;8000.719974800854;8005.159458257032;8336.208060234268;7234.312740289664;11121.332720036824;11972.401379930794;12344.197627154206;13407;9238.538073096453;11109.722256943318;11143;11615.477303521193;11772.646820595395;10290.691279261635;10941.179411544006;11094.334339939629;11171.106311495223;11611.941940290244;9042.954785226031;10600.681979540626;11402.657920262405;11643.88356116428;11863.881361186623;7237.927620723725;7241.746538871114;7376.926230737624;7380.040594722866;7482.438817088631;7835.921640783519;10328.380297182193;11221.326720396475;11549.48027338755;11578.594749183738 09:10:51 INFO - PROCESS | 1666 | |3;mootools.html;1529.2124555853736;1565.5929458340831;1777.4223377402348;1848.251458159446;1910.799366066563;8493.660253589856;9053.004169541346;9062.728118156458;9065.410748301356;9081.228095611872;7856.017997750281;8046.839063218732;8575.699850505234;8774.912250877489;8858.379913406065;2369.9763002369973;2401.543706695722;2404.5671779079757;2406.109739396426;2411.746766589509;2367.5738367094004;2392.5932591459405;2412.2763171048705;2412.6139817629182;2412.8914198861094;2364.267077206063;2378.512404956988;2390.4740956989435;2409.024345140221;2410.758924107593;2380.143148466551;2384.678068460753;2414.2998530426066;2417.456072383717;2420.334408037786;2369;2381.7141942966955;2383.1063351243283;2388.176079252655;2393.222202784102;8833.425827321267;8861.512616806072;8936.910630893737;8939.910600893973;8940.821183576358;5276.261323414725;5451.3458384993655;5454.53636440903;5459.863503412406;5467.863303417406;3659.030356955409;3666.3767159582935;3729.533808273966;3738.6448287412654;3743.7192210584044;1087.5323610847333;1092.580511829651;1098.8901109889027;1114.648885601033;1128.7573171768108;11776.293422394683;11874.762504749942;11884.762304753856;11892.345920974429;11902.464389102424;4675.9504649930395;4716.221823399101;4773.880652983703;4847.909220425447;4857.417109946829;10056.29605927578;10058.14505767018;10065.144462720604;10077.344972576759;10077.899221007696;5404.378496472956;5413.756380962866;5423.593230507728;5424.728763561806;5431.565474762009;4270.145970805851;4398.73607583546;4552.294394368878;4859.829905953346;4976.576990955737;3878.670313023368;3914.393269043303;3988.561258261589;4021.9890054972516;4061.329880569732;1293.1852932652369;1302.5310888080282;1302.8241187439764;1316.7037416581384;1322;837.899452065756;856.5674334461057;905.7056456651615;907.7095329494498;955.7897262602216;5701.572382071361;5746.511546518509;5970;6004.579679422399;6116.449519543174;944.7826999790087;945.0691069296737;954.9522523873778;960.673371053845;1004.633308842282;3902.2502678890164;3969.7221194516683;4035.6569691575955;4068.013346919976;4086.366613174963;9331.486768227813;10839.945800270949;10913.508892099875;10922.126229901589;10936.343819370863;8854.77863053416;10556.102731267774;10572.207084468695;10839.891601084046;10854.240203185702;7963.8805417918775;8177.918220817715;8181.345492360597;8183.590820458953;8192.385571082194;5853.707314634336;5859.414058594107;5895.911561326498;6039.396060393926;6244.906326405198;9644.75888102803;10110.898891010997;10186.388816670727;10200.897991019994;10322.535485903303;9909.752256193364;10037.347572408062;10289;10308.381497110197;10424.374537527772;6955.1653801544135;7028.191757947901;7524.510906791041;7555.622218888923;7686.692532298645;8310.501369917823;8475.533845638549;8480.067192608685;8484.575771211292;8484.575771211537;7379.262073792578;7505.962470187614;7525.510841795266;7626.54240745557;7631.847363052819;7175.390091842043;7281.963590182015;7315.122185337794;7340.082489688789;7452.478326517308;6824.863502730017;6973.686184121828;6975.895361569682;6998;7004.824879377852;4705.153072446992;4780.402449693788;4952.975235123801;5025.974870125626;5030.3963524377305;4934.136526107845;4940.2342636891335;5009.0983622948215;5036.571891389273;5215.973920130375 09:10:51 INFO - PROCESS | 1666 | |4;prototype.html;291.42879955287634;300.8856634478898;308.25863797566853;311.3120004789415;314.3681200786419;4638.512956139607;5004.398592450418;5472.452754724525;5489.451054894514;5520.316303527423;4418.2268103081915;4570.657200709943;5056.747162641863;5086.567641750456;5191.013707395602;4126.628603425691;4132.293347857159;4136.565660605638;4156.023334516386;4157.085441202946;3858.13192031792;4074.653654439376;4125.21620892031;4141.7100802943805;4145.150244199932;3323.9169020774552;3581.659742324475;3681.558213014442;3693.242885208526;3781.697464202857;4044.6966477514156;4069.369247766601;4094.303968325362;4101.52832424272;4110.362893751443;3494.7728397654328;3509.4911237870365;3512.6487351264923;3513.648635136466;3520.2079532105327;5030.144875371196;5158.613104017176;5228.738563071831;5238.8690282742855;5319.707416092114;4608.331791890158;4611.30830375443;4648.209804333272;4667.22990706533;4675.228587283094;4676.392069031004;4806.879828004293;5646.378898321182;5689.975804355215;5697.4587414196;3458.1181798641187;3672.669459748609;3818.384406681432;3825.1393436476847;3843.961560384388;5813.709314534256;5836.824895253149;5863.589548731633;5904.321003084658;5928.40715928408;3692.8367564217187;3772.830222639988;3789.905252368713;3802.923941521154;3833.5783063862955;3314.8011119332436;3559.750817442754;3779.603141670085;3812.932378933903;3819.579846216914;3718.6612819385;3761.7554858934627;3934.5868683788362;4311.663384350799;4493.932591011137;5074.8327884586015;5293.258943747878;5341.252224688546;5603.935252302131;5672.525143462647;1045.8483519889573;1129.0403157316216;1216.6775804411661;1242.1739543203848;1318.5187406596715;742.7103429662436;767.623864306497;809.29591255608;820.953284562188;825.2696363718153;4102.5692302307825;4116.773577453209;4391.429114215195;4442.888927776831;4536.818527258939;4320.4599425071865;4468.4414448193975;4873.415190177201;4889.2910527973245;4924.1875090610365;3828.7319887608155;4424.668149888771;4438.889027774331;4481.932771008437;4971.726555039508;2783.9860800696274;2862.298736809495;2863.8568071596337;3070.738987186114;3090.7218350348126;4524.895923395637;5395.757190926339;5736.024875771129;6054.697265136726;6076.453119219292;5137.383513978347;5387.919181212285;5655.688937108416;5953.970230148821;6019.398060193946;5257.317658349291;5406.513413792777;5958.582899197015;6039.607425517327;6053.79036651619;4448.844290449948;5810.5061069809535;5845.3277873045145;5885.911711324248;5892.819656727039;4522.145920172713;5750.424957504216;5752.395998420106;5765.596408251382;5766.568891509545;4812.639052071038;5225.764840582259;6004.159417681441;6042.305134909541;6109.083637454418;3719.739618226806;3855.614438556122;3868.864589739346;3884.514435695538;3891.708121890813;4295.656347492256;4917.262410638433;5760.740766665594;5810.4189581041555;5843.620164689281;4779.976100119477;5551.666899986014;5713.342965559014;5727;5737.368889422244;5298.523132918056;5677.1768093627015;5689.914651280152;5709.800156994485;5759.366469688414;4635.814567417266;5073.264376665436;5563.383800529688;5565.499105080562;5607.271054762855;4961.727105009115;5214.739263036757;5261.736913154404;5280.155175171954;5659.236003139524;5033.370828646419;5496.725163741877;5645.237892884572;5688.5733569981585;5698.715064246854 09:10:51 INFO - PROCESS | 1666 | |5;yui.html;718.7951433841356;721.9061522002143;782.7103971530531;804.8591496488114;866.1857853617597;14743.410263589458;15225.695486090272;15869;15870.206489675513;16154.596135096599;12143.75712485752;14422.855771442282;14755.18846463444;14787.40850365984;15060.24698765063;693.3240090911371;707.3775077931413;850.7745447456414;876.1807709791334;879.5074758135464;701.5019336271254;703.7501686901153;705.3334598804132;847.6100993542947;867.5271976772674;912.2747415804452;913.8126684029758;914.9843673522385;916.8808054952847;919.0396036142214;906.6101576322179;906.7461110888962;906.8277027364779;907.3059109781022;908.5139450394073;538.1121150102323;550.5540512185142;554.2296208270507;674.0697836984979;675.2504719761062;12527.498900043987;14326.212058336787;14868.479603213835;14891.925540372336;14936.701265974729;14327.426902923871;14622;14702;14917.254137293092;15235.390584376612;11820.645380638594;11834.230774999598;11892.940535297268;11943.223690460092;12162.391880405945;3241.789283696552;3716.6655001050035;3817.6945844332386;3828.885133446001;3947.407888816672;114887;115989;116429;116666.41666791697;126781.36609316987;10923.508442120125;10967.725806854893;11030.779384412428;11299.774004519864;11438.428078596036;23121.653175202384;23326.53346933052;23358.299251022156;23420.531589368118;23547.646785298235;7970.402219833536;7992.920811521582;8037.437379383387;8137.75586732399;8254.463459875089;4444.555544445594;4543;4550.499445061107;4609.308156077763;4614.123316569841;3558.2349794793727;3675.7610755301353;3677.191017976041;3677.3748462761396;3678.70570354371;589.9321578018582;651.7588492257895;657.7960832142052;666.6966530228734;668.1280928388403;584.386394285998;599.8650303681636;604.803438882365;648.1476857931899;658.4765111736182;8590.44585033142;9196.862047069299;9290.16388525036;9453.810923781624;9497.715068547956;552.809280798124;615.9106929495198;653.857013359485;665.7936039827669;675.321302091395;4482.327650852399;4505.144022635689;4520.849443816533;4525.343825145335;4597.804167600256;162051;165777;166257.16871415565;166522;175972;139731.30134349264;143105.8534121989;143754;143813;144884.7161397405;29622;29732.55401168984;29738;29754.702452975194;94988;8160.428769986044;8186.467879587808;8675.566221689016;8820.962431070744;8915.197632213132;62934;66286.33713662802;67953.66023169852;69183.3081669197;70436.59126817537;69175.65412172907;100005;102708;104203;106158.87682246466;11347.716307092389;11639.359835209145;12897.484100636244;12935.870641293466;13435.596932092052;14416.207108608707;14722.116672999655;14796.778048329068;15023.474178403703;15092;13740.725185496434;13747.587572372844;14061.500319897534;14645.9747817656;14725.926370368079;13617.319134043457;13630.890739813853;13757.449702011807;13872.653183670489;14466.855331446552;11780.58767943152;12731.93634031824;13185.34073296312;13723.931380343034;14061.718765624426;9680.661176858775;10789.082927951213;11260.605878794202;11506.884931150582;11783.76432471363;10978.560857565928;11289.943550282196;11368.147388946027;11560.30638161713;11621.941890290494 09:10:51 INFO - PROCESS | 1666 | __end_tp_report 09:10:51 INFO - PROCESS | 1666 | __start_cc_report 09:10:51 INFO - PROCESS | 1666 | _x_x_mozilla_cycle_collect,1232 09:10:51 INFO - PROCESS | 1666 | __end_cc_report 09:10:51 INFO - PROCESS | 1666 | __startTimestamp1473178251684__endTimestamp 09:10:51 INFO - PROCESS | 1666 | 09:10:51 INFO - PROCESS | 1666 | ------- Summary: start ------- 09:10:51 INFO - PROCESS | 1666 | Number of tests: 6 09:10:51 INFO - PROCESS | 1666 | 09:10:51 INFO - PROCESS | 1666 | [#0] dojo.html Cycles:165 Average:5706.85 Median:5942.79 stddev:671.56 (11.3%) stddev-sans-first:647.11 09:10:51 INFO - PROCESS | 1666 | Values: 3325.4 3328.3 3333.7 3353.7 3394.7 5506.7 5598.5 5648.8 5694.0 5702.8 4443.6 5616.4 5639.8 5704.3 5784.9 5090.6 5097.3 5175.8 5184.9 5352.2 5279.1 5280.7 5293.4 5311.1 5318.6 4222.7 5120.7 5157.3 5164.4 5289.4 5131.1 5139.8 5140.7 5201.0 5312.1 5115.9 5150.6 5170.1 5181.3 5227.5 4823.3 4951.4 5662.6 5683.2 5693.2 5266.6 6084.3 6104.8 6114.1 6222.8 6287.8 6327.0 6331.5 6342.0 6363.2 5621.2 5777.3 5782.2 5803.7 5806.6 6223.1 6273.3 6311.7 6313.3 6352.8 6133.4 6144.7 6146.9 6147.2 6156.4 6186.1 6206.0 6262.0 6287.3 6296.6 4935.9 6042.9 6106.5 6120.7 6148.8 6205.7 6213.9 6220.1 6232.9 6234.4 4900.1 4903.6 4911.1 4912.9 4951.5 4299.4 4344.0 4368.5 4433.4 4459.2 5764.5 5798.4 5816.8 5829.6 5858.6 6253.8 6275.4 6286.6 6297.8 6309.2 5631.9 5682.7 5692.7 5794.4 5806.2 5366.1 5391.2 5391.9 5445.8 5449.3 6306.3 6355.8 6356.9 6361.4 6365.5 6130.1 6134.7 6266.5 6275.4 6277.4 5387.4 6269.4 6330.4 6333.1 6342.5 6205.0 6212.4 6221.5 6232.7 6235.9 6131.1 6151.9 6317.6 6322.4 6331.6 6017.2 6102.3 6103.4 6110.6 6143.0 6081.2 6096.1 6104.5 6117.3 6124.8 5772.2 5902.5 5917.1 5923.0 5942.8 6074.0 6109.1 6159.1 6174.9 6176.2 5944.7 5949.2 5965.8 5985.7 6018.0 09:10:51 INFO - PROCESS | 1666 | 09:10:51 INFO - PROCESS | 1666 | [#1] ext.html Cycles:180 Average:69699.64 Median:19359.69 stddev:153239.54 (791.5%) stddev-sans-first:153581.16 09:10:51 INFO - PROCESS | 1666 | Values: 430.4 535.3 546.2 560.0 563.2 34432.5 39269.0 41579.4 43404.0 43472.6 42660.8 43088.0 43129.8 43152.4 43268.7 8669.0 8681.2 9890.6 9899.9 9908.4 8662.2 11912.3 12132.5 12150.4 12347.6 12189.6 12261.0 12264.9 12274.7 12325.9 12156.5 12233.5 12254.1 12254.7 12260.6 11678.7 11796.6 11954.3 12020.9 12039.3 40509.2 40750.0 40785.6 40885.0 40903.8 3298.4 3341.7 3361.0 3378.2 3473.5 24135.7 29691.9 30677.5 30840.0 30947.9 3017.8 3170.6 3250.7 3322.5 3334.0 421168.0 488735.1 495150.0 499597.0 646280.0 56955.0 57325.7 57515.7 57515.8 57716.8 58375.0 58707.7 58803.0 59132.4 59206.7 15226.3 15345.0 15350.8 15364.6 15375.1 9227.5 11597.7 12351.3 12416.2 12500.9 15304.3 15612.5 15629.8 15637.3 15853.7 6551.9 6591.4 6631.3 6678.8 6734.3 876.8 914.5 985.8 1042.2 1053.6 29050.7 29502.0 29699.7 29734.1 29870.9 986.4 1017.8 1034.5 1071.1 1113.2 14661.7 15157.3 15307.4 15468.5 15619.3 665953.0 667482.0 668494.0 669135.0 671462.0 56573.4 56663.7 56691.9 56732.0 56848.7 1219.0 1319.0 1353.1 1367.2 1369.3 24058.4 29005.8 31039.7 31157.9 31598.7 47851.0 48344.0 48451.8 48510.5 48714.1 519336.0 522087.0 522134.0 522772.0 523574.0 25071.5 25899.0 25938.0 26530.6 26680.6 45899.0 46512.5 47195.8 47265.0 47706.8 34039.6 35245.8 37926.1 37979.0 38416.8 38128.8 38291.4 38472.2 39198.8 39639.2 37046.3 37459.6 38075.6 38152.6 38175.4 26548.9 31189.2 33569.3 33940.0 34063.5 22518.0 24477.8 25038.6 25119.7 25507.2 09:10:51 INFO - PROCESS | 1666 | 09:10:51 INFO - PROCESS | 1666 | [#2] jquery.html Cycles:180 Average:34210.00 Median:26411.93 stddev:95746.46 (362.5%) stddev-sans-first:95981.31 09:10:51 INFO - PROCESS | 1666 | Values: 354.2 371.6 373.1 382.2 404.0 14897.2 14969.3 20217.4 20502.0 20593.5 18783.6 20195.1 20664.6 20666.0 21062.5 5565.2 5982.5 6218.8 6265.8 6274.1 6070.6 6216.4 6232.8 6239.8 6247.7 5912.3 6059.2 6077.9 6078.3 6196.4 6030.2 6106.2 6117.7 6137.1 6137.4 5142.9 5243.3 5299.2 5312.4 5316.9 26309.0 26330.8 26383.9 26440.0 26675.5 2251.7 2332.5 2374.5 2432.5 2495.3 15190.8 15829.7 16071.8 16125.5 16718.2 1864.7 1895.4 1941.7 1991.1 2016.6 114357.0 118388.0 118429.2 119024.0 119849.8 10021.4 10257.2 10997.0 11430.3 11443.5 13906.8 13908.7 13917.1 13948.0 13952.8 8398.3 8724.2 8726.7 8854.9 8898.2 6224.6 8738.7 8745.3 8762.8 8931.5 6687.8 6744.9 6776.2 6835.3 6911.7 1519.6 1765.2 1809.5 1846.8 1849.7 865.2 876.3 945.7 983.3 1060.5 14676.8 21635.1 21711.5 21853.7 21854.9 885.8 914.0 927.4 958.1 960.4 10059.6 10795.0 11610.5 11836.8 11854.5 551491.0 569870.2 578990.0 581649.0 588193.0 92921.0 95097.2 122075.0 122302.4 124499.8 979.9 987.2 1006.2 1043.2 1043.8 19528.2 20311.0 20486.5 20489.9 20499.6 52014.2 52100.0 53126.7 53941.7 55373.4 83560.7 83829.0 84694.6 85218.0 86328.6 7119.9 7396.3 8000.7 8005.2 8336.2 7234.3 11121.3 11972.4 12344.2 13407.0 9238.5 11109.7 11143.0 11615.5 11772.6 10290.7 10941.2 11094.3 11171.1 11611.9 9043.0 10600.7 11402.7 11643.9 11863.9 7237.9 7241.7 7376.9 7380.0 7482.4 7835.9 10328.4 11221.3 11549.5 11578.6 09:10:51 INFO - PROCESS | 1666 | 09:10:51 INFO - PROCESS | 1666 | [#3] mootools.html Cycles:180 Average:5746.13 Median:4852.66 stddev:3193.35 (65.8%) stddev-sans-first:3186.58 09:10:51 INFO - PROCESS | 1666 | Values: 1529.2 1565.6 1777.4 1848.3 1910.8 8493.7 9053.0 9062.7 9065.4 9081.2 7856.0 8046.8 8575.7 8774.9 8858.4 2370.0 2401.5 2404.6 2406.1 2411.7 2367.6 2392.6 2412.3 2412.6 2412.9 2364.3 2378.5 2390.5 2409.0 2410.8 2380.1 2384.7 2414.3 2417.5 2420.3 2369.0 2381.7 2383.1 2388.2 2393.2 8833.4 8861.5 8936.9 8939.9 8940.8 5276.3 5451.3 5454.5 5459.9 5467.9 3659.0 3666.4 3729.5 3738.6 3743.7 1087.5 1092.6 1098.9 1114.6 1128.8 11776.3 11874.8 11884.8 11892.3 11902.5 4676.0 4716.2 4773.9 4847.9 4857.4 10056.3 10058.1 10065.1 10077.3 10077.9 5404.4 5413.8 5423.6 5424.7 5431.6 4270.1 4398.7 4552.3 4859.8 4976.6 3878.7 3914.4 3988.6 4022.0 4061.3 1293.2 1302.5 1302.8 1316.7 1322.0 837.9 856.6 905.7 907.7 955.8 5701.6 5746.5 5970.0 6004.6 6116.4 944.8 945.1 955.0 960.7 1004.6 3902.3 3969.7 4035.7 4068.0 4086.4 9331.5 10839.9 10913.5 10922.1 10936.3 8854.8 10556.1 10572.2 10839.9 10854.2 7963.9 8177.9 8181.3 8183.6 8192.4 5853.7 5859.4 5895.9 6039.4 6244.9 9644.8 10110.9 10186.4 10200.9 10322.5 9909.8 10037.3 10289.0 10308.4 10424.4 6955.2 7028.2 7524.5 7555.6 7686.7 8310.5 8475.5 8480.1 8484.6 8484.6 7379.3 7506.0 7525.5 7626.5 7631.8 7175.4 7282.0 7315.1 7340.1 7452.5 6824.9 6973.7 6975.9 6998.0 7004.8 4705.2 4780.4 4953.0 5026.0 5030.4 4934.1 4940.2 5009.1 5036.6 5216.0 09:10:51 INFO - PROCESS | 1666 | 09:10:51 INFO - PROCESS | 1666 | [#4] prototype.html Cycles:180 Average:4439.37 Median:4793.43 stddev:1394.94 (29.1%) stddev-sans-first:1363.66 09:10:51 INFO - PROCESS | 1666 | Values: 291.4 300.9 308.3 311.3 314.4 4638.5 5004.4 5472.5 5489.5 5520.3 4418.2 4570.7 5056.7 5086.6 5191.0 4126.6 4132.3 4136.6 4156.0 4157.1 3858.1 4074.7 4125.2 4141.7 4145.2 3323.9 3581.7 3681.6 3693.2 3781.7 4044.7 4069.4 4094.3 4101.5 4110.4 3494.8 3509.5 3512.6 3513.6 3520.2 5030.1 5158.6 5228.7 5238.9 5319.7 4608.3 4611.3 4648.2 4667.2 4675.2 4676.4 4806.9 5646.4 5690.0 5697.5 3458.1 3672.7 3818.4 3825.1 3844.0 5813.7 5836.8 5863.6 5904.3 5928.4 3692.8 3772.8 3789.9 3802.9 3833.6 3314.8 3559.8 3779.6 3812.9 3819.6 3718.7 3761.8 3934.6 4311.7 4493.9 5074.8 5293.3 5341.3 5603.9 5672.5 1045.8 1129.0 1216.7 1242.2 1318.5 742.7 767.6 809.3 821.0 825.3 4102.6 4116.8 4391.4 4442.9 4536.8 4320.5 4468.4 4873.4 4889.3 4924.2 3828.7 4424.7 4438.9 4481.9 4971.7 2784.0 2862.3 2863.9 3070.7 3090.7 4524.9 5395.8 5736.0 6054.7 6076.5 5137.4 5387.9 5655.7 5954.0 6019.4 5257.3 5406.5 5958.6 6039.6 6053.8 4448.8 5810.5 5845.3 5885.9 5892.8 4522.1 5750.4 5752.4 5765.6 5766.6 4812.6 5225.8 6004.2 6042.3 6109.1 3719.7 3855.6 3868.9 3884.5 3891.7 4295.7 4917.3 5760.7 5810.4 5843.6 4780.0 5551.7 5713.3 5727.0 5737.4 5298.5 5677.2 5689.9 5709.8 5759.4 4635.8 5073.3 5563.4 5565.5 5607.3 4961.7 5214.7 5261.7 5280.2 5659.2 5033.4 5496.7 5645.2 5688.6 5698.7 09:10:51 INFO - PROCESS | 1666 | 09:10:51 INFO - PROCESS | 1666 | [#5] yui.html Cycles:180 Average:24447.74 Median:29746.35 stddev:41164.69 (138.4%) stddev-sans-first:41241.61 09:10:51 INFO - PROCESS | 1666 | Values: 718.8 721.9 782.7 804.9 866.2 14743.4 15225.7 15869.0 15870.2 16154.6 12143.8 14422.9 14755.2 14787.4 15060.2 693.3 707.4 850.8 876.2 879.5 701.5 703.8 705.3 847.6 867.5 912.3 913.8 915.0 916.9 919.0 906.6 906.7 906.8 907.3 908.5 538.1 550.6 554.2 674.1 675.3 12527.5 14326.2 14868.5 14891.9 14936.7 14327.4 14622.0 14702.0 14917.3 15235.4 11820.6 11834.2 11892.9 11943.2 12162.4 3241.8 3716.7 3817.7 3828.9 3947.4 114887.0 115989.0 116429.0 116666.4 126781.4 10923.5 10967.7 11030.8 11299.8 11438.4 23121.7 23326.5 23358.3 23420.5 23547.6 7970.4 7992.9 8037.4 8137.8 8254.5 4444.6 4543.0 4550.5 4609.3 4614.1 3558.2 3675.8 3677.2 3677.4 3678.7 589.9 651.8 657.8 666.7 668.1 584.4 599.9 604.8 648.1 658.5 8590.4 9196.9 9290.2 9453.8 9497.7 552.8 615.9 653.9 665.8 675.3 4482.3 4505.1 4520.8 4525.3 4597.8 162051.0 165777.0 166257.2 166522.0 175972.0 139731.3 143105.9 143754.0 143813.0 144884.7 29622.0 29732.6 29738.0 29754.7 94988.0 8160.4 8186.5 8675.6 8821.0 8915.2 62934.0 66286.3 67953.7 69183.3 70436.6 69175.7 100005.0 102708.0 104203.0 106158.9 11347.7 11639.4 12897.5 12935.9 13435.6 14416.2 14722.1 14796.8 15023.5 15092.0 13740.7 13747.6 14061.5 14646.0 14725.9 13617.3 13630.9 13757.4 13872.7 14466.9 11780.6 12731.9 13185.3 13723.9 14061.7 9680.7 10789.1 11260.6 11506.9 11783.8 10978.6 11289.9 11368.1 11560.3 11621.9 09:10:51 INFO - PROCESS | 1666 | -------- Summary: end -------- 09:10:51 INFO - PROCESS | 1666 | 09:10:52 INFO - TEST-INFO | 1666: exit 0 09:10:52 INFO - TEST-OK | dromaeo_css | took 1117332ms 09:10:52 INFO - TEST-START | kraken 09:10:52 INFO - operating with platform_type : mac_ 09:10:52 INFO - Initialising browser for kraken test... 09:10:52 INFO - TEST-INFO | started process 1671 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/tmpPfplzJ/profile http://localhost:49272/getInfo.html) 09:10:54 INFO - PROCESS | 1671 | __metrics Screen width/height:1600/1200 09:10:54 INFO - PROCESS | 1671 | colorDepth:24 09:10:54 INFO - PROCESS | 1671 | Browser inner width/height: 1024/689 09:10:54 INFO - PROCESS | 1671 | __metrics 09:10:54 INFO - PROCESS | 1671 | 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" 09:10:54 INFO - PROCESS | 1671 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:10:55 INFO - TEST-INFO | 1671: exit 0 09:10:55 INFO - Browser initialized. 09:10:55 INFO - Running cycle 1/1 for kraken test... 09:10:55 INFO - TEST-INFO | started process 1672 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/tmpPfplzJ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:11:07 INFO - PROCESS | 1672 | RSS: Main: 232542208 09:11:07 INFO - PROCESS | 1672 | 09:11:09 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49272/tests/kraken/driver.html?testName=audio-beat-detection) 09:11:10 INFO - PROCESS | 1672 | RSS: Main: 291766272 09:11:10 INFO - PROCESS | 1672 | 09:11:13 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49272/tests/kraken/driver.html?testName=audio-dft) 09:11:14 INFO - PROCESS | 1672 | RSS: Main: 288690176 09:11:14 INFO - PROCESS | 1672 | 09:11:17 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49272/tests/kraken/driver.html?testName=audio-fft) 09:11:18 INFO - PROCESS | 1672 | RSS: Main: 376164352 09:11:18 INFO - PROCESS | 1672 | 09:11:20 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49272/tests/kraken/driver.html?testName=audio-oscillator) 09:11:20 INFO - PROCESS | 1672 | RSS: Main: 278798336 09:11:20 INFO - PROCESS | 1672 | 09:11:22 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49272/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:11:23 INFO - PROCESS | 1672 | RSS: Main: 282226688 09:11:23 INFO - PROCESS | 1672 | 09:11:26 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49272/tests/kraken/driver.html?testName=imaging-darkroom) 09:11:26 INFO - PROCESS | 1672 | RSS: Main: 320913408 09:11:26 INFO - PROCESS | 1672 | 09:11:29 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49272/tests/kraken/driver.html?testName=imaging-desaturate) 09:11:30 INFO - PROCESS | 1672 | RSS: Main: 320888832 09:11:30 INFO - PROCESS | 1672 | 09:11:32 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49272/tests/kraken/driver.html?testName=json-parse-financial) 09:11:33 INFO - PROCESS | 1672 | RSS: Main: 320966656 09:11:33 INFO - PROCESS | 1672 | 09:11:35 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49272/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:11:35 INFO - PROCESS | 1672 | RSS: Main: 298864640 09:11:35 INFO - PROCESS | 1672 | 09:11:37 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:11:38 INFO - PROCESS | 1672 | RSS: Main: 304599040 09:11:38 INFO - PROCESS | 1672 | 09:11:40 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:11:41 INFO - PROCESS | 1672 | RSS: Main: 307814400 09:11:41 INFO - PROCESS | 1672 | 09:11:44 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:11:44 INFO - PROCESS | 1672 | RSS: Main: 319979520 09:11:44 INFO - PROCESS | 1672 | 09:11:47 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:11:48 INFO - PROCESS | 1672 | RSS: Main: 316162048 09:11:48 INFO - PROCESS | 1672 | 09:11:50 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49272/tests/kraken/driver.html?testName=ai-astar) 09:11:50 INFO - PROCESS | 1672 | RSS: Main: 359596032 09:11:50 INFO - PROCESS | 1672 | 09:11:50 INFO - PROCESS | 1672 | __start_tp_report 09:11:50 INFO - PROCESS | 1672 | _x_x_mozilla_page_load 09:11:50 INFO - PROCESS | 1672 | _x_x_mozilla_page_load_details 09:11:50 INFO - PROCESS | 1672 | |i|pagename|runs| 09:11:50 INFO - PROCESS | 1672 | |0;ai-astar;115;115;116;114;112;115;113;115;115;125 09:11:50 INFO - PROCESS | 1672 | |1;audio-beat-detection;145;114;132;187;138;134;128;106;156;109 09:11:50 INFO - PROCESS | 1672 | |2;audio-dft;185;186;183;183;183;184;180;181;185;182 09:11:50 INFO - PROCESS | 1672 | |3;audio-fft;77;76;78;152;57;57;57;65;144;56 09:11:50 INFO - PROCESS | 1672 | |4;audio-oscillator;82;84;130;70;75;91;120;70;71;119 09:11:50 INFO - PROCESS | 1672 | |5;imaging-gaussian-blur;88;84;87;85;87;84;88;84;89;84 09:11:50 INFO - PROCESS | 1672 | |6;imaging-darkroom;97;97;97;97;97;101;96;96;96;95 09:11:50 INFO - PROCESS | 1672 | |7;imaging-desaturate;86;84;84;87;85;83;84;84;86;84 09:11:50 INFO - PROCESS | 1672 | |8;json-parse-financial;55;57;58;56;56;57;56;54;54;52 09:11:50 INFO - PROCESS | 1672 | |9;json-stringify-tinderbox;67;65;72;68;72;78;73;70;69;71 09:11:50 INFO - PROCESS | 1672 | |10;stanford-crypto-aes;85;87;87;88;84;85;87;84;86;86 09:11:50 INFO - PROCESS | 1672 | |11;stanford-crypto-ccm;136;138;135;136;139;137;134;139;182;159 09:11:50 INFO - PROCESS | 1672 | |12;stanford-crypto-pbkdf2;167;166;165;166;164;173;237;237;168;166 09:11:50 INFO - PROCESS | 1672 | |13;stanford-crypto-sha256-iterative;69;65;67;67;66;68;67;66;65;66 09:11:50 INFO - PROCESS | 1672 | __end_tp_report 09:11:50 INFO - PROCESS | 1672 | __start_cc_report 09:11:50 INFO - PROCESS | 1672 | _x_x_mozilla_cycle_collect,1996 09:11:50 INFO - PROCESS | 1672 | __end_cc_report 09:11:50 INFO - PROCESS | 1672 | __startTimestamp1473178310247__endTimestamp 09:11:50 INFO - PROCESS | 1672 | 09:11:50 INFO - PROCESS | 1672 | ------- Summary: start ------- 09:11:50 INFO - PROCESS | 1672 | Number of tests: 14 09:11:50 INFO - PROCESS | 1672 | 09:11:50 INFO - PROCESS | 1672 | [#0] ai-astar Cycles:10 Average:115.50 Median:115.00 stddev:3.54 (3.1%) stddev-sans-first:3.75 09:11:50 INFO - PROCESS | 1672 | Values: 115.0 115.0 116.0 114.0 112.0 115.0 113.0 115.0 115.0 125.0 09:11:50 INFO - PROCESS | 1672 | 09:11:50 INFO - PROCESS | 1672 | [#1] audio-beat-detection Cycles:10 Average:134.90 Median:136.00 stddev:24.20 (17.8%) stddev-sans-first:25.39 09:11:50 INFO - PROCESS | 1672 | Values: 145.0 114.0 132.0 187.0 138.0 134.0 128.0 106.0 156.0 109.0 09:11:50 INFO - PROCESS | 1672 | 09:11:50 INFO - PROCESS | 1672 | [#2] audio-dft Cycles:10 Average:183.20 Median:183.50 stddev:1.87 (1.0%) stddev-sans-first:1.87 09:11:50 INFO - PROCESS | 1672 | Values: 185.0 186.0 183.0 183.0 183.0 184.0 180.0 181.0 185.0 182.0 09:11:50 INFO - PROCESS | 1672 | 09:11:50 INFO - PROCESS | 1672 | [#3] audio-fft Cycles:10 Average:81.90 Median:61.00 stddev:36.00 (59.0%) stddev-sans-first:38.13 09:11:50 INFO - PROCESS | 1672 | Values: 77.0 76.0 78.0 152.0 57.0 57.0 57.0 65.0 144.0 56.0 09:11:50 INFO - PROCESS | 1672 | 09:11:50 INFO - PROCESS | 1672 | [#4] audio-oscillator Cycles:10 Average:91.20 Median:73.00 stddev:23.13 (31.7%) stddev-sans-first:24.29 09:11:50 INFO - PROCESS | 1672 | Values: 82.0 84.0 130.0 70.0 75.0 91.0 120.0 70.0 71.0 119.0 09:11:50 INFO - PROCESS | 1672 | 09:11:50 INFO - PROCESS | 1672 | [#5] imaging-gaussian-blur Cycles:10 Average:86.00 Median:87.00 stddev:2.00 (2.3%) stddev-sans-first:1.99 09:11:50 INFO - PROCESS | 1672 | Values: 88.0 84.0 87.0 85.0 87.0 84.0 88.0 84.0 89.0 84.0 09:11:50 INFO - PROCESS | 1672 | 09:11:50 INFO - PROCESS | 1672 | [#6] imaging-darkroom Cycles:10 Average:96.90 Median:97.00 stddev:1.60 (1.6%) stddev-sans-first:1.69 09:11:50 INFO - PROCESS | 1672 | Values: 97.0 97.0 97.0 97.0 97.0 101.0 96.0 96.0 96.0 95.0 09:11:50 INFO - PROCESS | 1672 | 09:11:50 INFO - PROCESS | 1672 | [#7] imaging-desaturate Cycles:10 Average:84.70 Median:84.50 stddev:1.25 (1.5%) stddev-sans-first:1.24 09:11:50 INFO - PROCESS | 1672 | Values: 86.0 84.0 84.0 87.0 85.0 83.0 84.0 84.0 86.0 84.0 09:11:50 INFO - PROCESS | 1672 | 09:11:50 INFO - PROCESS | 1672 | [#8] json-parse-financial Cycles:10 Average:55.50 Median:56.00 stddev:1.78 (3.2%) stddev-sans-first:1.88 09:11:50 INFO - PROCESS | 1672 | Values: 55.0 57.0 58.0 56.0 56.0 57.0 56.0 54.0 54.0 52.0 09:11:50 INFO - PROCESS | 1672 | 09:11:50 INFO - PROCESS | 1672 | [#9] json-stringify-tinderbox Cycles:10 Average:70.50 Median:71.50 stddev:3.63 (5.1%) stddev-sans-first:3.62 09:11:50 INFO - PROCESS | 1672 | Values: 67.0 65.0 72.0 68.0 72.0 78.0 73.0 70.0 69.0 71.0 09:11:50 INFO - PROCESS | 1672 | 09:11:50 INFO - PROCESS | 1672 | [#10] stanford-crypto-aes Cycles:10 Average:85.90 Median:86.50 stddev:1.37 (1.6%) stddev-sans-first:1.41 09:11:50 INFO - PROCESS | 1672 | Values: 85.0 87.0 87.0 88.0 84.0 85.0 87.0 84.0 86.0 86.0 09:11:50 INFO - PROCESS | 1672 | 09:11:50 INFO - PROCESS | 1672 | [#11] stanford-crypto-ccm Cycles:10 Average:143.50 Median:138.50 stddev:15.31 (11.1%) stddev-sans-first:16.00 09:11:50 INFO - PROCESS | 1672 | Values: 136.0 138.0 135.0 136.0 139.0 137.0 134.0 139.0 182.0 159.0 09:11:50 INFO - PROCESS | 1672 | 09:11:50 INFO - PROCESS | 1672 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:180.90 Median:167.50 stddev:29.67 (17.7%) stddev-sans-first:31.04 09:11:50 INFO - PROCESS | 1672 | Values: 167.0 166.0 165.0 166.0 164.0 173.0 237.0 237.0 168.0 166.0 09:11:50 INFO - PROCESS | 1672 | 09:11:50 INFO - PROCESS | 1672 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.60 Median:67.00 stddev:1.26 (1.9%) stddev-sans-first:1.00 09:11:50 INFO - PROCESS | 1672 | Values: 69.0 65.0 67.0 67.0 66.0 68.0 67.0 66.0 65.0 66.0 09:11:50 INFO - PROCESS | 1672 | -------- Summary: end -------- 09:11:50 INFO - PROCESS | 1672 | 09:11:51 INFO - TEST-INFO | 1672: exit 0 09:11:51 INFO - TEST-OK | kraken | took 58797ms 09:11:51 INFO - SUITE-END | took 1176s 09:11:51 INFO - Completed test suite (00:19:36) 09:11:51 INFO - javascript benchmark 09:11:51 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3325.368180045791, 3328.334333133373, 3333.733301335892, 3353.7484688648356, 3394.6944774970248, 5506.724663766816, 5598.4961353478175, 5648.830535083949, 5693.9715301423485, 5702.8289151325425, 4443.60007599316, 5616.438356164392, 5639.802606908759, 5704.258446401983, 5784.884302313952, 5090.592752579803, 5097.260897169908, 5175.767090480937, 5184.922226166592, 5352.197170424429, 5279.102552566073, 5280.656757310781, 5293.39126000511, 5311.123664595337, 5318.6011049171275, 4222.725522841006, 5120.692758434506, 5157.277981082651, 5164.431912489623, 5289.444608316129, 5131.076406246874, 5139.794408223666, 5140.74296285188, 5201.0, 5312.096943519572, 5115.923261151086, 5150.562202212779, 5170.146925757245, 5181.326427564392, 5227.47725227478, 4823.252395878644, 4951.405831300267, 5662.631928924607, 5683.175939488751, 5693.231413759131, 5266.578673706094, 6084.305145821375, 6104.847378815521, 6114.11345354921, 6222.81331560054, 6287.811365659038, 6326.956052251373, 6331.461825744817, 6341.968290158519, 6363.236411630588, 5621.156826476062, 5777.277840269966, 5782.161586570008, 5803.738831752581, 5806.59353845231, 6223.066540019034, 6273.309935907047, 6311.715972781236, 6313.305536390993, 6352.7776527822225, 6133.355997620275, 6144.692765361714, 6146.877062458815, 6147.200863887666, 6156.384361563808, 6186.10301506288, 6206.007038873759, 6262.0, 6287.276963149205, 6296.5592408530965, 4935.851924442272, 6042.939570604238, 6106.460667179974, 6120.69094295093, 6148.754049838046, 6205.689715514206, 6213.943629582982, 6220.098085777537, 6232.906506402408, 6234.438900498977, 4900.142475066849, 4903.632227582874, 4911.066897289504, 4912.926306105412, 4951.480094590088, 4299.355096735452, 4343.956560434419, 4368.475782906008, 4433.401490798701, 4459.219636563588, 5764.452377024176, 5798.391168927286, 5816.76732930678, 5829.621074630136, 5858.5898987070495, 6253.781117660951, 6275.3724627537795, 6286.591371560834, 6297.811065668037, 6309.211348581427, 5631.859203519863, 5682.7442765075675, 5692.686902220335, 5794.420557944172, 5806.2451881255165, 5366.087765079946, 5391.245225668409, 5391.865203369947, 5445.83662490126, 5449.264349312872, 6306.274778400542, 6355.841103972252, 6356.904646430215, 6361.395667411589, 6365.490760739222, 6130.061839217998, 6134.681043575652, 6266.467350275278, 6275.3724627536885, 6277.372262773686, 5387.353517577916, 6269.435750782452, 6330.39861213184, 6333.113364129118, 6342.49260059185, 6205.03821907605, 6212.378762123752, 6221.5333849962335, 6232.657203853651, 6235.875282494416, 6131.0803379491645, 6151.8926593213655, 6317.557770955989, 6322.399372059647, 6331.556791024584, 6017.187679663364, 6102.298235702773, 6103.42017508336, 6110.6195130195665, 6143.047827586731, 6081.239845019372, 6096.146539484387, 6104.481119104926, 6117.265928088658, 6124.8162555121635, 5772.220750198838, 5902.498287645427, 5917.053271476543, 5923.022701254245, 5942.7920022799, 6074.0, 6109.083637454418, 6159.1377207190135, 6174.907376389448, 6176.166217560572, 5944.702764861826, 5949.196858424058, 5965.761369545169, 5985.700714964148, 6017.969910150421], "value": 5663.902343125963, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [430.44687576464247, 535.3281631552401, 546.1725485888877, 560.0059893688704, 563.1974436428089, 34432.48351274733, 39269.0, 41579.376309355386, 43404.0, 43472.565274347246, 42660.786696066476, 43088.0, 43129.784351078204, 43152.352714709305, 43268.701938941806, 8669.046404895473, 8681.175288347597, 9890.604375824958, 9899.851502227437, 9908.355956862817, 8662.220400163984, 11912.285262884212, 12132.454039568196, 12150.392480375946, 12347.629571112837, 12189.573364932228, 12261.019118470545, 12264.853650611107, 12274.693132671666, 12325.93837030818, 12156.51373945041, 12233.510659573607, 12254.080943929197, 12254.693632659166, 12260.570880019157, 11678.708032299175, 11796.587119450864, 11954.342511161884, 12020.939895300555, 12039.337836418994, 40509.189816203805, 40750.0, 40785.59214407847, 40885.0, 40903.7954810227, 3298.4062868683627, 3341.7159541439005, 3361.0, 3378.223008708011, 3473.548438702978, 24135.741674873843, 29691.85154074216, 30677.539836902466, 30840.0, 30947.916822911317, 3017.788754787166, 3170.5719727836677, 3250.7399408047536, 3322.5182348559565, 3334.0, 421168.0, 488735.1126488761, 495150.0, 499597.0, 646280.0, 56955.0, 57325.713371432874, 57515.699372024654, 57515.84968300694, 57716.84566308734, 58375.0, 58707.70646146742, 58803.0, 59132.40867591355, 59206.703966479894, 15226.314815833313, 15345.0025748326, 15350.846491534941, 15364.61588460275, 15375.077495350315, 9227.53862306882, 11597.6520704379, 12351.320677362832, 12416.192947458387, 12500.874991250153, 15304.311305991258, 15612.453564125428, 15629.765553516707, 15637.296321665324, 15853.68292634141, 6551.868962620721, 6591.373819487141, 6631.33686631333, 6678.799636010927, 6734.259231484532, 876.7632739160391, 914.5015966298383, 985.802250265916, 1042.1610603464285, 1053.6364954090827, 29050.7094929048, 29501.96743113981, 29699.693544435937, 29734.107976760733, 29870.85064574707, 986.4032260482448, 1017.7862648843677, 1034.4827586206898, 1071.0949247885524, 1113.17068783755, 14661.706765864836, 15157.317920693375, 15307.387704491695, 15468.5359439217, 15619.297131629104, 665953.0, 667482.0, 668494.0, 669135.0, 671462.0, 56573.43426565764, 56663.71668141633, 56691.86616267652, 56732.0, 56848.715756420956, 1218.9817152742717, 1318.960431187085, 1353.1339942436848, 1367.1591970938, 1369.342715496587, 24058.39854003664, 29005.83976640995, 31039.689603104584, 31157.90947316833, 31598.684013160495, 47851.0, 48344.0, 48451.75774121107, 48510.5148948506, 48714.051437943504, 519336.0, 522087.0, 522134.0, 522772.0, 523574.0, 25071.498570028863, 25899.0, 25938.0, 26530.60204096979, 26680.59979100276, 45899.0, 46512.53487465217, 47195.764021179675, 47265.0, 47706.761466192445, 34039.638414463145, 35245.82377088098, 37926.051848704, 37979.02440487529, 38416.84749457521, 38128.809355953046, 38291.42562861615, 38472.230555389295, 39198.804005979786, 39639.20721585494, 37046.25907481889, 37459.6254037467, 38075.61924380721, 38152.61847381491, 38175.427368588935, 26548.867255664372, 31189.220269493446, 33569.328613428086, 33940.0, 34063.48904766381, 22518.0, 24477.75522244826, 25038.62442063334, 25119.74880251174, 25507.23478295654], "value": 19960.21295510095, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [354.2295507271683, 371.5949614919738, 373.12874438186833, 382.1706896035602, 403.96364327210546, 14897.180655063981, 14969.251537423126, 20217.39347819564, 20502.0, 20593.485162870937, 18783.62432751344, 20195.091220895058, 20664.586708265826, 20666.0, 21062.473438164052, 5565.2486914266465, 5982.461578457927, 6218.8445288867915, 6265.780697675582, 6274.058891166316, 6070.57505974582, 6216.440520353167, 6232.781852635158, 6239.781607643733, 6247.687615619224, 5912.320083190423, 6059.242594675666, 6077.908831367533, 6078.270607527103, 6196.38036196379, 6030.216071910623, 6106.175666285061, 6117.724702388358, 6137.079438084301, 6137.447629713325, 5142.948570514284, 5243.2659427680155, 5299.178627312773, 5312.415634280226, 5316.867078323035, 26309.0, 26330.815113319946, 26383.868080659475, 26440.0, 26675.46649067027, 2251.6735073414425, 2332.498512819735, 2374.4894847607848, 2432.5134973005293, 2495.292607520842, 15190.848091519165, 15829.68340633181, 16071.785642871473, 16125.516234512867, 16718.24767885448, 1864.7482589850333, 1895.3745264062964, 1941.6602094633524, 1991.1040031985665, 2016.596680663873, 114357.0, 118388.0, 118429.22356164665, 119024.0, 119849.80150198474, 10021.448820314952, 10257.230707696803, 10997.0, 11430.314181149157, 11443.54225830974, 13906.791398129037, 13908.721825563433, 13917.095388799899, 13947.95390345728, 13952.790708139386, 8398.286145677564, 8724.214820666044, 8726.738197854074, 8854.911450885409, 8898.199162075443, 6224.603527641891, 8738.737837864874, 8745.256653184424, 8762.824743505094, 8931.464112153291, 6687.799366019027, 6744.8983103341325, 6776.15298087739, 6835.316468353125, 6911.6889739961825, 1519.566923426818, 1765.1968354398718, 1809.4571628511394, 1846.796852346241, 1849.6670599292256, 865.1953683074801, 876.2824863267939, 945.7210123013728, 983.306768728045, 1060.5280650110626, 14676.779848302283, 21635.13459461604, 21711.457213569473, 21853.67219491709, 21854.89072554627, 885.8095509465496, 914.0, 927.4481683398367, 958.1472489484364, 960.351762560269, 10059.582374005557, 10795.0, 11610.477528511237, 11836.76326473483, 11854.525818967317, 551491.0, 569870.1506492441, 578990.0, 581649.0, 588193.0, 92921.0, 95097.17992522662, 122075.0, 122302.38848805877, 124499.75500244882, 979.9167070799062, 987.1658448610768, 1006.2101250518308, 1043.1915265669015, 1043.8068957242933, 19528.168415579945, 20310.955333872706, 20486.468653463184, 20489.897550512153, 20499.590008199455, 52014.21978670399, 52100.0, 53126.734366327924, 53941.73029134829, 55373.446265536826, 83560.74658880243, 83829.0, 84694.57652711944, 85218.0, 86328.56835716033, 7119.857602848017, 7396.260373962561, 8000.719974800854, 8005.159458257032, 8336.208060234268, 7234.312740289664, 11121.332720036824, 11972.401379930794, 12344.197627154206, 13407.0, 9238.538073096453, 11109.722256943318, 11143.0, 11615.477303521193, 11772.646820595395, 10290.691279261635, 10941.179411544006, 11094.334339939629, 11171.106311495223, 11611.941940290244, 9042.954785226031, 10600.681979540626, 11402.657920262405, 11643.88356116428, 11863.881361186623, 7237.927620723725, 7241.746538871114, 7376.926230737624, 7380.040594722866, 7482.438817088631, 7835.921640783519, 10328.380297182193, 11221.326720396475, 11549.48027338755, 11578.594749183738], "value": 9692.359069903408, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1529.2124555853736, 1565.5929458340831, 1777.4223377402348, 1848.251458159446, 1910.799366066563, 8493.660253589856, 9053.004169541346, 9062.728118156458, 9065.410748301356, 9081.228095611872, 7856.017997750281, 8046.839063218732, 8575.699850505234, 8774.912250877489, 8858.379913406065, 2369.9763002369973, 2401.543706695722, 2404.5671779079757, 2406.109739396426, 2411.746766589509, 2367.5738367094004, 2392.5932591459405, 2412.2763171048705, 2412.6139817629182, 2412.8914198861094, 2364.267077206063, 2378.512404956988, 2390.4740956989435, 2409.024345140221, 2410.758924107593, 2380.143148466551, 2384.678068460753, 2414.2998530426066, 2417.456072383717, 2420.334408037786, 2369.0, 2381.7141942966955, 2383.1063351243283, 2388.176079252655, 2393.222202784102, 8833.425827321267, 8861.512616806072, 8936.910630893737, 8939.910600893973, 8940.821183576358, 5276.261323414725, 5451.3458384993655, 5454.53636440903, 5459.863503412406, 5467.863303417406, 3659.030356955409, 3666.3767159582935, 3729.533808273966, 3738.6448287412654, 3743.7192210584044, 1087.5323610847333, 1092.580511829651, 1098.8901109889027, 1114.648885601033, 1128.7573171768108, 11776.293422394683, 11874.762504749942, 11884.762304753856, 11892.345920974429, 11902.464389102424, 4675.9504649930395, 4716.221823399101, 4773.880652983703, 4847.909220425447, 4857.417109946829, 10056.29605927578, 10058.14505767018, 10065.144462720604, 10077.344972576759, 10077.899221007696, 5404.378496472956, 5413.756380962866, 5423.593230507728, 5424.728763561806, 5431.565474762009, 4270.145970805851, 4398.73607583546, 4552.294394368878, 4859.829905953346, 4976.576990955737, 3878.670313023368, 3914.393269043303, 3988.561258261589, 4021.9890054972516, 4061.329880569732, 1293.1852932652369, 1302.5310888080282, 1302.8241187439764, 1316.7037416581384, 1322.0, 837.899452065756, 856.5674334461057, 905.7056456651615, 907.7095329494498, 955.7897262602216, 5701.572382071361, 5746.511546518509, 5970.0, 6004.579679422399, 6116.449519543174, 944.7826999790087, 945.0691069296737, 954.9522523873778, 960.673371053845, 1004.633308842282, 3902.2502678890164, 3969.7221194516683, 4035.6569691575955, 4068.013346919976, 4086.366613174963, 9331.486768227813, 10839.945800270949, 10913.508892099875, 10922.126229901589, 10936.343819370863, 8854.77863053416, 10556.102731267774, 10572.207084468695, 10839.891601084046, 10854.240203185702, 7963.8805417918775, 8177.918220817715, 8181.345492360597, 8183.590820458953, 8192.385571082194, 5853.707314634336, 5859.414058594107, 5895.911561326498, 6039.396060393926, 6244.906326405198, 9644.75888102803, 10110.898891010997, 10186.388816670727, 10200.897991019994, 10322.535485903303, 9909.752256193364, 10037.347572408062, 10289.0, 10308.381497110197, 10424.374537527772, 6955.1653801544135, 7028.191757947901, 7524.510906791041, 7555.622218888923, 7686.692532298645, 8310.501369917823, 8475.533845638549, 8480.067192608685, 8484.575771211292, 8484.575771211537, 7379.262073792578, 7505.962470187614, 7525.510841795266, 7626.54240745557, 7631.847363052819, 7175.390091842043, 7281.963590182015, 7315.122185337794, 7340.082489688789, 7452.478326517308, 6824.863502730017, 6973.686184121828, 6975.895361569682, 6998.0, 7004.824879377852, 4705.153072446992, 4780.402449693788, 4952.975235123801, 5025.974870125626, 5030.3963524377305, 4934.136526107845, 4940.2342636891335, 5009.0983622948215, 5036.571891389273, 5215.973920130375], "value": 4639.491048180353, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [291.42879955287634, 300.8856634478898, 308.25863797566853, 311.3120004789415, 314.3681200786419, 4638.512956139607, 5004.398592450418, 5472.452754724525, 5489.451054894514, 5520.316303527423, 4418.2268103081915, 4570.657200709943, 5056.747162641863, 5086.567641750456, 5191.013707395602, 4126.628603425691, 4132.293347857159, 4136.565660605638, 4156.023334516386, 4157.085441202946, 3858.13192031792, 4074.653654439376, 4125.21620892031, 4141.7100802943805, 4145.150244199932, 3323.9169020774552, 3581.659742324475, 3681.558213014442, 3693.242885208526, 3781.697464202857, 4044.6966477514156, 4069.369247766601, 4094.303968325362, 4101.52832424272, 4110.362893751443, 3494.7728397654328, 3509.4911237870365, 3512.6487351264923, 3513.648635136466, 3520.2079532105327, 5030.144875371196, 5158.613104017176, 5228.738563071831, 5238.8690282742855, 5319.707416092114, 4608.331791890158, 4611.30830375443, 4648.209804333272, 4667.22990706533, 4675.228587283094, 4676.392069031004, 4806.879828004293, 5646.378898321182, 5689.975804355215, 5697.4587414196, 3458.1181798641187, 3672.669459748609, 3818.384406681432, 3825.1393436476847, 3843.961560384388, 5813.709314534256, 5836.824895253149, 5863.589548731633, 5904.321003084658, 5928.40715928408, 3692.8367564217187, 3772.830222639988, 3789.905252368713, 3802.923941521154, 3833.5783063862955, 3314.8011119332436, 3559.750817442754, 3779.603141670085, 3812.932378933903, 3819.579846216914, 3718.6612819385, 3761.7554858934627, 3934.5868683788362, 4311.663384350799, 4493.932591011137, 5074.8327884586015, 5293.258943747878, 5341.252224688546, 5603.935252302131, 5672.525143462647, 1045.8483519889573, 1129.0403157316216, 1216.6775804411661, 1242.1739543203848, 1318.5187406596715, 742.7103429662436, 767.623864306497, 809.29591255608, 820.953284562188, 825.2696363718153, 4102.5692302307825, 4116.773577453209, 4391.429114215195, 4442.888927776831, 4536.818527258939, 4320.4599425071865, 4468.4414448193975, 4873.415190177201, 4889.2910527973245, 4924.1875090610365, 3828.7319887608155, 4424.668149888771, 4438.889027774331, 4481.932771008437, 4971.726555039508, 2783.9860800696274, 2862.298736809495, 2863.8568071596337, 3070.738987186114, 3090.7218350348126, 4524.895923395637, 5395.757190926339, 5736.024875771129, 6054.697265136726, 6076.453119219292, 5137.383513978347, 5387.919181212285, 5655.688937108416, 5953.970230148821, 6019.398060193946, 5257.317658349291, 5406.513413792777, 5958.582899197015, 6039.607425517327, 6053.79036651619, 4448.844290449948, 5810.5061069809535, 5845.3277873045145, 5885.911711324248, 5892.819656727039, 4522.145920172713, 5750.424957504216, 5752.395998420106, 5765.596408251382, 5766.568891509545, 4812.639052071038, 5225.764840582259, 6004.159417681441, 6042.305134909541, 6109.083637454418, 3719.739618226806, 3855.614438556122, 3868.864589739346, 3884.514435695538, 3891.708121890813, 4295.656347492256, 4917.262410638433, 5760.740766665594, 5810.4189581041555, 5843.620164689281, 4779.976100119477, 5551.666899986014, 5713.342965559014, 5727.0, 5737.368889422244, 5298.523132918056, 5677.1768093627015, 5689.914651280152, 5709.800156994485, 5759.366469688414, 4635.814567417266, 5073.264376665436, 5563.383800529688, 5565.499105080562, 5607.271054762855, 4961.727105009115, 5214.739263036757, 5261.736913154404, 5280.155175171954, 5659.236003139524, 5033.370828646419, 5496.725163741877, 5645.237892884572, 5688.5733569981585, 5698.715064246854], "value": 3990.328800866794, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [718.7951433841356, 721.9061522002143, 782.7103971530531, 804.8591496488114, 866.1857853617597, 14743.410263589458, 15225.695486090272, 15869.0, 15870.206489675513, 16154.596135096599, 12143.75712485752, 14422.855771442282, 14755.18846463444, 14787.40850365984, 15060.24698765063, 693.3240090911371, 707.3775077931413, 850.7745447456414, 876.1807709791334, 879.5074758135464, 701.5019336271254, 703.7501686901153, 705.3334598804132, 847.6100993542947, 867.5271976772674, 912.2747415804452, 913.8126684029758, 914.9843673522385, 916.8808054952847, 919.0396036142214, 906.6101576322179, 906.7461110888962, 906.8277027364779, 907.3059109781022, 908.5139450394073, 538.1121150102323, 550.5540512185142, 554.2296208270507, 674.0697836984979, 675.2504719761062, 12527.498900043987, 14326.212058336787, 14868.479603213835, 14891.925540372336, 14936.701265974729, 14327.426902923871, 14622.0, 14702.0, 14917.254137293092, 15235.390584376612, 11820.645380638594, 11834.230774999598, 11892.940535297268, 11943.223690460092, 12162.391880405945, 3241.789283696552, 3716.6655001050035, 3817.6945844332386, 3828.885133446001, 3947.407888816672, 114887.0, 115989.0, 116429.0, 116666.41666791697, 126781.36609316987, 10923.508442120125, 10967.725806854893, 11030.779384412428, 11299.774004519864, 11438.428078596036, 23121.653175202384, 23326.53346933052, 23358.299251022156, 23420.531589368118, 23547.646785298235, 7970.402219833536, 7992.920811521582, 8037.437379383387, 8137.75586732399, 8254.463459875089, 4444.555544445594, 4543.0, 4550.499445061107, 4609.308156077763, 4614.123316569841, 3558.2349794793727, 3675.7610755301353, 3677.191017976041, 3677.3748462761396, 3678.70570354371, 589.9321578018582, 651.7588492257895, 657.7960832142052, 666.6966530228734, 668.1280928388403, 584.386394285998, 599.8650303681636, 604.803438882365, 648.1476857931899, 658.4765111736182, 8590.44585033142, 9196.862047069299, 9290.16388525036, 9453.810923781624, 9497.715068547956, 552.809280798124, 615.9106929495198, 653.857013359485, 665.7936039827669, 675.321302091395, 4482.327650852399, 4505.144022635689, 4520.849443816533, 4525.343825145335, 4597.804167600256, 162051.0, 165777.0, 166257.16871415565, 166522.0, 175972.0, 139731.30134349264, 143105.8534121989, 143754.0, 143813.0, 144884.7161397405, 29622.0, 29732.55401168984, 29738.0, 29754.702452975194, 94988.0, 8160.428769986044, 8186.467879587808, 8675.566221689016, 8820.962431070744, 8915.197632213132, 62934.0, 66286.33713662802, 67953.66023169852, 69183.3081669197, 70436.59126817537, 69175.65412172907, 100005.0, 102708.0, 104203.0, 106158.87682246466, 11347.716307092389, 11639.359835209145, 12897.484100636244, 12935.870641293466, 13435.596932092052, 14416.207108608707, 14722.116672999655, 14796.778048329068, 15023.474178403703, 15092.0, 13740.725185496434, 13747.587572372844, 14061.500319897534, 14645.9747817656, 14725.926370368079, 13617.319134043457, 13630.890739813853, 13757.449702011807, 13872.653183670489, 14466.855331446552, 11780.58767943152, 12731.93634031824, 13185.34073296312, 13723.931380343034, 14061.718765624426, 9680.661176858775, 10789.082927951213, 11260.605878794202, 11506.884931150582, 11783.76432471363, 10978.560857565928, 11289.943550282196, 11368.147388946027, 11560.30638161713, 11621.941890290494], "value": 7675.797036011231, "unit": "score"}], "name": "dromaeo_css", "value": 7334.885203728839, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 115.0, 116.0, 114.0, 112.0, 115.0, 113.0, 115.0, 115.0, 125.0], "value": 115.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 114.0, 132.0, 187.0, 138.0, 134.0, 128.0, 106.0, 156.0, 109.0], "value": 134.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [185.0, 186.0, 183.0, 183.0, 183.0, 184.0, 180.0, 181.0, 185.0, 182.0], "value": 183.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 76.0, 78.0, 152.0, 57.0, 57.0, 57.0, 65.0, 144.0, 56.0], "value": 81.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 84.0, 130.0, 70.0, 75.0, 91.0, 120.0, 70.0, 71.0, 119.0], "value": 91.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 84.0, 87.0, 85.0, 87.0, 84.0, 88.0, 84.0, 89.0, 84.0], "value": 86.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 97.0, 97.0, 97.0, 97.0, 101.0, 96.0, 96.0, 96.0, 95.0], "value": 96.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 84.0, 84.0, 87.0, 85.0, 83.0, 84.0, 84.0, 86.0, 84.0], "value": 84.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 57.0, 58.0, 56.0, 56.0, 57.0, 56.0, 54.0, 54.0, 52.0], "value": 55.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 65.0, 72.0, 68.0, 72.0, 78.0, 73.0, 70.0, 69.0, 71.0], "value": 70.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 87.0, 87.0, 88.0, 84.0, 85.0, 87.0, 84.0, 86.0, 86.0], "value": 85.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [136.0, 138.0, 135.0, 136.0, 139.0, 137.0, 134.0, 139.0, 182.0, 159.0], "value": 143.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 166.0, 165.0, 166.0, 164.0, 173.0, 237.0, 237.0, 168.0, 166.0], "value": 180.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 65.0, 67.0, 67.0, 66.0, 68.0, 67.0, 66.0, 65.0, 66.0], "value": 66.6, "unit": "score"}], "name": "kraken", "value": 1477.2, "alertThreshold": 2.0}]} 09:11:51 INFO - Return code: 0 09:11:51 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:11:51 INFO - # TBPL SUCCESS # 09:11:51 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 09:11:51 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 09:11:51 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 09:11:51 INFO - 2016-09-06 09:11:51.578 screenresolution[1676:10920] starting screenresolution argv=screenresolution get 09:11:51 INFO - 2016-09-06 09:11:51.581 screenresolution[1676:10920] Display 0: 1600x1200x32@60 09:11:51 INFO - 2016-09-06 09:11:51.587 screenresolution[1677:10923] starting screenresolution argv=screenresolution list 09:11:51 INFO - Available Modes on Display 0 09:11:51 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 09:11:51 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 09:11:51 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 09:11:51 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 09:11:51 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 09:11:51 INFO - Intel Iris: 09:11:51 INFO - Chipset Model: Intel Iris 09:11:51 INFO - Type: GPU 09:11:51 INFO - Bus: Built-In 09:11:51 INFO - VRAM (Dynamic, Max): 1536 MB 09:11:51 INFO - Vendor: Intel (0x8086) 09:11:51 INFO - Device ID: 0x0a2e 09:11:51 INFO - Revision ID: 0x0009 09:11:51 INFO - Displays: 09:11:51 INFO - Display: 09:11:51 INFO - Resolution: 1600 x 1200 @ 60 Hz 09:11:51 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 09:11:51 INFO - Display Serial Number: 1600x1200 60 09:11:51 INFO - Main Display: Yes 09:11:51 INFO - Mirror: Off 09:11:51 INFO - Online: Yes 09:11:51 INFO - Rotation: Supported 09:11:51 INFO - Return code: 0 09:11:51 INFO - Running post-action listener: _resource_record_post_action 09:11:51 INFO - [mozharness: 2016-09-06 16:11:51.823234Z] Finished run-tests step (success) 09:11:51 INFO - Running post-run listener: _resource_record_post_run 09:11:51 INFO - Total resource usage - Wall time: 1211s; CPU: 54.0%; Read bytes: 32816128; Write bytes: 705707520; Read time: 317; Write time: 2128 09:11:51 INFO - TinderboxPrint: CPU usage
53.6% 09:11:51 INFO - TinderboxPrint: I/O read bytes / time
32,816,128 / 317 09:11:51 INFO - TinderboxPrint: I/O write bytes / time
705,707,520 / 2,128 09:11:51 INFO - TinderboxPrint: CPU idle
2,249.7 (46.4%) 09:11:51 INFO - TinderboxPrint: CPU system
970.8 (20.0%) 09:11:51 INFO - TinderboxPrint: CPU user
1,625.1 (33.5%) 09:11:51 INFO - TinderboxPrint: Swap in / out
434,106,368 / 0 09:11:51 INFO - install - Wall time: 35s; CPU: 55.0%; Read bytes: 394136064; Write bytes: 389377536; Read time: 29542; Write time: 716 09:11:51 INFO - run-tests - Wall time: 1177s; CPU: 54.0%; Read bytes: 31046656; Write bytes: 295514112; Read time: 299; Write time: 1368 09:11:52 INFO - Running post-run listener: _upload_blobber_files 09:11:52 INFO - Blob upload gear active. 09:11:52 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:11:52 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 09:11:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 09:11:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 09:11:52 INFO - (blobuploader) - INFO - Open directory for files ... 09:11:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 09:11:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:11:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:11:53 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 09:11:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:11:53 INFO - (blobuploader) - INFO - Done attempting. 09:11:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 09:11:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:11:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:11:54 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 09:11:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:11:54 INFO - (blobuploader) - INFO - Done attempting. 09:11:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:11:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:11:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:11:57 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:11:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:11:57 INFO - (blobuploader) - INFO - Done attempting. 09:11:57 INFO - (blobuploader) - INFO - Iteration through files over. 09:11:57 INFO - Return code: 0 09:11:57 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:11:57 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:11:57 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d435e95cd60a00b2d221dcbfea2e7c9778b2f9abdfb9d07769536b7d5374a75dd3f967d618dcccab0bd38cdc19782348fe80c30248df5465f378f72af1a782b0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4abcc7de285f2c5fd3333cdd3aa01f1cef66dfe0fe5765a931933c24b706fd1f68b52cd8ae76fbd599f64835aad942c0d99279dd090858499af3b8cc89c9a758", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d6129c5db2f4acdfa729a0c2c2016ca959fa91a249d5c34936b131af8def2b631bc97e4bac608c4874495d1549487ceafd94c369ba4139c215145f95b4522e16"} 09:11:57 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:11:57 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:11:57 INFO - Contents: 09:11:57 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d435e95cd60a00b2d221dcbfea2e7c9778b2f9abdfb9d07769536b7d5374a75dd3f967d618dcccab0bd38cdc19782348fe80c30248df5465f378f72af1a782b0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4abcc7de285f2c5fd3333cdd3aa01f1cef66dfe0fe5765a931933c24b706fd1f68b52cd8ae76fbd599f64835aad942c0d99279dd090858499af3b8cc89c9a758", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d6129c5db2f4acdfa729a0c2c2016ca959fa91a249d5c34936b131af8def2b631bc97e4bac608c4874495d1549487ceafd94c369ba4139c215145f95b4522e16"} 09:11:57 INFO - Running post-run listener: copy_logs_to_upload_dir 09:11:57 INFO - Copying logs to upload dir... 09:11:57 INFO - mkdir: /builds/slave/test/build/upload/logs 09:11:57 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1272.628733 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 12 secs) (at 2016-09-06 09:11:57.504666) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-06 09:11:57.510586) ========= 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.VIFF5sX7rA/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.ZPY2AV9eJo/Listeners TMPDIR=/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d435e95cd60a00b2d221dcbfea2e7c9778b2f9abdfb9d07769536b7d5374a75dd3f967d618dcccab0bd38cdc19782348fe80c30248df5465f378f72af1a782b0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4abcc7de285f2c5fd3333cdd3aa01f1cef66dfe0fe5765a931933c24b706fd1f68b52cd8ae76fbd599f64835aad942c0d99279dd090858499af3b8cc89c9a758", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d6129c5db2f4acdfa729a0c2c2016ca959fa91a249d5c34936b131af8def2b631bc97e4bac608c4874495d1549487ceafd94c369ba4139c215145f95b4522e16"} build_url:https://queue.taskcluster.net/v1/task/EfMONJ7AT4OuX_IOgVe4rA/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011404 build_url: 'https://queue.taskcluster.net/v1/task/EfMONJ7AT4OuX_IOgVe4rA/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d435e95cd60a00b2d221dcbfea2e7c9778b2f9abdfb9d07769536b7d5374a75dd3f967d618dcccab0bd38cdc19782348fe80c30248df5465f378f72af1a782b0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4abcc7de285f2c5fd3333cdd3aa01f1cef66dfe0fe5765a931933c24b706fd1f68b52cd8ae76fbd599f64835aad942c0d99279dd090858499af3b8cc89c9a758", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d6129c5db2f4acdfa729a0c2c2016ca959fa91a249d5c34936b131af8def2b631bc97e4bac608c4874495d1549487ceafd94c369ba4139c215145f95b4522e16"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-06 09:11:57.544033) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-06 09:11:57.544336) ========= 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.VIFF5sX7rA/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.ZPY2AV9eJo/Listeners TMPDIR=/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/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.005123 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-06 09:11:57.592016) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-06 09:11:57.592327) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-06 09:11:57.592635) ========= ========= Total master_lag: 0.20 =========