builder: pine_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0101 starttime: 1491336870.34 results: success (0) buildid: 20170404090329 builduid: f31276557b67450ca8aa06528d2763c1 revision: 29799ff6c8a5578fb2939f66815668b18cb15e3b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-04-04 13:14:30.344988) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-04-04 13:14:30.345417) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-04 13:14:30.345691) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-04 13:14:30.372256) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-04 13:14:30.372620) ========= 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.4gTHEGQ8w3/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.UgNS6Uc6gj/Listeners TMPDIR=/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/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 --2017-04-04 13:14:30-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 15.1M=0.001s 2017-04-04 13:14:30 (15.1 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.114816 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-04 13:14:30.511455) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-04 13:14:30.511779) ========= 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.4gTHEGQ8w3/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.UgNS6Uc6gj/Listeners TMPDIR=/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/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.027458 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-04 13:14:30.560930) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-04 13:14:30.561267) ========= bash -c 'python archiver_client.py mozharness --repo projects/pine --rev 29799ff6c8a5578fb2939f66815668b18cb15e3b --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo projects/pine --rev 29799ff6c8a5578fb2939f66815668b18cb15e3b --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.4gTHEGQ8w3/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.UgNS6Uc6gj/Listeners TMPDIR=/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/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 2017-04-04 13:14:30,651 truncating revision to first 12 chars 2017-04-04 13:14:30,651 Setting DEBUG logging. 2017-04-04 13:14:30,651 attempt 1/10 2017-04-04 13:14:30,652 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/projects/pine/29799ff6c8a5?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-04-04 13:14:31,129 unpacking tar archive at: pine-29799ff6c8a5/testing/mozharness/ program finished with exit code 0 elapsedTime=0.758047 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-04 13:14:31.342559) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-04 13:14:31.342894) ========= script_repo_revision: 29799ff6c8a5578fb2939f66815668b18cb15e3b ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-04 13:14:31.343324) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-04 13:14:31.343607) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-04 13:14:31.363229) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 23 secs) (at 2017-04-04 13:14:31.363563) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Pine --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Pine in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Pine', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Pine'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.4gTHEGQ8w3/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.UgNS6Uc6gj/Listeners TMPDIR=/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 13:14:31 INFO - MultiFileLogger online at 20170404 13:14:31 in /builds/slave/test 13:14:31 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Pine --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Pine 13:14:31 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 13:14:31 INFO - {'append_to_log': False, 13:14:31 INFO - 'base_work_dir': '/builds/slave/test', 13:14:31 INFO - 'blob_upload_branch': 'Pine', 13:14:31 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 13:14:31 INFO - 'branch': 'Pine', 13:14:31 INFO - 'buildbot_json_path': 'buildprops.json', 13:14:31 INFO - 'config_files': ('talos/mac_config.py',), 13:14:31 INFO - 'default_actions': ('clobber', 13:14:31 INFO - 'read-buildbot-config', 13:14:31 INFO - 'download-and-extract', 13:14:31 INFO - 'populate-webroot', 13:14:31 INFO - 'create-virtualenv', 13:14:31 INFO - 'install', 13:14:31 INFO - 'run-tests'), 13:14:31 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 13:14:31 INFO - 'download_minidump_stackwalk': True, 13:14:31 INFO - 'download_symbols': 'ondemand', 13:14:31 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 13:14:31 INFO - 'tooltool.py': '/tools/tooltool.py', 13:14:31 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 13:14:31 INFO - '/tools/misc-python/virtualenv.py')}, 13:14:31 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 13:14:31 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 13:14:31 INFO - 'gecko_profile': False, 13:14:31 INFO - 'gecko_profile_interval': 0, 13:14:31 INFO - 'installer_path': 'installer.exe', 13:14:31 INFO - 'log_level': 'info', 13:14:31 INFO - 'log_name': 'talos', 13:14:31 INFO - 'log_to_console': True, 13:14:31 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 13:14:31 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 13:14:31 INFO - 'opt_config_files': (), 13:14:31 INFO - 'pip_index': False, 13:14:31 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 13:14:31 INFO - 'cmd': ('bash', 13:14:31 INFO - '-c', 13:14:31 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 13:14:31 INFO - 'enabled': True, 13:14:31 INFO - 'halt_on_failure': False, 13:14:31 INFO - 'name': 'check_screen_resolution'},), 13:14:31 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 13:14:31 INFO - 'cmd': ('bash', 13:14:31 INFO - '-c', 13:14:31 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 13:14:31 INFO - 'enabled': True, 13:14:31 INFO - 'halt_on_failure': False, 13:14:31 INFO - 'name': 'check_screen_resolution'},), 13:14:31 INFO - 'run_cmd_checks_enabled': True, 13:14:31 INFO - 'suite': 'dromaeojs-e10s', 13:14:31 INFO - 'system_bits': '32', 13:14:31 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 13:14:31 INFO - 'title': 't-yosemite-r7-0101', 13:14:31 INFO - 'tooltool_cache': '/builds/tooltool_cache', 13:14:31 INFO - 'use_talos_json': True, 13:14:31 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 13:14:31 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 13:14:31 INFO - 'work_dir': 'build'} 13:14:31 INFO - [mozharness: 2017-04-04 20:14:31.560568Z] Running clobber step. 13:14:31 INFO - Running pre-action listener: _resource_record_pre_action 13:14:31 INFO - Running main action method: clobber 13:14:31 INFO - rmtree: /builds/slave/test/build 13:14:31 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 13:14:34 INFO - Running post-action listener: _resource_record_post_action 13:14:34 INFO - [mozharness: 2017-04-04 20:14:34.093596Z] Finished clobber step (success) 13:14:34 INFO - [mozharness: 2017-04-04 20:14:34.093676Z] Running read-buildbot-config step. 13:14:34 INFO - Running pre-action listener: _resource_record_pre_action 13:14:34 INFO - Running main action method: read_buildbot_config 13:14:34 INFO - Using buildbot properties: 13:14:34 INFO - { 13:14:34 INFO - "project": "", 13:14:34 INFO - "product": "firefox", 13:14:34 INFO - "script_repo_revision": "default", 13:14:34 INFO - "builddir": "pine_yosemite_r7_test-dromaeojs-e10s", 13:14:34 INFO - "repository": "", 13:14:34 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 pine talos dromaeojs-e10s", 13:14:34 INFO - "buildid": "20170404090329", 13:14:34 INFO - "pgo_build": "False", 13:14:34 INFO - "basedir": "/builds/slave/test", 13:14:34 INFO - "buildnumber": 2, 13:14:34 INFO - "slavename": "t-yosemite-r7-0101", 13:14:34 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 13:14:34 INFO - "platform": "yosemite_r7", 13:14:34 INFO - "scheduler": "tests-pine-macosx64-talos", 13:14:34 INFO - "branch": "pine", 13:14:34 INFO - "repo_path": "projects/pine", 13:14:34 INFO - "revision": "29799ff6c8a5578fb2939f66815668b18cb15e3b", 13:14:34 INFO - "stage_platform": "macosx64", 13:14:34 INFO - "builduid": "f31276557b67450ca8aa06528d2763c1", 13:14:34 INFO - "slavebuilddir": "test" 13:14:34 INFO - } 13:14:34 INFO - Found installer url https://queue.taskcluster.net/v1/task/d4iKk8LgRCqYM8jbxQZwcQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg. 13:14:34 INFO - Running post-action listener: _resource_record_post_action 13:14:34 INFO - [mozharness: 2017-04-04 20:14:34.096838Z] Finished read-buildbot-config step (success) 13:14:34 INFO - [mozharness: 2017-04-04 20:14:34.096983Z] Running download-and-extract step. 13:14:34 INFO - Running pre-action listener: _resource_record_pre_action 13:14:34 INFO - Running main action method: download_and_extract 13:14:34 INFO - mkdir: /builds/slave/test/build/tests 13:14:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:14:34 INFO - trying https://queue.taskcluster.net/v1/task/d4iKk8LgRCqYM8jbxQZwcQ/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json 13:14:34 INFO - Downloading https://queue.taskcluster.net/v1/task/d4iKk8LgRCqYM8jbxQZwcQ/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 13:14:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/d4iKk8LgRCqYM8jbxQZwcQ/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json'}, attempt #1 13:14:34 INFO - Downloaded 1325 bytes. 13:14:34 INFO - Reading from file /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 13:14:34 INFO - Using the following test package requirements: 13:14:34 INFO - {u'awsy': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 13:14:34 INFO - u'firefox-55.0a1.en-US.mac.awsy.tests.zip'], 13:14:34 INFO - u'common': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 13:14:34 INFO - u'cppunittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 13:14:34 INFO - u'firefox-55.0a1.en-US.mac.cppunittest.tests.zip'], 13:14:34 INFO - u'gtest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 13:14:34 INFO - u'firefox-55.0a1.en-US.mac.gtest.tests.zip'], 13:14:34 INFO - u'jittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 13:14:34 INFO - u'jsshell-mac.zip'], 13:14:34 INFO - u'mochitest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 13:14:34 INFO - u'firefox-55.0a1.en-US.mac.mochitest.tests.zip'], 13:14:34 INFO - u'mozbase': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 13:14:34 INFO - u'reftest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 13:14:34 INFO - u'firefox-55.0a1.en-US.mac.reftest.tests.zip'], 13:14:34 INFO - u'talos': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 13:14:34 INFO - u'firefox-55.0a1.en-US.mac.talos.tests.zip'], 13:14:34 INFO - u'web-platform': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 13:14:34 INFO - u'firefox-55.0a1.en-US.mac.web-platform.tests.zip'], 13:14:34 INFO - u'xpcshell': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 13:14:34 INFO - u'firefox-55.0a1.en-US.mac.xpcshell.tests.zip']} 13:14:34 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip'] for test suite category: common 13:14:34 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/d4iKk8LgRCqYM8jbxQZwcQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 13:14:34 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/d4iKk8LgRCqYM8jbxQZwcQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 13:14:34 INFO - Fetch https://queue.taskcluster.net/v1/task/d4iKk8LgRCqYM8jbxQZwcQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 13:14:36 INFO - Expected file size: 52520435 13:14:36 INFO - Obtained file size: 52520435 13:14:52 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip', u'firefox-55.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 13:14:52 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/d4iKk8LgRCqYM8jbxQZwcQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 13:14:52 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/d4iKk8LgRCqYM8jbxQZwcQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 13:14:52 INFO - Fetch https://queue.taskcluster.net/v1/task/d4iKk8LgRCqYM8jbxQZwcQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 13:14:54 INFO - Expected file size: 52520435 13:14:54 INFO - Obtained file size: 52520435 13:15:09 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/d4iKk8LgRCqYM8jbxQZwcQ/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip 13:15:09 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/d4iKk8LgRCqYM8jbxQZwcQ/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip'}, attempt #1 13:15:09 INFO - Fetch https://queue.taskcluster.net/v1/task/d4iKk8LgRCqYM8jbxQZwcQ/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip into memory 13:15:10 INFO - Expected file size: 14404152 13:15:10 INFO - Obtained file size: 14404152 13:15:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:15:11 INFO - trying https://queue.taskcluster.net/v1/task/d4iKk8LgRCqYM8jbxQZwcQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 13:15:11 INFO - Downloading https://queue.taskcluster.net/v1/task/d4iKk8LgRCqYM8jbxQZwcQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg 13:15:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/d4iKk8LgRCqYM8jbxQZwcQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg'}, attempt #1 13:15:13 INFO - Downloaded 75665554 bytes. 13:15:13 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/d4iKk8LgRCqYM8jbxQZwcQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 13:15:13 INFO - mkdir: /builds/slave/test/properties 13:15:13 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 13:15:13 INFO - Writing to file /builds/slave/test/properties/build_url 13:15:13 INFO - Contents: 13:15:13 INFO - build_url:https://queue.taskcluster.net/v1/task/d4iKk8LgRCqYM8jbxQZwcQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 13:15:13 INFO - Running post-action listener: _resource_record_post_action 13:15:13 INFO - Running post-action listener: set_extra_try_arguments 13:15:13 INFO - [mozharness: 2017-04-04 20:15:13.959964Z] Finished download-and-extract step (success) 13:15:13 INFO - [mozharness: 2017-04-04 20:15:13.960118Z] Running populate-webroot step. 13:15:13 INFO - Running pre-action listener: _resource_record_pre_action 13:15:13 INFO - Running main action method: populate_webroot 13:15:13 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 13:15:13 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 13:15:13 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 13:15:13 INFO - '--tppagecycles', 13:15:13 INFO - '7'], 13:15:13 INFO - 'tests': ['tsvgm']}}, 13:15:13 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 13:15:13 INFO - 'tests': ['tresize', 'tcanvasmark']}, 13:15:13 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 13:15:13 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 13:15:13 INFO - 'tests': ['dromaeo_css', 'kraken']}, 13:15:13 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 13:15:13 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 13:15:13 INFO - 'talos_options': ['--disable-e10s'], 13:15:13 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:15:13 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 13:15:13 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:15:13 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 13:15:13 INFO - 'talos_options': ['--disable-e10s'], 13:15:13 INFO - 'tests': ['damp', 'tps']}, 13:15:13 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 13:15:13 INFO - 'tests': ['damp', 'tps']}, 13:15:13 INFO - 'g3': {'talos_options': ['--disable-e10s'], 13:15:13 INFO - 'tests': ['dromaeo_dom']}, 13:15:13 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 13:15:13 INFO - 'g4': {'talos_options': ['--disable-e10s'], 13:15:13 INFO - 'tests': ['basic_compositor_video']}, 13:15:13 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 13:15:13 INFO - 'other': {'talos_options': ['--disable-e10s'], 13:15:13 INFO - 'tests': ['a11yr', 13:15:13 INFO - 'ts_paint', 13:15:13 INFO - 'tpaint', 13:15:13 INFO - 'sessionrestore', 13:15:13 INFO - 'sessionrestore_no_auto_restore', 13:15:13 INFO - 'tabpaint']}, 13:15:13 INFO - 'other-e10s': {'tests': ['a11yr', 13:15:13 INFO - 'ts_paint', 13:15:13 INFO - 'tpaint', 13:15:13 INFO - 'sessionrestore', 13:15:13 INFO - 'sessionrestore_no_auto_restore', 13:15:13 INFO - 'tabpaint']}, 13:15:13 INFO - 'other-e10s_l64': {'tests': ['a11yr', 13:15:13 INFO - 'ts_paint', 13:15:13 INFO - 'tpaint', 13:15:13 INFO - 'sessionrestore', 13:15:13 INFO - 'sessionrestore_no_auto_restore', 13:15:13 INFO - 'tabpaint']}, 13:15:13 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 13:15:13 INFO - 'ts_paint', 13:15:13 INFO - 'tpaint', 13:15:13 INFO - 'sessionrestore', 13:15:13 INFO - 'sessionrestore_no_auto_restore', 13:15:13 INFO - 'tabpaint']}, 13:15:13 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 13:15:13 INFO - 'tests': ['a11yr', 13:15:13 INFO - 'ts_paint', 13:15:13 INFO - 'tpaint', 13:15:13 INFO - 'sessionrestore', 13:15:13 INFO - 'sessionrestore_no_auto_restore', 13:15:13 INFO - 'tabpaint']}, 13:15:13 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 13:15:13 INFO - 'tests': ['a11yr', 13:15:13 INFO - 'ts_paint', 13:15:13 INFO - 'tpaint', 13:15:13 INFO - 'sessionrestore', 13:15:13 INFO - 'sessionrestore_no_auto_restore', 13:15:13 INFO - 'tabpaint']}, 13:15:13 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 13:15:13 INFO - 'tests': ['tsvgx', 13:15:13 INFO - 'tsvgr_opacity', 13:15:13 INFO - 'tart', 13:15:13 INFO - 'tscrollx', 13:15:13 INFO - 'cart', 13:15:13 INFO - 'tsvg_static']}, 13:15:13 INFO - 'svgr-e10s': {'tests': ['tsvgx', 13:15:13 INFO - 'tsvgr_opacity', 13:15:13 INFO - 'tart', 13:15:13 INFO - 'tscrollx', 13:15:13 INFO - 'cart', 13:15:13 INFO - 'tsvg_static']}, 13:15:13 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 13:15:13 INFO - 'talos_options': ['--disable-e10s'], 13:15:13 INFO - 'tests': ['tp5o']}, 13:15:13 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 13:15:13 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 13:15:13 INFO - 'talos_options': ['--disable-e10s', 13:15:13 INFO - '--xperf_path', 13:15:13 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:15:13 INFO - 'tests': ['tp5n']}, 13:15:13 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 13:15:13 INFO - 'talos_options': ['--xperf_path', 13:15:13 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:15:13 INFO - 'tests': ['tp5n']}}, 13:15:13 INFO - 'talos.zip': {'path': '', 13:15:13 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 13:15:13 INFO - Running post-action listener: _resource_record_post_action 13:15:13 INFO - [mozharness: 2017-04-04 20:15:13.977903Z] Finished populate-webroot step (success) 13:15:13 INFO - [mozharness: 2017-04-04 20:15:13.978027Z] Running create-virtualenv step. 13:15:13 INFO - Running pre-action listener: _resource_record_pre_action 13:15:13 INFO - Running main action method: create_virtualenv 13:15:13 INFO - Creating virtualenv /builds/slave/test/build/venv 13:15:13 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 13:15:13 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 13:15:14 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 13:15:14 INFO - Using real prefix '/tools/python27' 13:15:14 INFO - New python executable in /builds/slave/test/build/venv/bin/python 13:15:14 INFO - Installing distribute.............................................................................................................................................................................................done. 13:15:17 INFO - Installing pip.................done. 13:15:17 INFO - Return code: 0 13:15:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 13:15:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 13:15:17 INFO - Reading from file tmpfile_stdout 13:15:17 INFO - Output received: 13:15:17 INFO - pip 1.5.5 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 13:15:17 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 13:15: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')]} 13:15:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:15:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:15: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')]} 13:15:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:15:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:15: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1074b5b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1074b8768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fddaa560f40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107293d30>, '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 0x1071badb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107288be8>, '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.4gTHEGQ8w3/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.UgNS6Uc6gj/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 13:15: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', 'pip>=1.5'] in /builds/slave/test/build 13:15: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 pip>=1.5 13:15:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4gTHEGQ8w3/Render', 13:15:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:15:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:15:17 INFO - 'HOME': '/Users/cltbld', 13:15:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:15:17 INFO - 'LOGNAME': 'cltbld', 13:15:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:15:17 INFO - 'MOZ_NO_REMOTE': '1', 13:15:17 INFO - 'NO_EM_RESTART': '1', 13:15:17 INFO - 'PAGER': '/bin/cat', 13:15:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:15:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:15:17 INFO - 'PWD': '/builds/slave/test', 13:15:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:15:17 INFO - 'SHELL': '/bin/bash', 13:15:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UgNS6Uc6gj/Listeners', 13:15:17 INFO - 'TMPDIR': '/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/', 13:15:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:15:17 INFO - 'USER': 'cltbld', 13:15:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:15:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:15:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:15:17 INFO - 'XPC_FLAGS': '0x0', 13:15:17 INFO - 'XPC_SERVICE_NAME': '0', 13:15:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:15:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:15:18 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 13:15:18 INFO - Cleaning up... 13:15:18 INFO - Return code: 0 13:15:18 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 13:15:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:15:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:15:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:15:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:15:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:15:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:15:18 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1074b5b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1074b8768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fddaa560f40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107293d30>, '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 0x1071badb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107288be8>, '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.4gTHEGQ8w3/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.UgNS6Uc6gj/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 13:15:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 13:15:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 13:15:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4gTHEGQ8w3/Render', 13:15:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:15:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:15:18 INFO - 'HOME': '/Users/cltbld', 13:15:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:15:18 INFO - 'LOGNAME': 'cltbld', 13:15:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:15:18 INFO - 'MOZ_NO_REMOTE': '1', 13:15:18 INFO - 'NO_EM_RESTART': '1', 13:15:18 INFO - 'PAGER': '/bin/cat', 13:15:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:15:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:15:18 INFO - 'PWD': '/builds/slave/test', 13:15:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:15:18 INFO - 'SHELL': '/bin/bash', 13:15:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UgNS6Uc6gj/Listeners', 13:15:18 INFO - 'TMPDIR': '/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/', 13:15:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:15:18 INFO - 'USER': 'cltbld', 13:15:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:15:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:15:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:15:18 INFO - 'XPC_FLAGS': '0x0', 13:15:18 INFO - 'XPC_SERVICE_NAME': '0', 13:15:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:15:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:15:18 INFO - Downloading/unpacking psutil>=3.1.1 13:15:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:15:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:15:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:15:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:15:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:15:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:15:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 13:15:21 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:15:21 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:15:21 INFO - Installing collected packages: psutil 13:15:21 INFO - Running setup.py install for psutil 13:15:22 INFO - building 'psutil._psutil_osx' extension 13:15:22 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 13:15:22 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 13:15:22 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 13:15:22 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 13:15:22 INFO - building 'psutil._psutil_posix' extension 13:15:22 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 13:15:22 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 13:15:22 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 13:15:22 INFO - ^ 13:15:23 INFO - 1 warning generated. 13:15:23 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 13:15:23 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:15:23 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:15:23 INFO - Successfully installed psutil 13:15:23 INFO - Cleaning up... 13:15:23 INFO - Return code: 0 13:15:23 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 13:15:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:15:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:15:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:15:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:15:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:15:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:15:23 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 0x1074b5b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1074b8768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fddaa560f40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107293d30>, '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 0x1071badb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107288be8>, '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.4gTHEGQ8w3/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.UgNS6Uc6gj/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 13:15:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 13:15:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 13:15:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4gTHEGQ8w3/Render', 13:15:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:15:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:15:23 INFO - 'HOME': '/Users/cltbld', 13:15:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:15:23 INFO - 'LOGNAME': 'cltbld', 13:15:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:15:23 INFO - 'MOZ_NO_REMOTE': '1', 13:15:23 INFO - 'NO_EM_RESTART': '1', 13:15:23 INFO - 'PAGER': '/bin/cat', 13:15:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:15:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:15:23 INFO - 'PWD': '/builds/slave/test', 13:15:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:15:23 INFO - 'SHELL': '/bin/bash', 13:15:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UgNS6Uc6gj/Listeners', 13:15:23 INFO - 'TMPDIR': '/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/', 13:15:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:15:23 INFO - 'USER': 'cltbld', 13:15:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:15:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:15:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:15:23 INFO - 'XPC_FLAGS': '0x0', 13:15:23 INFO - 'XPC_SERVICE_NAME': '0', 13:15:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:15:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:15:23 INFO - Downloading/unpacking mozsystemmonitor==0.3 13:15: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 13:15: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 13:15: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 13:15: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 13:15: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 13:15: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 13:15:26 INFO - Downloading mozsystemmonitor-0.3.tar.gz 13:15:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 13:15:26 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 13:15:26 INFO - Installing collected packages: mozsystemmonitor 13:15:26 INFO - Running setup.py install for mozsystemmonitor 13:15:26 INFO - Successfully installed mozsystemmonitor 13:15:26 INFO - Cleaning up... 13:15:26 INFO - Return code: 0 13:15:26 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 13:15:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:15:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:15:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:15:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:15:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:15:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:15:27 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 0x1074b5b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1074b8768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fddaa560f40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107293d30>, '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 0x1071badb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107288be8>, '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.4gTHEGQ8w3/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.UgNS6Uc6gj/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 13:15:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 13:15:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 13:15:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4gTHEGQ8w3/Render', 13:15:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:15:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:15:27 INFO - 'HOME': '/Users/cltbld', 13:15:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:15:27 INFO - 'LOGNAME': 'cltbld', 13:15:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:15:27 INFO - 'MOZ_NO_REMOTE': '1', 13:15:27 INFO - 'NO_EM_RESTART': '1', 13:15:27 INFO - 'PAGER': '/bin/cat', 13:15:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:15:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:15:27 INFO - 'PWD': '/builds/slave/test', 13:15:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:15:27 INFO - 'SHELL': '/bin/bash', 13:15:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UgNS6Uc6gj/Listeners', 13:15:27 INFO - 'TMPDIR': '/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/', 13:15:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:15:27 INFO - 'USER': 'cltbld', 13:15:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:15:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:15:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:15:27 INFO - 'XPC_FLAGS': '0x0', 13:15:27 INFO - 'XPC_SERVICE_NAME': '0', 13:15:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:15:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:15:27 INFO - Downloading/unpacking jsonschema==2.5.1 13:15: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 13:15: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 13:15: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 13:15: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 13:15: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 13:15: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 13:15:30 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 13:15:30 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 13:15:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:15:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:15:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:15:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:15:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:15:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:15:30 INFO - Downloading functools32-3.2.3-2.tar.gz 13:15:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 13:15:30 INFO - warning: no files found matching '*.txt' 13:15:30 INFO - no previously-included directories found matching 'build' 13:15:30 INFO - no previously-included directories found matching 'dist' 13:15:30 INFO - no previously-included directories found matching '.git*' 13:15:30 INFO - Installing collected packages: jsonschema, functools32 13:15:30 INFO - Running setup.py install for functools32 13:15:31 INFO - warning: no files found matching '*.txt' 13:15:31 INFO - no previously-included directories found matching 'build' 13:15:31 INFO - no previously-included directories found matching 'dist' 13:15:31 INFO - no previously-included directories found matching '.git*' 13:15:31 INFO - Successfully installed jsonschema functools32 13:15:31 INFO - Cleaning up... 13:15:31 INFO - Return code: 0 13:15:31 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 13:15:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:15:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:15:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:15:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:15:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:15:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:15:31 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1074b5b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1074b8768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fddaa560f40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107293d30>, '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 0x1071badb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107288be8>, '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.4gTHEGQ8w3/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.UgNS6Uc6gj/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 13:15:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 13:15:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 13:15:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4gTHEGQ8w3/Render', 13:15:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:15:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:15:31 INFO - 'HOME': '/Users/cltbld', 13:15:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:15:31 INFO - 'LOGNAME': 'cltbld', 13:15:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:15:31 INFO - 'MOZ_NO_REMOTE': '1', 13:15:31 INFO - 'NO_EM_RESTART': '1', 13:15:31 INFO - 'PAGER': '/bin/cat', 13:15:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:15:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:15:31 INFO - 'PWD': '/builds/slave/test', 13:15:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:15:31 INFO - 'SHELL': '/bin/bash', 13:15:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UgNS6Uc6gj/Listeners', 13:15:31 INFO - 'TMPDIR': '/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/', 13:15:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:15:31 INFO - 'USER': 'cltbld', 13:15:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:15:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:15:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:15:31 INFO - 'XPC_FLAGS': '0x0', 13:15:31 INFO - 'XPC_SERVICE_NAME': '0', 13:15:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:15:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:15:31 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 13:15:31 INFO - Cleaning up... 13:15:31 INFO - Return code: 0 13:15:31 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 13:15:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:15:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:15:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:15:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:15:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:15:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:15:31 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1074b5b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1074b8768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fddaa560f40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107293d30>, '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 0x1071badb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107288be8>, '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.4gTHEGQ8w3/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.UgNS6Uc6gj/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 13:15:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 13:15:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 13:15:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4gTHEGQ8w3/Render', 13:15:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:15:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:15:31 INFO - 'HOME': '/Users/cltbld', 13:15:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:15:31 INFO - 'LOGNAME': 'cltbld', 13:15:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:15:31 INFO - 'MOZ_NO_REMOTE': '1', 13:15:31 INFO - 'NO_EM_RESTART': '1', 13:15:31 INFO - 'PAGER': '/bin/cat', 13:15:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:15:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:15:31 INFO - 'PWD': '/builds/slave/test', 13:15:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:15:31 INFO - 'SHELL': '/bin/bash', 13:15:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UgNS6Uc6gj/Listeners', 13:15:31 INFO - 'TMPDIR': '/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/', 13:15:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:15:31 INFO - 'USER': 'cltbld', 13:15:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:15:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:15:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:15:31 INFO - 'XPC_FLAGS': '0x0', 13:15:31 INFO - 'XPC_SERVICE_NAME': '0', 13:15:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:15:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:15:31 INFO - Downloading/unpacking blobuploader==1.2.4 13:15:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:15:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:15:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:15:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:15:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:15:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:15:34 INFO - Downloading blobuploader-1.2.4.tar.gz 13:15:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 13:15:34 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 13:15:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:15:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:15:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:15:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:15:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:15:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:15:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 13:15:35 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 13:15:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:15:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:15:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:15:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:15:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:15:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:15:35 INFO - Downloading docopt-0.6.1.tar.gz 13:15:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 13:15:35 INFO - Installing collected packages: blobuploader, requests, docopt 13:15:35 INFO - Running setup.py install for blobuploader 13:15:36 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 13:15:36 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 13:15:36 INFO - Running setup.py install for requests 13:15:36 INFO - Running setup.py install for docopt 13:15:36 INFO - Successfully installed blobuploader requests docopt 13:15:36 INFO - Cleaning up... 13:15:36 INFO - Return code: 0 13:15:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:15:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:15:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:15:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:15:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:15:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:15:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:15:36 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 0x1074b5b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1074b8768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fddaa560f40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107293d30>, '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 0x1071badb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107288be8>, '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.4gTHEGQ8w3/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.UgNS6Uc6gj/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 13:15:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 13:15:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 13:15:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4gTHEGQ8w3/Render', 13:15:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:15:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:15:36 INFO - 'HOME': '/Users/cltbld', 13:15:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:15:36 INFO - 'LOGNAME': 'cltbld', 13:15:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:15:36 INFO - 'MOZ_NO_REMOTE': '1', 13:15:36 INFO - 'NO_EM_RESTART': '1', 13:15:36 INFO - 'PAGER': '/bin/cat', 13:15:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:15:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:15:36 INFO - 'PWD': '/builds/slave/test', 13:15:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:15:36 INFO - 'SHELL': '/bin/bash', 13:15:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UgNS6Uc6gj/Listeners', 13:15:36 INFO - 'TMPDIR': '/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/', 13:15:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:15:36 INFO - 'USER': 'cltbld', 13:15:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:15:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:15:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:15:36 INFO - 'XPC_FLAGS': '0x0', 13:15:36 INFO - 'XPC_SERVICE_NAME': '0', 13:15:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:15:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:15:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:15:37 INFO - Running setup.py (path:/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/pip-YTMAQp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:15:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:15:37 INFO - Running setup.py (path:/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/pip-6PryYo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:15:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:15:37 INFO - Running setup.py (path:/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/pip-ntFLu2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:15:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:15:37 INFO - Running setup.py (path:/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/pip-BL2gwq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:15:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:15:37 INFO - Running setup.py (path:/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/pip-qGvDTH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:15:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:15:37 INFO - Running setup.py (path:/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/pip-TYCD65-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:15:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:15:37 INFO - Running setup.py (path:/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/pip-eCUJg_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:15:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:15:37 INFO - Running setup.py (path:/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/pip-fVYcbi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:15:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:15:37 INFO - Running setup.py (path:/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/pip-cdtn1M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:15:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:15:37 INFO - Running setup.py (path:/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/pip-jS2sYV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:15:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:15:38 INFO - Running setup.py (path:/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/pip-KNfO3H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:15:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:15:38 INFO - Running setup.py (path:/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/pip-8O2auy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:15:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:15:38 INFO - Running setup.py (path:/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/pip-0E59n6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:15:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:15:38 INFO - Running setup.py (path:/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/pip-o8kz50-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:15:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:15:38 INFO - Running setup.py (path:/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/pip-jpyhIE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:15:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:15:38 INFO - Running setup.py (path:/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/pip-Q5Qgj3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:15:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:15:38 INFO - Running setup.py (path:/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/pip-Yc07On-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:15:38 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 13:15:38 INFO - Running setup.py install for manifestparser 13:15:38 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 13:15:38 INFO - Running setup.py install for mozcrash 13:15:39 INFO - Running setup.py install for mozdebug 13:15:39 INFO - Running setup.py install for mozdevice 13:15:39 INFO - Installing dm script to /builds/slave/test/build/venv/bin 13:15:39 INFO - Running setup.py install for mozfile 13:15:39 INFO - Running setup.py install for mozhttpd 13:15:39 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 13:15:39 INFO - Running setup.py install for mozinfo 13:15:39 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 13:15:39 INFO - Running setup.py install for mozInstall 13:15:39 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 13:15:39 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 13:15:39 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 13:15:39 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 13:15:39 INFO - Running setup.py install for mozleak 13:15:40 INFO - Running setup.py install for mozlog 13:15:40 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 13:15:40 INFO - Running setup.py install for moznetwork 13:15:40 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 13:15:40 INFO - Running setup.py install for mozprocess 13:15:40 INFO - Running setup.py install for mozprofile 13:15:40 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 13:15:40 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 13:15:40 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 13:15:40 INFO - Running setup.py install for mozrunner 13:15:40 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 13:15:40 INFO - Running setup.py install for mozscreenshot 13:15:41 INFO - Running setup.py install for moztest 13:15:41 INFO - Running setup.py install for mozversion 13:15:41 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 13:15:41 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 13:15:41 INFO - Cleaning up... 13:15:41 INFO - Return code: 0 13:15:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:15:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:15:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:15:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:15:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:15:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:15:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:15:41 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 0x1074b5b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1074b8768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fddaa560f40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107293d30>, '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 0x1071badb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107288be8>, '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.4gTHEGQ8w3/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.UgNS6Uc6gj/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 13:15:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 13:15:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 13:15:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4gTHEGQ8w3/Render', 13:15:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:15:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:15:41 INFO - 'HOME': '/Users/cltbld', 13:15:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:15:41 INFO - 'LOGNAME': 'cltbld', 13:15:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:15:41 INFO - 'MOZ_NO_REMOTE': '1', 13:15:41 INFO - 'NO_EM_RESTART': '1', 13:15:41 INFO - 'PAGER': '/bin/cat', 13:15:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:15:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:15:41 INFO - 'PWD': '/builds/slave/test', 13:15:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:15:41 INFO - 'SHELL': '/bin/bash', 13:15:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UgNS6Uc6gj/Listeners', 13:15:41 INFO - 'TMPDIR': '/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/', 13:15:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:15:41 INFO - 'USER': 'cltbld', 13:15:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:15:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:15:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:15:41 INFO - 'XPC_FLAGS': '0x0', 13:15:41 INFO - 'XPC_SERVICE_NAME': '0', 13:15:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:15:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:15:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:15:41 INFO - Running setup.py (path:/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/pip-FoIV0w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:15:41 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 13:15:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:15:41 INFO - Running setup.py (path:/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/pip-eRBuTA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:15:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 13:15:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:15:41 INFO - Running setup.py (path:/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/pip-hSZRF3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:15:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 13:15:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:15:41 INFO - Running setup.py (path:/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/pip-wC76LS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:15:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 13:15:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:15:42 INFO - Running setup.py (path:/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/pip-s608hH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:15:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 13:15:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:15:42 INFO - Running setup.py (path:/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/pip-4apkOR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:15:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 13:15:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:15:42 INFO - Running setup.py (path:/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/pip-p4oyfc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:15:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 13:15:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:15:42 INFO - Running setup.py (path:/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/pip-Yr5prv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:15:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 13:15:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:15:42 INFO - Running setup.py (path:/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/pip-U3a87M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:15:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 13:15:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:15:42 INFO - Running setup.py (path:/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/pip-VEBGcw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:15:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 13:15:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:15:42 INFO - Running setup.py (path:/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/pip-z0Bh2j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:15:42 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 13:15:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:15:42 INFO - Running setup.py (path:/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/pip-WinZX2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:15:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 13:15:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:15:42 INFO - Running setup.py (path:/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/pip-kd6mSm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:15:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 13:15:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:15:43 INFO - Running setup.py (path:/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/pip-eQQ4iN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:15:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 13:15:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:15:43 INFO - Running setup.py (path:/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/pip-tsx2ER-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:15:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 13:15:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:15:43 INFO - Running setup.py (path:/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/pip-68Mp28-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:15:43 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 13:15:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:15:43 INFO - Running setup.py (path:/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/pip-P3Nja7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:15:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 13:15:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 13:15:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 13:15:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 13:15:43 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 13:15:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 13:15:43 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 13:15:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:15:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:15:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:15:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:15:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:15:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:15:46 INFO - Downloading blessings-1.6.tar.gz 13:15:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 13:15:46 INFO - Installing collected packages: blessings 13:15:46 INFO - Running setup.py install for blessings 13:15:46 INFO - Successfully installed blessings 13:15:46 INFO - Cleaning up... 13:15:46 INFO - Return code: 0 13:15:46 INFO - Done creating virtualenv /builds/slave/test/build/venv. 13:15:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:15:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:15:46 INFO - Reading from file tmpfile_stdout 13:15:46 INFO - Current package versions: 13:15:46 INFO - blessings == 1.6 13:15:46 INFO - blobuploader == 1.2.4 13:15:46 INFO - docopt == 0.6.1 13:15:46 INFO - functools32 == 3.2.3-2 13:15:46 INFO - jsonschema == 2.5.1 13:15:46 INFO - manifestparser == 1.1 13:15:46 INFO - mozInstall == 1.12 13:15:46 INFO - mozcrash == 1.0 13:15:46 INFO - mozdebug == 0.1 13:15:46 INFO - mozdevice == 0.49 13:15:46 INFO - mozfile == 1.2 13:15:46 INFO - mozhttpd == 0.7 13:15:46 INFO - mozinfo == 0.9 13:15:46 INFO - mozleak == 0.1 13:15:46 INFO - mozlog == 3.4 13:15:46 INFO - moznetwork == 0.27 13:15:46 INFO - mozprocess == 0.25 13:15:46 INFO - mozprofile == 0.28 13:15:46 INFO - mozrunner == 6.13 13:15:46 INFO - mozscreenshot == 0.1 13:15:46 INFO - mozsystemmonitor == 0.3 13:15:46 INFO - moztest == 0.8 13:15:46 INFO - mozversion == 1.4 13:15:46 INFO - psutil == 3.1.1 13:15:46 INFO - requests == 1.2.3 13:15:46 INFO - wsgiref == 0.1.2 13:15:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:15:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:15:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:15:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:15:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:15:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:15:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:15:46 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 0x1074b5b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1074b8768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fddaa560f40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107293d30>, '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 0x1071badb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107288be8>, '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.4gTHEGQ8w3/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.UgNS6Uc6gj/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 13:15:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 13:15:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 13:15:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4gTHEGQ8w3/Render', 13:15:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:15:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:15:46 INFO - 'HOME': '/Users/cltbld', 13:15:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:15:46 INFO - 'LOGNAME': 'cltbld', 13:15:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:15:46 INFO - 'MOZ_NO_REMOTE': '1', 13:15:46 INFO - 'NO_EM_RESTART': '1', 13:15:46 INFO - 'PAGER': '/bin/cat', 13:15:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:15:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:15:46 INFO - 'PWD': '/builds/slave/test', 13:15:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:15:46 INFO - 'SHELL': '/bin/bash', 13:15:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UgNS6Uc6gj/Listeners', 13:15:46 INFO - 'TMPDIR': '/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/', 13:15:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:15:46 INFO - 'USER': 'cltbld', 13:15:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:15:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:15:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:15:46 INFO - 'XPC_FLAGS': '0x0', 13:15:46 INFO - 'XPC_SERVICE_NAME': '0', 13:15:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:15:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:15:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 13:15:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 13:15:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 13:15:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 13:15:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 13:15:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 13:15:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 13:15:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 13:15:46 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 13:15:46 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 13:15:46 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 13:15:46 INFO - Cleaning up... 13:15:46 INFO - Return code: 0 13:15:46 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 13:15:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:15:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:15:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:15:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:15:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:15:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:15:46 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 0x1074b5b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1074b8768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fddaa560f40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107293d30>, '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 0x1071badb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107288be8>, '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.4gTHEGQ8w3/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.UgNS6Uc6gj/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 13:15:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 13:15:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 13:15:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4gTHEGQ8w3/Render', 13:15:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:15:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:15:46 INFO - 'HOME': '/Users/cltbld', 13:15:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:15:46 INFO - 'LOGNAME': 'cltbld', 13:15:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:15:46 INFO - 'MOZ_NO_REMOTE': '1', 13:15:46 INFO - 'NO_EM_RESTART': '1', 13:15:46 INFO - 'PAGER': '/bin/cat', 13:15:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:15:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:15:46 INFO - 'PWD': '/builds/slave/test', 13:15:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:15:46 INFO - 'SHELL': '/bin/bash', 13:15:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UgNS6Uc6gj/Listeners', 13:15:46 INFO - 'TMPDIR': '/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/', 13:15:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:15:46 INFO - 'USER': 'cltbld', 13:15:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:15:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:15:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:15:46 INFO - 'XPC_FLAGS': '0x0', 13:15:46 INFO - 'XPC_SERVICE_NAME': '0', 13:15:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:15:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:15:47 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 13:15:47 INFO - Cleaning up... 13:15:47 INFO - Return code: 0 13:15:47 INFO - Running post-action listener: _resource_record_post_action 13:15:47 INFO - Running post-action listener: _start_resource_monitoring 13:15:47 INFO - Starting resource monitoring. 13:15:47 INFO - [mozharness: 2017-04-04 20:15:47.247349Z] Finished create-virtualenv step (success) 13:15:47 INFO - [mozharness: 2017-04-04 20:15:47.248280Z] Running install step. 13:15:47 INFO - Running pre-action listener: _resource_record_pre_action 13:15:47 INFO - Running main action method: install 13:15:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:15:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:15:47 INFO - Reading from file tmpfile_stdout 13:15:47 INFO - Detecting whether we're running mozinstall >=1.0... 13:15:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 13:15:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 13:15:47 INFO - Reading from file tmpfile_stdout 13:15:47 INFO - Output received: 13:15:47 INFO - Usage: mozinstall [options] installer 13:15:47 INFO - Options: 13:15:47 INFO - -h, --help show this help message and exit 13:15:47 INFO - -d DEST, --destination=DEST 13:15:47 INFO - Directory to install application into. [default: 13:15:47 INFO - "/builds/slave/test"] 13:15:47 INFO - --app=APP Application being installed. [default: firefox] 13:15:47 INFO - mkdir: /builds/slave/test/build/application 13:15:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 13:15:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 13:16:07 INFO - Reading from file tmpfile_stdout 13:16:07 INFO - Output received: 13:16:07 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 13:16:07 INFO - Running post-action listener: _resource_record_post_action 13:16:07 INFO - [mozharness: 2017-04-04 20:16:07.749582Z] Finished install step (success) 13:16:07 INFO - [mozharness: 2017-04-04 20:16:07.749734Z] Running run-tests step. 13:16:07 INFO - Running pre-action listener: _resource_record_pre_action 13:16:07 INFO - Running main action method: run_tests 13:16:07 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 13:16:07 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 13:16:07 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 13:16:07 INFO - 2017-04-04 13:16:07.764 screenresolution[1622:7324] starting screenresolution argv=screenresolution get 13:16:07 INFO - 2017-04-04 13:16:07.766 screenresolution[1622:7324] Display 0: 1600x1200x32@60 13:16:07 INFO - 2017-04-04 13:16:07.772 screenresolution[1623:7327] starting screenresolution argv=screenresolution list 13:16:07 INFO - Available Modes on Display 0 13:16:07 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 13:16:07 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 13:16:07 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 13:16:07 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 13:16:07 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 13:16:07 INFO - Intel Iris: 13:16:07 INFO - Chipset Model: Intel Iris 13:16:07 INFO - Type: GPU 13:16:07 INFO - Bus: Built-In 13:16:07 INFO - VRAM (Dynamic, Max): 1536 MB 13:16:07 INFO - Vendor: Intel (0x8086) 13:16:07 INFO - Device ID: 0x0a2e 13:16:07 INFO - Revision ID: 0x0009 13:16:07 INFO - Displays: 13:16:07 INFO - Display: 13:16:07 INFO - Resolution: 1600 x 1200 @ 60 Hz 13:16:07 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 13:16:07 INFO - Display Serial Number: 1600x1200 60 13:16:08 INFO - Main Display: Yes 13:16:08 INFO - Mirror: Off 13:16:08 INFO - Online: Yes 13:16:08 INFO - Rotation: Supported 13:16:08 INFO - Return code: 0 13:16:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 13:16:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 13:16:08 INFO - Python 2.7.3 13:16:08 INFO - Return code: 0 13:16:08 INFO - grabbing minidump binary from tooltool 13:16:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:16:08 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 0x107293d30>, '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 0x1071badb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107288be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 13:16:08 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 13:16:08 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 13:16:08 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 13:16:08 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 13:16:08 INFO - Return code: 0 13:16:08 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 13:16:08 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 13:16:08 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 13:16:08 INFO - ENV: RUST_BACKTRACE is now 1 13:16:08 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 13:16:08 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 13:16:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Pine', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/d4iKk8LgRCqYM8jbxQZwcQ/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0101', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 13:16:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Pine --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/d4iKk8LgRCqYM8jbxQZwcQ/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0101 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 13:16:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4gTHEGQ8w3/Render', 13:16:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:16:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:16:08 INFO - 'HOME': '/Users/cltbld', 13:16:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:16:08 INFO - 'LOGNAME': 'cltbld', 13:16:08 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 13:16:08 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 13:16:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:16:08 INFO - 'MOZ_NO_REMOTE': '1', 13:16:08 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 13:16:08 INFO - 'NO_EM_RESTART': '1', 13:16:08 INFO - 'PAGER': '/bin/cat', 13:16:08 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:16:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:16:08 INFO - 'PWD': '/builds/slave/test', 13:16:08 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 13:16:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:16:08 INFO - 'RUST_BACKTRACE': '1', 13:16:08 INFO - 'SHELL': '/bin/bash', 13:16:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UgNS6Uc6gj/Listeners', 13:16:08 INFO - 'TMPDIR': '/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/', 13:16:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:16:08 INFO - 'USER': 'cltbld', 13:16:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:16:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:16:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:16:08 INFO - 'XPC_FLAGS': '0x0', 13:16:08 INFO - 'XPC_SERVICE_NAME': '0', 13:16:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:16:08 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Pine', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/d4iKk8LgRCqYM8jbxQZwcQ/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0101', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 13:16:08 INFO - mozversion application_buildid: 20170404090329 13:16:08 INFO - mozversion application_changeset: 29799ff6c8a5578fb2939f66815668b18cb15e3b 13:16:08 INFO - mozversion application_display_name: Nightly 13:16:08 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 13:16:08 INFO - mozversion application_name: Firefox 13:16:08 INFO - mozversion application_remotingname: firefox 13:16:08 INFO - mozversion application_repository: https://hg.mozilla.org/projects/pine 13:16:08 INFO - mozversion application_vendor: Mozilla 13:16:08 INFO - mozversion application_version: 55.0a1 13:16:08 INFO - mozversion platform_buildid: 20170404090329 13:16:08 INFO - mozversion platform_changeset: 29799ff6c8a5578fb2939f66815668b18cb15e3b 13:16:08 INFO - mozversion platform_repository: https://hg.mozilla.org/projects/pine 13:16:08 INFO - mozversion platform_version: 55.0a1 13:16:08 INFO - using testdate: 1491336968 13:16:08 INFO - actual date: 1491336968 13:16:08 INFO - starting webserver on 'localhost:49241' 13:16:08 INFO - SUITE-START | Running 2 tests 13:16:08 INFO - TEST-START | dromaeo_css 13:16:08 INFO - operating with platform_type : mac_ 13:16:08 INFO - Initialising browser for dromaeo_css test... 13:16:08 INFO - TEST-INFO | started process 1633 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/tmpeO8MXI/profile http://localhost:49241/getInfo.html) 13:16:11 INFO - PID 1633 | 2017-04-04 13:16:11.466 plugin-container[1635:7508] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4c4b, name = 'com.apple.tsm.portname' 13:16:11 INFO - PID 1633 | See /usr/include/servers/bootstrap_defs.h for the error codes. 13:16:11 INFO - PID 1633 | 2017-04-04 13:16:11.469 plugin-container[1635:7508] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x940b, name = 'com.apple.CFPasteboardClient' 13:16:11 INFO - PID 1633 | See /usr/include/servers/bootstrap_defs.h for the error codes. 13:16:11 INFO - PID 1633 | 2017-04-04 13:16:11.469 plugin-container[1635:7508] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 13:16:11 INFO - PID 1633 | __metrics Screen width/height:1600/1200 13:16:11 INFO - PID 1633 | colorDepth:24 13:16:11 INFO - PID 1633 | Browser inner width/height: 1024/689 13:16:11 INFO - PID 1633 | __metrics 13:16:11 ERROR - PID 1633 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3355: TypeError: this.tabs is undefined 13:16:12 INFO - TEST-INFO | 1633: exit 0 13:16:12 INFO - Browser initialized. 13:16:12 INFO - Running cycle 1/1 for dromaeo_css test... 13:16:12 INFO - TEST-INFO | started process 1636 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/tmpeO8MXI/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:16:15 INFO - PID 1636 | 2017-04-04 13:16:15.019 plugin-container[1637:7629] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x883f, name = 'com.apple.tsm.portname' 13:16:15 INFO - PID 1636 | See /usr/include/servers/bootstrap_defs.h for the error codes. 13:16:15 INFO - PID 1636 | 2017-04-04 13:16:15.019 plugin-container[1637:7629] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8c0b, name = 'com.apple.CFPasteboardClient' 13:16:15 INFO - PID 1636 | See /usr/include/servers/bootstrap_defs.h for the error codes. 13:16:15 INFO - PID 1636 | 2017-04-04 13:16:15.019 plugin-container[1637:7629] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 13:16:24 INFO - PID 1636 | RSS: Main: 230424576 13:16:24 INFO - PID 1636 | 13:19:28 INFO - PID 1636 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49241/tests/dromaeo/cssquery-ext.html) 13:19:30 INFO - PID 1636 | RSS: Main: 254545920 13:19:30 INFO - PID 1636 | 13:21:12 INFO - PID 1636 | ************************* 13:21:12 INFO - PID 1636 | A coding exception was thrown and uncaught in a Task. 13:21:12 INFO - PID 1636 | 13:21:12 ERROR - PID 1636 | Full message: TypeError: NetworkError when attempting to fetch resource. 13:21:12 INFO - PID 1636 | Full stack: 13:21:12 INFO - PID 1636 | ************************* 13:21:12 INFO - PID 1636 | ************************* 13:21:12 INFO - PID 1636 | A coding exception was thrown and uncaught in a Task. 13:21:12 INFO - PID 1636 | 13:21:12 ERROR - PID 1636 | Full message: TypeError: NetworkError when attempting to fetch resource. 13:21:12 INFO - PID 1636 | Full stack: 13:21:12 INFO - PID 1636 | ************************* 13:21:12 INFO - PID 1636 | ************************* 13:21:12 INFO - PID 1636 | A coding exception was thrown and uncaught in a Task. 13:21:12 INFO - PID 1636 | 13:21:12 ERROR - PID 1636 | Full message: TypeError: NetworkError when attempting to fetch resource. 13:21:12 INFO - PID 1636 | Full stack: 13:21:12 INFO - PID 1636 | ************************* 13:21:12 INFO - PID 1636 | ************************* 13:21:12 INFO - PID 1636 | A coding exception was thrown and uncaught in a Task. 13:21:12 INFO - PID 1636 | 13:21:12 ERROR - PID 1636 | Full message: TypeError: NetworkError when attempting to fetch resource. 13:21:12 INFO - PID 1636 | Full stack: 13:21:12 INFO - PID 1636 | ************************* 13:22:32 INFO - PID 1636 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-ext.html (next: http://localhost:49241/tests/dromaeo/cssquery-jquery.html) 13:22:32 INFO - PID 1636 | RSS: Main: 262373376 13:22:32 INFO - PID 1636 | 13:25:34 INFO - PID 1636 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49241/tests/dromaeo/cssquery-mootools.html) 13:25:35 INFO - PID 1636 | RSS: Main: 274264064 13:25:35 INFO - PID 1636 | 13:28:37 INFO - PID 1636 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49241/tests/dromaeo/cssquery-prototype.html) 13:28:37 INFO - PID 1636 | RSS: Main: 266678272 13:28:37 INFO - PID 1636 | 13:31:40 INFO - PID 1636 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49241/tests/dromaeo/cssquery-yui.html) 13:31:41 INFO - PID 1636 | RSS: Main: 277032960 13:31:41 INFO - PID 1636 | 13:34:43 INFO - PID 1636 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-yui.html (next: http://localhost:49241/tests/dromaeo/cssquery-dojo.html) 13:34:43 INFO - PID 1636 | RSS: Main: 273747968 13:34:43 INFO - PID 1636 | 13:34:43 INFO - PID 1636 | __start_tp_report 13:34:43 INFO - PID 1636 | _x_x_mozilla_page_load 13:34:43 INFO - PID 1636 | _x_x_mozilla_page_load_details 13:34:43 INFO - PID 1636 | |i|pagename|runs| 13:34:43 INFO - PID 1636 | |0;dojo.html;3541.433370660695;3578.2843431313736;3597.80212088335;3612.3317186320533;3617.1861331200485;6077.0884367344925;6220.222472190976;6220.440160385564;6235.812925612227;6264.874702505947;4969.900601987958;6149.046897730847;6179.351168127349;6231;6258.186435763344;5424.186372044185;5446.972765136179;5450.645708028966;5460.426655201206;5539.25220095288;5339.359276886759;5404.6486978346475;5487.6433031853;5490.176473528963;5511.118221084627;5327.987682340343;5387.0841956867425;5421.21392398104;5421.484958928935;5454.699991500466;5431.348238211401;5435.211894275348;5462.0987537056335;5486.286782718221;5502.9174562381595;5380.677159370412;5404.189371594253;5404.729763511808;5411.269478620415;5481.588880833913;4910.091633047898;5940.881182376328;5972.283326000907;6072.453479186895;6116;6427.8393040173905;6485.902711459332;6576.5067619928695;6577.375149360803;6595.340465953414;6754.9662251688915;6777.695003724844;6784.1858976922595;6788.1175447192045;6802.4217941475035;5244.842654720326;6338.429541341301;6367.936320636827;6380.968095159541;6399.744010239631;6218.9427797274575;6289.371062893674;6395.488360931115;6584;6828.487863410264;6251.374862513712;6359.872802543923;6362.268339141058;6492.480601551864;6618.53670243088;5371.4897084776885;6372.171617689671;6504.447121994589;6714.429273511806;6724.226713927961;6619.66901654925;6646.015488383712;6651.935690289627;6653.534252602271;6655.500837437212;6334.144890439732;6353;6479.935200648028;6663.633500157538;6682.365175308338;5281.524662780368;5300.734963251822;5307.920381194285;5313.521783039545;5359.544438722753;4695.671303008825;4721.504242054535;4726.527347265246;4729.858104256878;4761.500042495557;6115.666295175888;6139;6285.497160227171;6297.275813281532;6330.746770129143;5411.053065713563;5756.913646295309;5890.705464726832;6617.503687223478;6678.599284042876;5294.894102117936;6173.012318029184;6368.522360822957;6374.521910856704;6378.776742814072;5704.71476426177;5883.94116058834;5917.467427931507;5930.466258036798;5935.881282374328;6591.307912669101;6793.932060679527;6871.690773915086;6905.343992320722;6906.585604863724;6732.057511948429;6737.225219099866;6748.662566871735;6753.15585551806;6753.594784312761;6819.863602728017;6889.311068893071;6916.93083069183;6922.238553758982;6951.16586009682;6319.399657032574;6431.967840160769;6560.540762146795;6584.8353791155605;6628.701708423229;6601.943689009735;6695.966520167368;6712.39588437043;6731.495137864582;6755.05429239897;6216.72024758896;6347.39699728525;6421.068945002855;6439.774607888889;6479.157709497735;6375.936240637534;6441.291457939717;6451.516136289703;6468.5472016958365;6478.611283323015;5226.660267082628;5559.138333558305;6346.682665866781;6354.23749150105;6378.90431643535;5147.6911385317;6401.327860574573;6416.935830641821;6427.614343139427;6457;6240.594361366497;6278.340774218641;6298.937010630018;6329.1139240505445;6336.524760643062 13:34:43 INFO - PID 1636 | |1;ext.html;610.1732152932776;810.0886502684479;835.4861760017591;1269.2447993443898;1269.2574843716425;38569.61430385695;39671.60328396715;39697;39758.60241397585;39780.80109599452;34939.301213975705;36434.27131457376;38839.80580097103;39104.80447597765;39204.803975980154;6681.398674119316;7097.787066388017;8120.1879812018915;8482.448640838356;8725.171108744691;8597.054324024351;8632.956835215815;8721.781955451133;8728.039915609277;8755.649774009033;7799.337056350217;8651.783705407352;8660.307175425982;8733.95633021834;8738.169873862005;8673.219410253076;8699;8719.084496127878;8732.257758090569;8739.825203495959;8562.70030548934;8568.871466928002;8608.569571521399;8618.525981071038;8619.051904290523;38306;38469.42295865564;38525.42211866824;38546.80726596377;38608.61391386078;3447.5690538682666;3449.1721986723255;3474.5656792900886;3483.7909725416557;3486.163320802989;28204.01285955002;30096;30244.69755302441;30439.543406848916;30451.543226851616;2895.102518219359;3113.470709979309;3141.7172454479205;3170;3176.332970076264;318579.2213116805;320079.5944283901;330664.3466782651;337385;338561;52574;52978;52990;53097.734511327195;53284.46715532795;54845.45154548483;55230;55656;55754;55849.720751396795;14470.421183152766;14552.41790328375;14707.558773236606;14720.558383248519;14722.263886805616;11892.989095926943;11893.70265743346;11915.2255103418;11924.224925379822;11928.821067683992;14037.649058773408;14102.85897141036;14155;14225.933055020914;14249.073810202304;5580;6019.729112189962;6078.3617720138745;6097.451229389376;6115.143879856823;816.4285000499674;963.8987906269881;975.11264749078;997.8453339732353;1016.5781200801732;19469;23733.643995340084;24363;24557.754422455546;24626;1079.3685693869018;1086.1365214654368;1099.7910397024539;1118.6532175025768;1123.1969142063301;10882.727931801768;11986.88013119875;12632.115751897463;12678.936605316914;12711.173773704679;358729;457387.27838164906;458205;459530;459786;55423.168652470245;55927.440725593035;56138.7193064032;56165.87668246612;56282;1449.8332691740375;1490.5975386645546;1517.833038365779;1519.7948276982465;1526.1301058396607;24045.398865028514;26802.865985669945;28860.711392886642;29734.55398168986;29816.552751709176;54344.19590628618;54398.45601543934;54525.454745452036;54634.45365546294;54883.72558137184;355018.2249088738;436288;445308;448950;450811.7459412682;34909.127271818405;35483.64516354803;35624;35694.82152589221;35701.28597428089;42852;43184;43361.13277734364;44453.33320000267;44507.55492445034;25922.761363693688;27856.44287114287;30339.848300758356;30587.388252235276;30598.541021884244;28486.85756571204;29545;30253.697463025088;30344.78620855141;30717.23206919845;35980.640193598774;36215.456768147975;36486.817565912;36567.26865462623;36781.89654310375;22787.88606056959;29356.266093347836;29556.261093471974;30438.695613043586;30512;20105.793652380904;20697.586048279252;21609;23076.307710768702;24748.257552273462 13:34:44 INFO - PID 1636 | |2;jquery.html;418.26385561411945;423.66318776572626;435.27465830939326;435.41654183394246;453.1661742393994;19839.20643174275;21288.57422851544;21954;21999.670004949938;22218.00018999145;21895;22135.778642213612;22146.778532214674;22550.43623909403;23310.06759729613;6038.69806509675;6222.004479283316;6226.470749986257;6230.626162430269;6233.71948262327;5868.9413105868825;6119.571629985903;6160.260768707762;6165.599236049642;6175.135481032659;5940.554458415614;6025.642946691239;6096;6121.540884433663;6126.7549298028025;6250;6298.275698294663;6303.401176888234;6313.242410910697;6330.588511746721;5385.892282154374;5406.945930540684;5464.9180262296095;5466.808661696821;5607.158926161068;23626.881865590563;27944.16167514978;28021.719782802116;28118.859405703046;28443;2119.448943274744;2187.8359123065834;2189.5949249388755;2190.6166420876284;2194.264921251383;17534.561635959075;17599.73600395995;17624.295028198856;17995.910020449945;18109.275628974825;2077.981788923432;2138.700581918533;2151.5911976724374;2165.2421652421526;2171.3051823416513;129292;164838.3516164835;165271;166337;167005.16497417435;12192;12445.937770311271;12524.74950500985;12583.307918064595;12818.294993775431;16165.838341616432;16330.265138068815;16381.508554743377;16384.344626214817;16398.67202655964;7765.883511747328;8700.34747393948;9070.455772653662;9098.499582522893;9347.392419492711;8739.825203495895;8761.474311541328;8769.736907892773;8874.423162494417;8887.911120888837;6263.96868015657;7831.864379664917;7874.645640946172;7883.448158628956;7930.5638189898955;1828.3052440072688;2153.1491789384154;2175.7715439878903;2181.9890900545397;2335.8014568761505;933.6452148183647;936.1901954809041;945.5130607737021;973.2019743810008;981.2346369831542;19253.711194332096;20473.385798425774;20504.897475512826;20632.896835516025;20878.164873404894;969.3021024862088;971.1987610221596;1003.8092762375126;1003.964861229868;1011.9038691324313;10321.432321222404;10748.301360411548;10805.513751881026;10811;10833.620823271147;676668;687177;696468;707988;718968;146671;147555;155848;159674;161245.0692677252;1202.3026644546142;1205.3671822293365;1247.5508816825936;1253.6489782860813;1253.7805883970452;21167.576648467253;21208.787912121297;21328.680069799277;21588.136474541472;21588.78411215868;53329;59567.40432595619;62847.6857615709;65603.67198163978;66352;84908;90769.54615226881;91450.54274728584;91513.7121571966;91653;8727.956360218412;8744.300455963636;8791.692070885349;8826.735197944072;9027.32295077885;13713.862861371259;13732.038757286895;13939.493082303632;14072.437102515785;14079.648008799863;11148.108151348035;11859.789774630228;11909.702257443632;11957.402129893644;12035.518579256732;9365.297602679962;10350.585976561155;10972.23194376418;11176.888231117584;11264.887351126385;11818.881811181778;11847.289162649924;12062.51749929993;12126.818097728365;12156.696082598006;9035.954820225857;12191.171324301426;12564;12847.678808029874;13147.671308217372;10113.039261270167;11671.941640291745;11819.468123934272;12180.467664377586;12239.632811015328 13:34:44 INFO - PID 1636 | |3;mootools.html;1346.2797403389186;1411.4848080450638;1414.3069895751084;1426.0516756357024;1438.7266419380317;9029.683961061364;10752.677419677413;11229.550817967282;11235.550577976881;11371.260868043571;11100;11175.944120279408;11314.490847911844;11317.660470185887;11319.603813866517;2120.968185477219;2448;2451.7303096659352;2483.75162483752;2487.7139129000125;2372.8694921779297;2447.4615584571366;2451;2470.308313672175;2474.7030356357172;2367.8342516023886;2448.51029794041;2448.8163387745903;2449.510097980411;2460.6063029915217;2336.8481048731946;2390.426297688551;2400.919586186223;2405.1822380390663;2435.622478515833;2337.1819863047967;2412.9034838606435;2417.528581926525;2434.0993832281993;2453.4970331082263;10983.450827458595;11061.336319820837;11063.612773552886;11066.114710823196;11080.722981925517;5815.21494598228;6264.185655864709;6446.484281257488;6479.254885688159;6506.967465162691;3289.111939776247;3398.898033059012;3749.381352076904;3976.224636195943;4086.162336720965;1213.9393030348447;1223.8837310455492;1248.7814632439288;1262.7790136726128;1263.7219811641517;14082.295885205698;14555.19946402958;15304.464343747915;15407.998480098759;15435.614109647237;5272.261883336336;5352.223927530486;5559.916601250984;5560.805371811967;5571.554275657938;11385.487653055632;11597.88402115968;11600.361980091177;11611.90985622596;11635.650930472098;6283.465905398001;6360.554761166674;6362.363763623694;6365.777197798055;6374;5793.420657934173;5963.075723262901;6015.3383127855905;6071.848203794852;6095.573309868355;4214.431051808028;4289.1850548395705;4326.58897404746;4344.674149438742;4397.834573837871;1258.6098309524077;1275.661949583361;1276.9170003949714;1293.6183825771232;1300.0964329790704;745.4781652843031;754.3437209627659;775.7440044785208;778.8792737125755;811.7686459359172;6606.966965165144;6878.243393226741;7040.823979400454;7064.364207221375;7090.184628767758;884.0673089890228;885.2386947225381;900.4102312984875;900.7072701372081;907.9182873541413;3995.780232087263;4056.229316429869;4233.534311225762;4261.786910654517;4356.128774245164;12853.871461285267;14097;14164.716705665829;14385.352659130363;14386.568402947929;10998.175136864607;13394.799078013837;13947.58157255284;14338.928305358406;14516.637084072983;10332.793344133075;10421;10425.582976681;10493.47532623381;10523.473826308807;6037.75848966054;6070.969645151746;6671.799846004627;6827.146606674166;6949.3745562899585;12050.216735912489;12141.514339426323;12284.1401101922;12450.439730211981;12991.35043247815;12986.480540778262;13025.413856376676;13047.804282935575;13082.80375794383;13098.541551045668;8237.176282371714;8457.281131103926;8468.322534197372;8480.279176270085;8497.490150590984;9900.306978511435;10190.929952354896;10268.845967310346;10326.48367581633;10340.37957722539;8670.566471676517;8703.216710496086;8703.955525337;8759.91240087591;8938.195562399154;8510.574471276535;8558.871616925875;8564.914350856412;8660.35047371437;8705.47767133974;7791.61041947889;7882.7241046563095;7949.920500794918;7961.16407777175;7968.282854543119;5836.270466191726;5857.853553661193;5947.464728174485;6050.062240352752;6074.36219196978;5859.355470898283;5915.645061296336;6082.817515474543;6104.4505994460715;6237.033259844731 13:34:44 INFO - PID 1636 | |4;prototype.html;337.9831008449578;352.937657650472;385.652912378859;408.82011914757516;410.3536929336294;4520.367148599199;5154.768035438405;6032.215811944447;6071.483923866476;6250.468710159631;5137.537621614054;5525.861853453665;5580.107182850745;5843.590948633598;6119.143319935201;4513.2101882170655;4516.819327226907;4523.253663145577;4526.524714904937;4533.297338912474;4271.807768650418;4373.300271956487;4544.182047231497;4548.204064288753;4549.181147393468;4451.910961780763;4454.265046267362;4466.307722303032;4494.1461122386645;4514.954850451502;4492.326151077332;4496.707713998596;4512.706674066175;4516.661250406232;4516.954830451687;3322.8670853165845;3522.277933023724;3613.6567026132475;3674.9053039767346;3920.4315374270855;4952.455229924705;5992.910106348409;5994.8501287467725;6001.649628833521;6003.247970018739;4692.554207350297;5373.167159090347;5398;5406.567474602022;5427.755750991176;6178.9691051544905;6503.739850405978;6523;6598.340165983412;6640.468762498988;4388.275934470808;4391.989842336248;4396.054848207618;4409;4431.91699901046;5799.768009279624;5969.910451343233;5981.641101533922;6778.966719619493;6864.2106157791495;3722.7207959402613;4237.618614324726;4423.646108311327;4455.799489023002;4463.66522510813;3828.5405751310022;4531.252343363374;4546;4566.360709500673;4570.177368073712;4462.821487140478;4868.902621947541;5170.1469257572835;5369.328833895763;5380.757865896044;5509.118541033416;6557.868842623121;6593.406593406617;6618.30507796684;6638.701258443381;1239.7292774905793;1306.399056434051;1438.762604170321;1536.0399750156153;1562.796836411282;966.367029595616;1016.9288149829589;1022.8261195596766;1030.1192480429124;1033.49358814182;5462.399136095027;5888.852778680567;6125.632462052291;6148.4159004895355;6157.168782214344;6048.304444988795;6213.720382582795;6776.424003959719;6796.898046529306;6807.65961701913;5462.590305727086;5701.914471282934;5740.70834062341;6014.548908831855;6057.00059490188;3328.2511434927433;3560.590532088791;3576.195356044869;3580.5166302548823;3581.552305961755;6108.205933228741;6416.101745755598;6814.182298124158;6937.202221744564;6993.852766255104;6940.722371105099;6943.930560694429;7017.193022802341;7018.2278000189635;7029.22678505364;5898.35118136996;6646.966765166143;6998.10132906957;7028.262032486516;7107.92892071083;6525.412712855866;6579.506537009839;6768.4585233182215;6781.321867813179;6884.139482564679;5653.434656534479;6070.757169713162;6631.767888123893;6743.730250789913;6770.255271919987;5161.032406366429;5914.940850591439;6670.733170673118;6762.889071027383;7053.4004609608755;4056.350983842571;4103.8974025649595;4120.649744771608;4154.356074808409;4480.596746292719;6394.840128996812;6413;6467.482601391784;6484.254310754135;6762.560433571802;4801.767178262125;5842.649441033552;5891.1457838614015;6033.728482218398;6511.2512061113575;5776;6228.844278892882;6456.418922297016;6520.771772987922;6566.080748695282;5625.662460252398;6069.726862291296;6209.883264983897;6337.225576838493;6398.840028999312;4998.725070121178;6053.576249662481;6490.935090649222;6540.901886471612;6579.17760279965;5767.8558036049435;5787.884242315215;6335.556511044183;6346.682665866781;6449.838754031187 13:34:44 INFO - PID 1636 | |5;yui.html;772.4091070331198;807.9111297757249;826.4132465949176;842.380850075195;847.9830403391933;15803.841961580381;16345.509634710963;17355.132243387827;18452.985085820274;18580.628387432243;17004.744928826076;17314.740278895795;17374.82625173751;17379.217935192915;17753.556161095978;1002.1031177096512;1035.3994683083831;1036;1037.761314897574;1041.281515754131;990.3612170150249;1021.8569400283966;1028.4497793680382;1034.9948250258738;1038.5949479702922;1086.0388556127843;1089.1341383600056;1089.629525961173;1092.5138313450518;1095.43585053697;1080.6811990462832;1082.880883102862;1083.7994970930324;1084.9313426275112;1086.7554800169937;792.0693185507006;812.0336799208982;813.4509206285793;814.2834305810849;814.7922279818667;16282.674346513122;16330.75503867443;16482.175891205512;16865.156742162966;17018.744718829228;14617.269136543131;14798.556043318718;14863.479778207819;14881.627959300995;15485.612859678598;12994.675133121747;13418.060735748404;13497.048547168544;13532.32338383077;13581.117227380288;3224.790388624732;3242.189452636841;3270.1988012936745;3275.1157187559224;3279.9344013119844;111913.44043279813;112809.43595281971;113663;114591.42704286425;115864.42067789691;11419.60031398897;11629.302241865515;11647.242929209744;11760.70598235051;12030.81953770694;24772.628410573856;24815.5036899261;24919.127830525846;25150.874245628656;25334.239972800846;7777.051861974019;7905.169957154531;8052.798680033046;8086.838263234702;8115.147909469539;3726.3386418045848;4079.204555111784;4191.161767646483;4235.830566777356;4329.458817647794;4141.834326626901;4213.6207741302815;4215.873523794291;4241.766702831374;4250.489941207075;645.8579112595221;780.867252567065;787.4960025583631;796.1799346672937;796.243568609823;603.1465476350915;623.1960770605867;636.0808631527491;647.4658406814303;648.3581254557954;8201.466904651297;9824.754381140387;9969.35199212049;10157.593696252216;10232.6418575351;587.5358466811257;602.0728078758663;623.822210669966;638.1321402892063;652.5040968863698;4645.9303110453375;4649.651276154234;4679.602233810097;4681.274402467623;4700.271457924027;102327;102698.48650756698;103171.4841425788;105628;106003;74222;92614.61078083834;93023.53488232516;94705.52647236857;95997.52001239949;73679;83176.58411707902;83865;84565.57717211374;85869.57065214634;9841.901580984384;10912.454377280945;11165.888341116484;11169.329840209613;11304;40615;41252;41822.790886045375;42063.7896810514;42179.57820421756;52709.47290527199;52766.73616632046;53052.20421693601;53138.46861531335;53255;13423.472684793878;13789.172649641054;13888;14048.438062477386;14362.210078445785;14505.709885802436;14526.782098268746;14547.665684793965;14592.416303348173;15347.923260384074;13657.112287701268;13808.447662093404;13968.930155349159;14310.928445357707;14557.781633275297;13231.338433078115;13769.862301376857;13785.379657915217;13823.239721815396;13962.232077235443;13320.239086327498;13422.918703261555;13429.798553021908;13665.18008919468;13942.930285348508;9003.369764116711;10064.295499314978;10156.18750499973;10427;10690.62582809598;7734.922650773646;9473.715788526355;9570.95214523923;10302.484875756332;11185.161112916727 13:34:44 INFO - PID 1636 | __end_tp_report 13:34:44 INFO - PID 1636 | __start_cc_report 13:34:44 INFO - PID 1636 | _x_x_mozilla_cycle_collect,435 13:34:44 INFO - PID 1636 | __end_cc_report 13:34:44 INFO - PID 1636 | __startTimestamp1491338083993__endTimestamp 13:34:44 INFO - PID 1636 | 13:34:44 INFO - PID 1636 | ------- Summary: start ------- 13:34:44 INFO - PID 1636 | Number of tests: 6 13:34:44 INFO - PID 1636 | 13:34:44 INFO - PID 1636 | [#0] dojo.html Cycles:165 Average:6055.64 Median:6329.11 stddev:716.88 (11.3%) stddev-sans-first:691.42 13:34:44 INFO - PID 1636 | Values: 3541.4 3578.3 3597.8 3612.3 3617.2 6077.1 6220.2 6220.4 6235.8 6264.9 4969.9 6149.0 6179.4 6231.0 6258.2 5424.2 5447.0 5450.6 5460.4 5539.3 5339.4 5404.6 5487.6 5490.2 5511.1 5328.0 5387.1 5421.2 5421.5 5454.7 5431.3 5435.2 5462.1 5486.3 5502.9 5380.7 5404.2 5404.7 5411.3 5481.6 4910.1 5940.9 5972.3 6072.5 6116.0 6427.8 6485.9 6576.5 6577.4 6595.3 6755.0 6777.7 6784.2 6788.1 6802.4 5244.8 6338.4 6367.9 6381.0 6399.7 6218.9 6289.4 6395.5 6584.0 6828.5 6251.4 6359.9 6362.3 6492.5 6618.5 5371.5 6372.2 6504.4 6714.4 6724.2 6619.7 6646.0 6651.9 6653.5 6655.5 6334.1 6353.0 6479.9 6663.6 6682.4 5281.5 5300.7 5307.9 5313.5 5359.5 4695.7 4721.5 4726.5 4729.9 4761.5 6115.7 6139.0 6285.5 6297.3 6330.7 5411.1 5756.9 5890.7 6617.5 6678.6 5294.9 6173.0 6368.5 6374.5 6378.8 5704.7 5883.9 5917.5 5930.5 5935.9 6591.3 6793.9 6871.7 6905.3 6906.6 6732.1 6737.2 6748.7 6753.2 6753.6 6819.9 6889.3 6916.9 6922.2 6951.2 6319.4 6432.0 6560.5 6584.8 6628.7 6601.9 6696.0 6712.4 6731.5 6755.1 6216.7 6347.4 6421.1 6439.8 6479.2 6375.9 6441.3 6451.5 6468.5 6478.6 5226.7 5559.1 6346.7 6354.2 6378.9 5147.7 6401.3 6416.9 6427.6 6457.0 6240.6 6278.3 6298.9 6329.1 6336.5 13:34:44 INFO - PID 1636 | 13:34:44 INFO - PID 1636 | [#1] ext.html Cycles:180 Average:54115.96 Median:197354.82 stddev:106788.30 (54.1%) stddev-sans-first:107012.31 13:34:44 INFO - PID 1636 | Values: 610.2 810.1 835.5 1269.2 1269.3 38569.6 39671.6 39697.0 39758.6 39780.8 34939.3 36434.3 38839.8 39104.8 39204.8 6681.4 7097.8 8120.2 8482.4 8725.2 8597.1 8633.0 8721.8 8728.0 8755.6 7799.3 8651.8 8660.3 8734.0 8738.2 8673.2 8699.0 8719.1 8732.3 8739.8 8562.7 8568.9 8608.6 8618.5 8619.1 38306.0 38469.4 38525.4 38546.8 38608.6 3447.6 3449.2 3474.6 3483.8 3486.2 28204.0 30096.0 30244.7 30439.5 30451.5 2895.1 3113.5 3141.7 3170.0 3176.3 318579.2 320079.6 330664.3 337385.0 338561.0 52574.0 52978.0 52990.0 53097.7 53284.5 54845.5 55230.0 55656.0 55754.0 55849.7 14470.4 14552.4 14707.6 14720.6 14722.3 11893.0 11893.7 11915.2 11924.2 11928.8 14037.6 14102.9 14155.0 14225.9 14249.1 5580.0 6019.7 6078.4 6097.5 6115.1 816.4 963.9 975.1 997.8 1016.6 19469.0 23733.6 24363.0 24557.8 24626.0 1079.4 1086.1 1099.8 1118.7 1123.2 10882.7 11986.9 12632.1 12678.9 12711.2 358729.0 457387.3 458205.0 459530.0 459786.0 55423.2 55927.4 56138.7 56165.9 56282.0 1449.8 1490.6 1517.8 1519.8 1526.1 24045.4 26802.9 28860.7 29734.6 29816.6 54344.2 54398.5 54525.5 54634.5 54883.7 355018.2 436288.0 445308.0 448950.0 450811.7 34909.1 35483.6 35624.0 35694.8 35701.3 42852.0 43184.0 43361.1 44453.3 44507.6 25922.8 27856.4 30339.8 30587.4 30598.5 28486.9 29545.0 30253.7 30344.8 30717.2 35980.6 36215.5 36486.8 36567.3 36781.9 22787.9 29356.3 29556.3 30438.7 30512.0 20105.8 20697.6 21609.0 23076.3 24748.3 13:34:44 INFO - PID 1636 | 13:34:44 INFO - PID 1636 | [#2] jquery.html Cycles:180 Average:41055.25 Median:12042.81 stddev:117215.40 (973.3%) stddev-sans-first:117504.50 13:34:44 INFO - PID 1636 | Values: 418.3 423.7 435.3 435.4 453.2 19839.2 21288.6 21954.0 21999.7 22218.0 21895.0 22135.8 22146.8 22550.4 23310.1 6038.7 6222.0 6226.5 6230.6 6233.7 5868.9 6119.6 6160.3 6165.6 6175.1 5940.6 6025.6 6096.0 6121.5 6126.8 6250.0 6298.3 6303.4 6313.2 6330.6 5385.9 5406.9 5464.9 5466.8 5607.2 23626.9 27944.2 28021.7 28118.9 28443.0 2119.4 2187.8 2189.6 2190.6 2194.3 17534.6 17599.7 17624.3 17995.9 18109.3 2078.0 2138.7 2151.6 2165.2 2171.3 129292.0 164838.4 165271.0 166337.0 167005.2 12192.0 12445.9 12524.7 12583.3 12818.3 16165.8 16330.3 16381.5 16384.3 16398.7 7765.9 8700.3 9070.5 9098.5 9347.4 8739.8 8761.5 8769.7 8874.4 8887.9 6264.0 7831.9 7874.6 7883.4 7930.6 1828.3 2153.1 2175.8 2182.0 2335.8 933.6 936.2 945.5 973.2 981.2 19253.7 20473.4 20504.9 20632.9 20878.2 969.3 971.2 1003.8 1004.0 1011.9 10321.4 10748.3 10805.5 10811.0 10833.6 676668.0 687177.0 696468.0 707988.0 718968.0 146671.0 147555.0 155848.0 159674.0 161245.1 1202.3 1205.4 1247.6 1253.6 1253.8 21167.6 21208.8 21328.7 21588.1 21588.8 53329.0 59567.4 62847.7 65603.7 66352.0 84908.0 90769.5 91450.5 91513.7 91653.0 8728.0 8744.3 8791.7 8826.7 9027.3 13713.9 13732.0 13939.5 14072.4 14079.6 11148.1 11859.8 11909.7 11957.4 12035.5 9365.3 10350.6 10972.2 11176.9 11264.9 11818.9 11847.3 12062.5 12126.8 12156.7 9036.0 12191.2 12564.0 12847.7 13147.7 10113.0 11671.9 11819.5 12180.5 12239.6 13:34:44 INFO - PID 1636 | 13:34:44 INFO - PID 1636 | [#3] mootools.html Cycles:180 Average:6837.53 Median:2479.23 stddev:4202.73 (169.5%) stddev-sans-first:4194.26 13:34:44 INFO - PID 1636 | Values: 1346.3 1411.5 1414.3 1426.1 1438.7 9029.7 10752.7 11229.6 11235.6 11371.3 11100.0 11175.9 11314.5 11317.7 11319.6 2121.0 2448.0 2451.7 2483.8 2487.7 2372.9 2447.5 2451.0 2470.3 2474.7 2367.8 2448.5 2448.8 2449.5 2460.6 2336.8 2390.4 2400.9 2405.2 2435.6 2337.2 2412.9 2417.5 2434.1 2453.5 10983.5 11061.3 11063.6 11066.1 11080.7 5815.2 6264.2 6446.5 6479.3 6507.0 3289.1 3398.9 3749.4 3976.2 4086.2 1213.9 1223.9 1248.8 1262.8 1263.7 14082.3 14555.2 15304.5 15408.0 15435.6 5272.3 5352.2 5559.9 5560.8 5571.6 11385.5 11597.9 11600.4 11611.9 11635.7 6283.5 6360.6 6362.4 6365.8 6374.0 5793.4 5963.1 6015.3 6071.8 6095.6 4214.4 4289.2 4326.6 4344.7 4397.8 1258.6 1275.7 1276.9 1293.6 1300.1 745.5 754.3 775.7 778.9 811.8 6607.0 6878.2 7040.8 7064.4 7090.2 884.1 885.2 900.4 900.7 907.9 3995.8 4056.2 4233.5 4261.8 4356.1 12853.9 14097.0 14164.7 14385.4 14386.6 10998.2 13394.8 13947.6 14338.9 14516.6 10332.8 10421.0 10425.6 10493.5 10523.5 6037.8 6071.0 6671.8 6827.1 6949.4 12050.2 12141.5 12284.1 12450.4 12991.4 12986.5 13025.4 13047.8 13082.8 13098.5 8237.2 8457.3 8468.3 8480.3 8497.5 9900.3 10190.9 10268.8 10326.5 10340.4 8670.6 8703.2 8704.0 8759.9 8938.2 8510.6 8558.9 8564.9 8660.4 8705.5 7791.6 7882.7 7949.9 7961.2 7968.3 5836.3 5857.9 5947.5 6050.1 6074.4 5859.4 5915.6 6082.8 6104.5 6237.0 13:34:44 INFO - PID 1636 | 13:34:44 INFO - PID 1636 | [#4] prototype.html Cycles:180 Average:5187.38 Median:5771.93 stddev:1633.33 (28.3%) stddev-sans-first:1596.84 13:34:44 INFO - PID 1636 | Values: 338.0 352.9 385.7 408.8 410.4 4520.4 5154.8 6032.2 6071.5 6250.5 5137.5 5525.9 5580.1 5843.6 6119.1 4513.2 4516.8 4523.3 4526.5 4533.3 4271.8 4373.3 4544.2 4548.2 4549.2 4451.9 4454.3 4466.3 4494.1 4515.0 4492.3 4496.7 4512.7 4516.7 4517.0 3322.9 3522.3 3613.7 3674.9 3920.4 4952.5 5992.9 5994.9 6001.6 6003.2 4692.6 5373.2 5398.0 5406.6 5427.8 6179.0 6503.7 6523.0 6598.3 6640.5 4388.3 4392.0 4396.1 4409.0 4431.9 5799.8 5969.9 5981.6 6779.0 6864.2 3722.7 4237.6 4423.6 4455.8 4463.7 3828.5 4531.3 4546.0 4566.4 4570.2 4462.8 4868.9 5170.1 5369.3 5380.8 5509.1 6557.9 6593.4 6618.3 6638.7 1239.7 1306.4 1438.8 1536.0 1562.8 966.4 1016.9 1022.8 1030.1 1033.5 5462.4 5888.9 6125.6 6148.4 6157.2 6048.3 6213.7 6776.4 6796.9 6807.7 5462.6 5701.9 5740.7 6014.5 6057.0 3328.3 3560.6 3576.2 3580.5 3581.6 6108.2 6416.1 6814.2 6937.2 6993.9 6940.7 6943.9 7017.2 7018.2 7029.2 5898.4 6647.0 6998.1 7028.3 7107.9 6525.4 6579.5 6768.5 6781.3 6884.1 5653.4 6070.8 6631.8 6743.7 6770.3 5161.0 5914.9 6670.7 6762.9 7053.4 4056.4 4103.9 4120.6 4154.4 4480.6 6394.8 6413.0 6467.5 6484.3 6762.6 4801.8 5842.6 5891.1 6033.7 6511.3 5776.0 6228.8 6456.4 6520.8 6566.1 5625.7 6069.7 6209.9 6337.2 6398.8 4998.7 6053.6 6490.9 6540.9 6579.2 5767.9 5787.9 6335.6 6346.7 6449.8 13:34:44 INFO - PID 1636 | 13:34:44 INFO - PID 1636 | [#5] yui.html Cycles:180 Average:20646.54 Median:17364.98 stddev:29654.64 (170.8%) stddev-sans-first:29700.28 13:34:44 INFO - PID 1636 | Values: 772.4 807.9 826.4 842.4 848.0 15803.8 16345.5 17355.1 18453.0 18580.6 17004.7 17314.7 17374.8 17379.2 17753.6 1002.1 1035.4 1036.0 1037.8 1041.3 990.4 1021.9 1028.4 1035.0 1038.6 1086.0 1089.1 1089.6 1092.5 1095.4 1080.7 1082.9 1083.8 1084.9 1086.8 792.1 812.0 813.5 814.3 814.8 16282.7 16330.8 16482.2 16865.2 17018.7 14617.3 14798.6 14863.5 14881.6 15485.6 12994.7 13418.1 13497.0 13532.3 13581.1 3224.8 3242.2 3270.2 3275.1 3279.9 111913.4 112809.4 113663.0 114591.4 115864.4 11419.6 11629.3 11647.2 11760.7 12030.8 24772.6 24815.5 24919.1 25150.9 25334.2 7777.1 7905.2 8052.8 8086.8 8115.1 3726.3 4079.2 4191.2 4235.8 4329.5 4141.8 4213.6 4215.9 4241.8 4250.5 645.9 780.9 787.5 796.2 796.2 603.1 623.2 636.1 647.5 648.4 8201.5 9824.8 9969.4 10157.6 10232.6 587.5 602.1 623.8 638.1 652.5 4645.9 4649.7 4679.6 4681.3 4700.3 102327.0 102698.5 103171.5 105628.0 106003.0 74222.0 92614.6 93023.5 94705.5 95997.5 73679.0 83176.6 83865.0 84565.6 85869.6 9841.9 10912.5 11165.9 11169.3 11304.0 40615.0 41252.0 41822.8 42063.8 42179.6 52709.5 52766.7 53052.2 53138.5 53255.0 13423.5 13789.2 13888.0 14048.4 14362.2 14505.7 14526.8 14547.7 14592.4 15347.9 13657.1 13808.4 13968.9 14310.9 14557.8 13231.3 13769.9 13785.4 13823.2 13962.2 13320.2 13422.9 13429.8 13665.2 13942.9 9003.4 10064.3 10156.2 10427.0 10690.6 7734.9 9473.7 9571.0 10302.5 11185.2 13:34:44 INFO - PID 1636 | -------- Summary: end -------- 13:34:44 INFO - PID 1636 | 13:34:44 INFO - TEST-INFO | 1636: exit 0 13:34:44 INFO - TEST-OK | dromaeo_css | took 1116316ms 13:34:44 INFO - TEST-START | kraken 13:34:44 INFO - operating with platform_type : mac_ 13:34:44 INFO - Initialising browser for kraken test... 13:34:44 INFO - TEST-INFO | started process 1649 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/tmpw_Cd5E/profile http://localhost:49241/getInfo.html) 13:34:47 INFO - PID 1649 | 2017-04-04 13:34:47.074 plugin-container[1650:10083] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x873f, name = 'com.apple.tsm.portname' 13:34:47 INFO - PID 1649 | See /usr/include/servers/bootstrap_defs.h for the error codes. 13:34:47 INFO - PID 1649 | 2017-04-04 13:34:47.077 plugin-container[1650:10083] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8d0b, name = 'com.apple.CFPasteboardClient' 13:34:47 INFO - PID 1649 | See /usr/include/servers/bootstrap_defs.h for the error codes. 13:34:47 INFO - PID 1649 | 2017-04-04 13:34:47.077 plugin-container[1650:10083] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 13:34:47 INFO - PID 1649 | __metrics Screen width/height:1600/1200 13:34:47 INFO - PID 1649 | colorDepth:24 13:34:47 INFO - PID 1649 | Browser inner width/height: 1024/689 13:34:47 INFO - PID 1649 | __metrics 13:34:47 ERROR - PID 1649 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3355: TypeError: this.tabs is undefined 13:34:48 INFO - TEST-INFO | 1649: exit 0 13:34:48 INFO - Browser initialized. 13:34:48 INFO - Running cycle 1/1 for kraken test... 13:34:48 INFO - TEST-INFO | started process 1651 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/tmpw_Cd5E/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:34:51 INFO - PID 1651 | 2017-04-04 13:34:51.011 plugin-container[1652:10199] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x454f, name = 'com.apple.tsm.portname' 13:34:51 INFO - PID 1651 | See /usr/include/servers/bootstrap_defs.h for the error codes. 13:34:51 INFO - PID 1651 | 2017-04-04 13:34:51.011 plugin-container[1652:10199] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8e0b, name = 'com.apple.CFPasteboardClient' 13:34:51 INFO - PID 1651 | See /usr/include/servers/bootstrap_defs.h for the error codes. 13:34:51 INFO - PID 1651 | 2017-04-04 13:34:51.011 plugin-container[1652:10199] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 13:35:00 INFO - PID 1651 | RSS: Main: 244826112 13:35:00 INFO - PID 1651 | 13:35:03 INFO - PID 1651 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-beat-detection) 13:35:04 INFO - PID 1651 | RSS: Main: 254783488 13:35:04 INFO - PID 1651 | 13:35:07 INFO - PID 1651 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-dft) 13:35:08 INFO - PID 1651 | RSS: Main: 262094848 13:35:08 INFO - PID 1651 | 13:35:11 INFO - PID 1651 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-fft) 13:35:12 INFO - PID 1651 | RSS: Main: 257961984 13:35:12 INFO - PID 1651 | 13:35:14 INFO - PID 1651 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-oscillator) 13:35:15 INFO - PID 1651 | RSS: Main: 259796992 13:35:15 INFO - PID 1651 | 13:35:16 INFO - PID 1651 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-gaussian-blur) 13:35:17 INFO - PID 1651 | RSS: Main: 260411392 13:35:17 INFO - PID 1651 | 13:35:20 INFO - PID 1651 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-darkroom) 13:35:21 INFO - PID 1651 | RSS: Main: 265949184 13:35:21 INFO - PID 1651 | 13:35:24 INFO - PID 1651 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-desaturate) 13:35:25 INFO - PID 1651 | RSS: Main: 265887744 13:35:25 INFO - PID 1651 | 13:35:28 INFO - PID 1651 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49241/tests/kraken/driver.html?testName=json-parse-financial) 13:35:29 INFO - PID 1651 | RSS: Main: 265445376 13:35:29 INFO - PID 1651 | 13:35:30 INFO - PID 1651 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49241/tests/kraken/driver.html?testName=json-stringify-tinderbox) 13:35:31 INFO - PID 1651 | RSS: Main: 265445376 13:35:31 INFO - PID 1651 | 13:35:33 INFO - PID 1651 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-aes) 13:35:34 INFO - PID 1651 | RSS: Main: 265396224 13:35:34 INFO - PID 1651 | 13:35:36 INFO - PID 1651 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-ccm) 13:35:37 INFO - PID 1651 | RSS: Main: 265445376 13:35:37 INFO - PID 1651 | 13:35:40 INFO - PID 1651 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 13:35:40 INFO - PID 1651 | RSS: Main: 266063872 13:35:40 INFO - PID 1651 | 13:35:44 INFO - PID 1651 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 13:35:44 INFO - PID 1651 | RSS: Main: 263081984 13:35:44 INFO - PID 1651 | 13:35:46 INFO - PID 1651 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49241/tests/kraken/driver.html?testName=ai-astar) 13:35:47 INFO - PID 1651 | RSS: Main: 266371072 13:35:47 INFO - PID 1651 | 13:35:47 INFO - PID 1651 | __start_tp_report 13:35:47 INFO - PID 1651 | _x_x_mozilla_page_load 13:35:47 INFO - PID 1651 | _x_x_mozilla_page_load_details 13:35:47 INFO - PID 1651 | |i|pagename|runs| 13:35:47 INFO - PID 1651 | |0;ai-astar;111;177;184;138;142;186;162;124;107;183 13:35:47 INFO - PID 1651 | |1;audio-beat-detection;148;118;121;151;168;156;111;155;177;117 13:35:47 INFO - PID 1651 | |2;audio-dft;225;230;231;233;214;213;213;210;217;212 13:35:47 INFO - PID 1651 | |3;audio-fft;81;59;59;91;63;63;62;60;75;61 13:35:47 INFO - PID 1651 | |4;audio-oscillator;89;71;89;74;71;73;85;71;72;85 13:35:47 INFO - PID 1651 | |5;imaging-gaussian-blur;91;92;111;138;94;99;92;93;110;90 13:35:47 INFO - PID 1651 | |6;imaging-darkroom;101;99;101;107;163;148;100;102;123;160 13:35:47 INFO - PID 1651 | |7;imaging-desaturate;103;101;101;103;108;151;111;85;93;149 13:35:47 INFO - PID 1651 | |8;json-parse-financial;52;53;55;54;44;44;61;84;78;82 13:35:47 INFO - PID 1651 | |9;json-stringify-tinderbox;68;89;98;63;67;66;61;60;59;65 13:35:47 INFO - PID 1651 | |10;stanford-crypto-aes;78;115;113;77;104;113;113;86;95;116 13:35:47 INFO - PID 1651 | |11;stanford-crypto-ccm;148;147;164;166;156;147;169;150;198;180 13:35:47 INFO - PID 1651 | |12;stanford-crypto-pbkdf2;256;203;235;206;243;241;194;193;195;224 13:35:47 INFO - PID 1651 | |13;stanford-crypto-sha256-iterative;71;76;77;71;72;72;69;70;69;73 13:35:47 INFO - PID 1651 | __end_tp_report 13:35:47 INFO - PID 1651 | __start_cc_report 13:35:47 INFO - PID 1651 | _x_x_mozilla_cycle_collect,1021 13:35:47 INFO - PID 1651 | __end_cc_report 13:35:47 INFO - PID 1651 | __startTimestamp1491338147001__endTimestamp 13:35:47 INFO - PID 1651 | 13:35:47 INFO - PID 1651 | ------- Summary: start ------- 13:35:47 INFO - PID 1651 | Number of tests: 14 13:35:47 INFO - PID 1651 | 13:35:47 INFO - PID 1651 | [#0] ai-astar Cycles:10 Average:151.40 Median:169.50 stddev:31.00 (18.3%) stddev-sans-first:29.23 13:35:47 INFO - PID 1651 | Values: 111.0 177.0 184.0 138.0 142.0 186.0 162.0 124.0 107.0 183.0 13:35:47 INFO - PID 1651 | 13:35:47 INFO - PID 1651 | [#1] audio-beat-detection Cycles:10 Average:142.20 Median:153.00 stddev:23.54 (15.4%) stddev-sans-first:24.87 13:35:47 INFO - PID 1651 | Values: 148.0 118.0 121.0 151.0 168.0 156.0 111.0 155.0 177.0 117.0 13:35:47 INFO - PID 1651 | 13:35:47 INFO - PID 1651 | [#2] audio-dft Cycles:10 Average:219.80 Median:221.00 stddev:8.95 (4.1%) stddev-sans-first:9.30 13:35:47 INFO - PID 1651 | Values: 225.0 230.0 231.0 233.0 214.0 213.0 213.0 210.0 217.0 212.0 13:35:47 INFO - PID 1651 | 13:35:47 INFO - PID 1651 | [#3] audio-fft Cycles:10 Average:67.40 Median:63.00 stddev:11.08 (17.6%) stddev-sans-first:10.60 13:35:47 INFO - PID 1651 | Values: 81.0 59.0 59.0 91.0 63.0 63.0 62.0 60.0 75.0 61.0 13:35:47 INFO - PID 1651 | 13:35:47 INFO - PID 1651 | [#4] audio-oscillator Cycles:10 Average:78.00 Median:79.50 stddev:7.92 (10.0%) stddev-sans-first:7.33 13:35:47 INFO - PID 1651 | Values: 89.0 71.0 89.0 74.0 71.0 73.0 85.0 71.0 72.0 85.0 13:35:47 INFO - PID 1651 | 13:35:47 INFO - PID 1651 | [#5] imaging-gaussian-blur Cycles:10 Average:101.00 Median:92.00 stddev:15.09 (16.4%) stddev-sans-first:15.57 13:35:47 INFO - PID 1651 | Values: 91.0 92.0 111.0 138.0 94.0 99.0 92.0 93.0 110.0 90.0 13:35:47 INFO - PID 1651 | 13:35:47 INFO - PID 1651 | [#6] imaging-darkroom Cycles:10 Average:120.40 Median:135.50 stddev:26.45 (19.5%) stddev-sans-first:27.11 13:35:47 INFO - PID 1651 | Values: 101.0 99.0 101.0 107.0 163.0 148.0 100.0 102.0 123.0 160.0 13:35:47 INFO - PID 1651 | 13:35:47 INFO - PID 1651 | [#7] imaging-desaturate Cycles:10 Average:110.50 Median:130.00 stddev:22.06 (17.0%) stddev-sans-first:23.23 13:35:47 INFO - PID 1651 | Values: 103.0 101.0 101.0 103.0 108.0 151.0 111.0 85.0 93.0 149.0 13:35:47 INFO - PID 1651 | 13:35:47 INFO - PID 1651 | [#8] json-parse-financial Cycles:10 Average:60.70 Median:58.00 stddev:15.15 (26.1%) stddev-sans-first:15.74 13:35:47 INFO - PID 1651 | Values: 52.0 53.0 55.0 54.0 44.0 44.0 61.0 84.0 78.0 82.0 13:35:47 INFO - PID 1651 | 13:35:47 INFO - PID 1651 | [#9] json-stringify-tinderbox Cycles:10 Average:69.60 Median:66.50 stddev:13.12 (19.7%) stddev-sans-first:13.90 13:35:47 INFO - PID 1651 | Values: 68.0 89.0 98.0 63.0 67.0 66.0 61.0 60.0 59.0 65.0 13:35:47 INFO - PID 1651 | 13:35:47 INFO - PID 1651 | [#10] stanford-crypto-aes Cycles:10 Average:101.00 Median:96.50 stddev:15.73 (16.3%) stddev-sans-first:14.32 13:35:47 INFO - PID 1651 | Values: 78.0 115.0 113.0 77.0 104.0 113.0 113.0 86.0 95.0 116.0 13:35:47 INFO - PID 1651 | 13:35:47 INFO - PID 1651 | [#11] stanford-crypto-ccm Cycles:10 Average:162.50 Median:165.00 stddev:16.71 (10.1%) stddev-sans-first:16.88 13:35:47 INFO - PID 1651 | Values: 148.0 147.0 164.0 166.0 156.0 147.0 169.0 150.0 198.0 180.0 13:35:47 INFO - PID 1651 | 13:35:47 INFO - PID 1651 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:219.00 Median:229.50 stddev:23.60 (10.3%) stddev-sans-first:20.89 13:35:47 INFO - PID 1651 | Values: 256.0 203.0 235.0 206.0 243.0 241.0 194.0 193.0 195.0 224.0 13:35:47 INFO - PID 1651 | 13:35:47 INFO - PID 1651 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:72.00 Median:72.00 stddev:2.71 (3.8%) stddev-sans-first:2.85 13:35:47 INFO - PID 1651 | Values: 71.0 76.0 77.0 71.0 72.0 72.0 69.0 70.0 69.0 73.0 13:35:47 INFO - PID 1651 | -------- Summary: end -------- 13:35:47 INFO - PID 1651 | 13:35:47 INFO - TEST-INFO | 1651: exit 0 13:35:47 INFO - TEST-OK | kraken | took 63275ms 13:35:47 INFO - SUITE-END | took 1179s 13:35:48 INFO - Completed test suite (00:19:39) 13:35:48 INFO - javascript benchmark 13:35:48 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7798.9267185098215, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3541.433370660695, 3578.2843431313736, 3597.80212088335, 3612.3317186320533, 3617.1861331200485, 6077.0884367344925, 6220.222472190976, 6220.440160385564, 6235.812925612227, 6264.874702505947, 4969.900601987958, 6149.046897730847, 6179.351168127349, 6231.0, 6258.186435763344, 5424.186372044185, 5446.972765136179, 5450.645708028966, 5460.426655201206, 5539.25220095288, 5339.359276886759, 5404.6486978346475, 5487.6433031853, 5490.176473528963, 5511.118221084627, 5327.987682340343, 5387.0841956867425, 5421.21392398104, 5421.484958928935, 5454.699991500466, 5431.348238211401, 5435.211894275348, 5462.0987537056335, 5486.286782718221, 5502.9174562381595, 5380.677159370412, 5404.189371594253, 5404.729763511808, 5411.269478620415, 5481.588880833913, 4910.091633047898, 5940.881182376328, 5972.283326000907, 6072.453479186895, 6116.0, 6427.8393040173905, 6485.902711459332, 6576.5067619928695, 6577.375149360803, 6595.340465953414, 6754.9662251688915, 6777.695003724844, 6784.1858976922595, 6788.1175447192045, 6802.4217941475035, 5244.842654720326, 6338.429541341301, 6367.936320636827, 6380.968095159541, 6399.744010239631, 6218.9427797274575, 6289.371062893674, 6395.488360931115, 6584.0, 6828.487863410264, 6251.374862513712, 6359.872802543923, 6362.268339141058, 6492.480601551864, 6618.53670243088, 5371.4897084776885, 6372.171617689671, 6504.447121994589, 6714.429273511806, 6724.226713927961, 6619.66901654925, 6646.015488383712, 6651.935690289627, 6653.534252602271, 6655.500837437212, 6334.144890439732, 6353.0, 6479.935200648028, 6663.633500157538, 6682.365175308338, 5281.524662780368, 5300.734963251822, 5307.920381194285, 5313.521783039545, 5359.544438722753, 4695.671303008825, 4721.504242054535, 4726.527347265246, 4729.858104256878, 4761.500042495557, 6115.666295175888, 6139.0, 6285.497160227171, 6297.275813281532, 6330.746770129143, 5411.053065713563, 5756.913646295309, 5890.705464726832, 6617.503687223478, 6678.599284042876, 5294.894102117936, 6173.012318029184, 6368.522360822957, 6374.521910856704, 6378.776742814072, 5704.71476426177, 5883.94116058834, 5917.467427931507, 5930.466258036798, 5935.881282374328, 6591.307912669101, 6793.932060679527, 6871.690773915086, 6905.343992320722, 6906.585604863724, 6732.057511948429, 6737.225219099866, 6748.662566871735, 6753.15585551806, 6753.594784312761, 6819.863602728017, 6889.311068893071, 6916.93083069183, 6922.238553758982, 6951.16586009682, 6319.399657032574, 6431.967840160769, 6560.540762146795, 6584.8353791155605, 6628.701708423229, 6601.943689009735, 6695.966520167368, 6712.39588437043, 6731.495137864582, 6755.05429239897, 6216.72024758896, 6347.39699728525, 6421.068945002855, 6439.774607888889, 6479.157709497735, 6375.936240637534, 6441.291457939717, 6451.516136289703, 6468.5472016958365, 6478.611283323015, 5226.660267082628, 5559.138333558305, 6346.682665866781, 6354.23749150105, 6378.90431643535, 5147.6911385317, 6401.327860574573, 6416.935830641821, 6427.614343139427, 6457.0, 6240.594361366497, 6278.340774218641, 6298.937010630018, 6329.1139240505445, 6336.524760643062], "value": 6012.023175438715, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [610.1732152932776, 810.0886502684479, 835.4861760017591, 1269.2447993443898, 1269.2574843716425, 38569.61430385695, 39671.60328396715, 39697.0, 39758.60241397585, 39780.80109599452, 34939.301213975705, 36434.27131457376, 38839.80580097103, 39104.80447597765, 39204.803975980154, 6681.398674119316, 7097.787066388017, 8120.1879812018915, 8482.448640838356, 8725.171108744691, 8597.054324024351, 8632.956835215815, 8721.781955451133, 8728.039915609277, 8755.649774009033, 7799.337056350217, 8651.783705407352, 8660.307175425982, 8733.95633021834, 8738.169873862005, 8673.219410253076, 8699.0, 8719.084496127878, 8732.257758090569, 8739.825203495959, 8562.70030548934, 8568.871466928002, 8608.569571521399, 8618.525981071038, 8619.051904290523, 38306.0, 38469.42295865564, 38525.42211866824, 38546.80726596377, 38608.61391386078, 3447.5690538682666, 3449.1721986723255, 3474.5656792900886, 3483.7909725416557, 3486.163320802989, 28204.01285955002, 30096.0, 30244.69755302441, 30439.543406848916, 30451.543226851616, 2895.102518219359, 3113.470709979309, 3141.7172454479205, 3170.0, 3176.332970076264, 318579.2213116805, 320079.5944283901, 330664.3466782651, 337385.0, 338561.0, 52574.0, 52978.0, 52990.0, 53097.734511327195, 53284.46715532795, 54845.45154548483, 55230.0, 55656.0, 55754.0, 55849.720751396795, 14470.421183152766, 14552.41790328375, 14707.558773236606, 14720.558383248519, 14722.263886805616, 11892.989095926943, 11893.70265743346, 11915.2255103418, 11924.224925379822, 11928.821067683992, 14037.649058773408, 14102.85897141036, 14155.0, 14225.933055020914, 14249.073810202304, 5580.0, 6019.729112189962, 6078.3617720138745, 6097.451229389376, 6115.143879856823, 816.4285000499674, 963.8987906269881, 975.11264749078, 997.8453339732353, 1016.5781200801732, 19469.0, 23733.643995340084, 24363.0, 24557.754422455546, 24626.0, 1079.3685693869018, 1086.1365214654368, 1099.7910397024539, 1118.6532175025768, 1123.1969142063301, 10882.727931801768, 11986.88013119875, 12632.115751897463, 12678.936605316914, 12711.173773704679, 358729.0, 457387.27838164906, 458205.0, 459530.0, 459786.0, 55423.168652470245, 55927.440725593035, 56138.7193064032, 56165.87668246612, 56282.0, 1449.8332691740375, 1490.5975386645546, 1517.833038365779, 1519.7948276982465, 1526.1301058396607, 24045.398865028514, 26802.865985669945, 28860.711392886642, 29734.55398168986, 29816.552751709176, 54344.19590628618, 54398.45601543934, 54525.454745452036, 54634.45365546294, 54883.72558137184, 355018.2249088738, 436288.0, 445308.0, 448950.0, 450811.7459412682, 34909.127271818405, 35483.64516354803, 35624.0, 35694.82152589221, 35701.28597428089, 42852.0, 43184.0, 43361.13277734364, 44453.33320000267, 44507.55492445034, 25922.761363693688, 27856.44287114287, 30339.848300758356, 30587.388252235276, 30598.541021884244, 28486.85756571204, 29545.0, 30253.697463025088, 30344.78620855141, 30717.23206919845, 35980.640193598774, 36215.456768147975, 36486.817565912, 36567.26865462623, 36781.89654310375, 22787.88606056959, 29356.266093347836, 29556.261093471974, 30438.695613043586, 30512.0, 20105.793652380904, 20697.586048279252, 21609.0, 23076.307710768702, 24748.257552273462], "value": 18223.421613032904, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [418.26385561411945, 423.66318776572626, 435.27465830939326, 435.41654183394246, 453.1661742393994, 19839.20643174275, 21288.57422851544, 21954.0, 21999.670004949938, 22218.00018999145, 21895.0, 22135.778642213612, 22146.778532214674, 22550.43623909403, 23310.06759729613, 6038.69806509675, 6222.004479283316, 6226.470749986257, 6230.626162430269, 6233.71948262327, 5868.9413105868825, 6119.571629985903, 6160.260768707762, 6165.599236049642, 6175.135481032659, 5940.554458415614, 6025.642946691239, 6096.0, 6121.540884433663, 6126.7549298028025, 6250.0, 6298.275698294663, 6303.401176888234, 6313.242410910697, 6330.588511746721, 5385.892282154374, 5406.945930540684, 5464.9180262296095, 5466.808661696821, 5607.158926161068, 23626.881865590563, 27944.16167514978, 28021.719782802116, 28118.859405703046, 28443.0, 2119.448943274744, 2187.8359123065834, 2189.5949249388755, 2190.6166420876284, 2194.264921251383, 17534.561635959075, 17599.73600395995, 17624.295028198856, 17995.910020449945, 18109.275628974825, 2077.981788923432, 2138.700581918533, 2151.5911976724374, 2165.2421652421526, 2171.3051823416513, 129292.0, 164838.3516164835, 165271.0, 166337.0, 167005.16497417435, 12192.0, 12445.937770311271, 12524.74950500985, 12583.307918064595, 12818.294993775431, 16165.838341616432, 16330.265138068815, 16381.508554743377, 16384.344626214817, 16398.67202655964, 7765.883511747328, 8700.34747393948, 9070.455772653662, 9098.499582522893, 9347.392419492711, 8739.825203495895, 8761.474311541328, 8769.736907892773, 8874.423162494417, 8887.911120888837, 6263.96868015657, 7831.864379664917, 7874.645640946172, 7883.448158628956, 7930.5638189898955, 1828.3052440072688, 2153.1491789384154, 2175.7715439878903, 2181.9890900545397, 2335.8014568761505, 933.6452148183647, 936.1901954809041, 945.5130607737021, 973.2019743810008, 981.2346369831542, 19253.711194332096, 20473.385798425774, 20504.897475512826, 20632.896835516025, 20878.164873404894, 969.3021024862088, 971.1987610221596, 1003.8092762375126, 1003.964861229868, 1011.9038691324313, 10321.432321222404, 10748.301360411548, 10805.513751881026, 10811.0, 10833.620823271147, 676668.0, 687177.0, 696468.0, 707988.0, 718968.0, 146671.0, 147555.0, 155848.0, 159674.0, 161245.0692677252, 1202.3026644546142, 1205.3671822293365, 1247.5508816825936, 1253.6489782860813, 1253.7805883970452, 21167.576648467253, 21208.787912121297, 21328.680069799277, 21588.136474541472, 21588.78411215868, 53329.0, 59567.40432595619, 62847.6857615709, 65603.67198163978, 66352.0, 84908.0, 90769.54615226881, 91450.54274728584, 91513.7121571966, 91653.0, 8727.956360218412, 8744.300455963636, 8791.692070885349, 8826.735197944072, 9027.32295077885, 13713.862861371259, 13732.038757286895, 13939.493082303632, 14072.437102515785, 14079.648008799863, 11148.108151348035, 11859.789774630228, 11909.702257443632, 11957.402129893644, 12035.518579256732, 9365.297602679962, 10350.585976561155, 10972.23194376418, 11176.888231117584, 11264.887351126385, 11818.881811181778, 11847.289162649924, 12062.51749929993, 12126.818097728365, 12156.696082598006, 9035.954820225857, 12191.171324301426, 12564.0, 12847.678808029874, 13147.671308217372, 10113.039261270167, 11671.941640291745, 11819.468123934272, 12180.467664377586, 12239.632811015328], "value": 10726.39901058214, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1346.2797403389186, 1411.4848080450638, 1414.3069895751084, 1426.0516756357024, 1438.7266419380317, 9029.683961061364, 10752.677419677413, 11229.550817967282, 11235.550577976881, 11371.260868043571, 11100.0, 11175.944120279408, 11314.490847911844, 11317.660470185887, 11319.603813866517, 2120.968185477219, 2448.0, 2451.7303096659352, 2483.75162483752, 2487.7139129000125, 2372.8694921779297, 2447.4615584571366, 2451.0, 2470.308313672175, 2474.7030356357172, 2367.8342516023886, 2448.51029794041, 2448.8163387745903, 2449.510097980411, 2460.6063029915217, 2336.8481048731946, 2390.426297688551, 2400.919586186223, 2405.1822380390663, 2435.622478515833, 2337.1819863047967, 2412.9034838606435, 2417.528581926525, 2434.0993832281993, 2453.4970331082263, 10983.450827458595, 11061.336319820837, 11063.612773552886, 11066.114710823196, 11080.722981925517, 5815.21494598228, 6264.185655864709, 6446.484281257488, 6479.254885688159, 6506.967465162691, 3289.111939776247, 3398.898033059012, 3749.381352076904, 3976.224636195943, 4086.162336720965, 1213.9393030348447, 1223.8837310455492, 1248.7814632439288, 1262.7790136726128, 1263.7219811641517, 14082.295885205698, 14555.19946402958, 15304.464343747915, 15407.998480098759, 15435.614109647237, 5272.261883336336, 5352.223927530486, 5559.916601250984, 5560.805371811967, 5571.554275657938, 11385.487653055632, 11597.88402115968, 11600.361980091177, 11611.90985622596, 11635.650930472098, 6283.465905398001, 6360.554761166674, 6362.363763623694, 6365.777197798055, 6374.0, 5793.420657934173, 5963.075723262901, 6015.3383127855905, 6071.848203794852, 6095.573309868355, 4214.431051808028, 4289.1850548395705, 4326.58897404746, 4344.674149438742, 4397.834573837871, 1258.6098309524077, 1275.661949583361, 1276.9170003949714, 1293.6183825771232, 1300.0964329790704, 745.4781652843031, 754.3437209627659, 775.7440044785208, 778.8792737125755, 811.7686459359172, 6606.966965165144, 6878.243393226741, 7040.823979400454, 7064.364207221375, 7090.184628767758, 884.0673089890228, 885.2386947225381, 900.4102312984875, 900.7072701372081, 907.9182873541413, 3995.780232087263, 4056.229316429869, 4233.534311225762, 4261.786910654517, 4356.128774245164, 12853.871461285267, 14097.0, 14164.716705665829, 14385.352659130363, 14386.568402947929, 10998.175136864607, 13394.799078013837, 13947.58157255284, 14338.928305358406, 14516.637084072983, 10332.793344133075, 10421.0, 10425.582976681, 10493.47532623381, 10523.473826308807, 6037.75848966054, 6070.969645151746, 6671.799846004627, 6827.146606674166, 6949.3745562899585, 12050.216735912489, 12141.514339426323, 12284.1401101922, 12450.439730211981, 12991.35043247815, 12986.480540778262, 13025.413856376676, 13047.804282935575, 13082.80375794383, 13098.541551045668, 8237.176282371714, 8457.281131103926, 8468.322534197372, 8480.279176270085, 8497.490150590984, 9900.306978511435, 10190.929952354896, 10268.845967310346, 10326.48367581633, 10340.37957722539, 8670.566471676517, 8703.216710496086, 8703.955525337, 8759.91240087591, 8938.195562399154, 8510.574471276535, 8558.871616925875, 8564.914350856412, 8660.35047371437, 8705.47767133974, 7791.61041947889, 7882.7241046563095, 7949.920500794918, 7961.16407777175, 7968.282854543119, 5836.270466191726, 5857.853553661193, 5947.464728174485, 6050.062240352752, 6074.36219196978, 5859.355470898283, 5915.645061296336, 6082.817515474543, 6104.4505994460715, 6237.033259844731], "value": 5218.945880307501, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [337.9831008449578, 352.937657650472, 385.652912378859, 408.82011914757516, 410.3536929336294, 4520.367148599199, 5154.768035438405, 6032.215811944447, 6071.483923866476, 6250.468710159631, 5137.537621614054, 5525.861853453665, 5580.107182850745, 5843.590948633598, 6119.143319935201, 4513.2101882170655, 4516.819327226907, 4523.253663145577, 4526.524714904937, 4533.297338912474, 4271.807768650418, 4373.300271956487, 4544.182047231497, 4548.204064288753, 4549.181147393468, 4451.910961780763, 4454.265046267362, 4466.307722303032, 4494.1461122386645, 4514.954850451502, 4492.326151077332, 4496.707713998596, 4512.706674066175, 4516.661250406232, 4516.954830451687, 3322.8670853165845, 3522.277933023724, 3613.6567026132475, 3674.9053039767346, 3920.4315374270855, 4952.455229924705, 5992.910106348409, 5994.8501287467725, 6001.649628833521, 6003.247970018739, 4692.554207350297, 5373.167159090347, 5398.0, 5406.567474602022, 5427.755750991176, 6178.9691051544905, 6503.739850405978, 6523.0, 6598.340165983412, 6640.468762498988, 4388.275934470808, 4391.989842336248, 4396.054848207618, 4409.0, 4431.91699901046, 5799.768009279624, 5969.910451343233, 5981.641101533922, 6778.966719619493, 6864.2106157791495, 3722.7207959402613, 4237.618614324726, 4423.646108311327, 4455.799489023002, 4463.66522510813, 3828.5405751310022, 4531.252343363374, 4546.0, 4566.360709500673, 4570.177368073712, 4462.821487140478, 4868.902621947541, 5170.1469257572835, 5369.328833895763, 5380.757865896044, 5509.118541033416, 6557.868842623121, 6593.406593406617, 6618.30507796684, 6638.701258443381, 1239.7292774905793, 1306.399056434051, 1438.762604170321, 1536.0399750156153, 1562.796836411282, 966.367029595616, 1016.9288149829589, 1022.8261195596766, 1030.1192480429124, 1033.49358814182, 5462.399136095027, 5888.852778680567, 6125.632462052291, 6148.4159004895355, 6157.168782214344, 6048.304444988795, 6213.720382582795, 6776.424003959719, 6796.898046529306, 6807.65961701913, 5462.590305727086, 5701.914471282934, 5740.70834062341, 6014.548908831855, 6057.00059490188, 3328.2511434927433, 3560.590532088791, 3576.195356044869, 3580.5166302548823, 3581.552305961755, 6108.205933228741, 6416.101745755598, 6814.182298124158, 6937.202221744564, 6993.852766255104, 6940.722371105099, 6943.930560694429, 7017.193022802341, 7018.2278000189635, 7029.22678505364, 5898.35118136996, 6646.966765166143, 6998.10132906957, 7028.262032486516, 7107.92892071083, 6525.412712855866, 6579.506537009839, 6768.4585233182215, 6781.321867813179, 6884.139482564679, 5653.434656534479, 6070.757169713162, 6631.767888123893, 6743.730250789913, 6770.255271919987, 5161.032406366429, 5914.940850591439, 6670.733170673118, 6762.889071027383, 7053.4004609608755, 4056.350983842571, 4103.8974025649595, 4120.649744771608, 4154.356074808409, 4480.596746292719, 6394.840128996812, 6413.0, 6467.482601391784, 6484.254310754135, 6762.560433571802, 4801.767178262125, 5842.649441033552, 5891.1457838614015, 6033.728482218398, 6511.2512061113575, 5776.0, 6228.844278892882, 6456.418922297016, 6520.771772987922, 6566.080748695282, 5625.662460252398, 6069.726862291296, 6209.883264983897, 6337.225576838493, 6398.840028999312, 4998.725070121178, 6053.576249662481, 6490.935090649222, 6540.901886471612, 6579.17760279965, 5767.8558036049435, 5787.884242315215, 6335.556511044183, 6346.682665866781, 6449.838754031187], "value": 4675.363737343026, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [772.4091070331198, 807.9111297757249, 826.4132465949176, 842.380850075195, 847.9830403391933, 15803.841961580381, 16345.509634710963, 17355.132243387827, 18452.985085820274, 18580.628387432243, 17004.744928826076, 17314.740278895795, 17374.82625173751, 17379.217935192915, 17753.556161095978, 1002.1031177096512, 1035.3994683083831, 1036.0, 1037.761314897574, 1041.281515754131, 990.3612170150249, 1021.8569400283966, 1028.4497793680382, 1034.9948250258738, 1038.5949479702922, 1086.0388556127843, 1089.1341383600056, 1089.629525961173, 1092.5138313450518, 1095.43585053697, 1080.6811990462832, 1082.880883102862, 1083.7994970930324, 1084.9313426275112, 1086.7554800169937, 792.0693185507006, 812.0336799208982, 813.4509206285793, 814.2834305810849, 814.7922279818667, 16282.674346513122, 16330.75503867443, 16482.175891205512, 16865.156742162966, 17018.744718829228, 14617.269136543131, 14798.556043318718, 14863.479778207819, 14881.627959300995, 15485.612859678598, 12994.675133121747, 13418.060735748404, 13497.048547168544, 13532.32338383077, 13581.117227380288, 3224.790388624732, 3242.189452636841, 3270.1988012936745, 3275.1157187559224, 3279.9344013119844, 111913.44043279813, 112809.43595281971, 113663.0, 114591.42704286425, 115864.42067789691, 11419.60031398897, 11629.302241865515, 11647.242929209744, 11760.70598235051, 12030.81953770694, 24772.628410573856, 24815.5036899261, 24919.127830525846, 25150.874245628656, 25334.239972800846, 7777.051861974019, 7905.169957154531, 8052.798680033046, 8086.838263234702, 8115.147909469539, 3726.3386418045848, 4079.204555111784, 4191.161767646483, 4235.830566777356, 4329.458817647794, 4141.834326626901, 4213.6207741302815, 4215.873523794291, 4241.766702831374, 4250.489941207075, 645.8579112595221, 780.867252567065, 787.4960025583631, 796.1799346672937, 796.243568609823, 603.1465476350915, 623.1960770605867, 636.0808631527491, 647.4658406814303, 648.3581254557954, 8201.466904651297, 9824.754381140387, 9969.35199212049, 10157.593696252216, 10232.6418575351, 587.5358466811257, 602.0728078758663, 623.822210669966, 638.1321402892063, 652.5040968863698, 4645.9303110453375, 4649.651276154234, 4679.602233810097, 4681.274402467623, 4700.271457924027, 102327.0, 102698.48650756698, 103171.4841425788, 105628.0, 106003.0, 74222.0, 92614.61078083834, 93023.53488232516, 94705.52647236857, 95997.52001239949, 73679.0, 83176.58411707902, 83865.0, 84565.57717211374, 85869.57065214634, 9841.901580984384, 10912.454377280945, 11165.888341116484, 11169.329840209613, 11304.0, 40615.0, 41252.0, 41822.790886045375, 42063.7896810514, 42179.57820421756, 52709.47290527199, 52766.73616632046, 53052.20421693601, 53138.46861531335, 53255.0, 13423.472684793878, 13789.172649641054, 13888.0, 14048.438062477386, 14362.210078445785, 14505.709885802436, 14526.782098268746, 14547.665684793965, 14592.416303348173, 15347.923260384074, 13657.112287701268, 13808.447662093404, 13968.930155349159, 14310.928445357707, 14557.781633275297, 13231.338433078115, 13769.862301376857, 13785.379657915217, 13823.239721815396, 13962.232077235443, 13320.239086327498, 13422.918703261555, 13429.798553021908, 13665.18008919468, 13942.930285348508, 9003.369764116711, 10064.295499314978, 10156.18750499973, 10427.0, 10690.62582809598, 7734.922650773646, 9473.715788526355, 9570.95214523923, 10302.484875756332, 11185.161112916727], "value": 7846.436023244823, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1675.5, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 177.0, 184.0, 138.0, 142.0, 186.0, 162.0, 124.0, 107.0, 183.0], "value": 151.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 118.0, 121.0, 151.0, 168.0, 156.0, 111.0, 155.0, 177.0, 117.0], "value": 142.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [225.0, 230.0, 231.0, 233.0, 214.0, 213.0, 213.0, 210.0, 217.0, 212.0], "value": 219.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 59.0, 59.0, 91.0, 63.0, 63.0, 62.0, 60.0, 75.0, 61.0], "value": 67.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 71.0, 89.0, 74.0, 71.0, 73.0, 85.0, 71.0, 72.0, 85.0], "value": 78.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 92.0, 111.0, 138.0, 94.0, 99.0, 92.0, 93.0, 110.0, 90.0], "value": 101.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 99.0, 101.0, 107.0, 163.0, 148.0, 100.0, 102.0, 123.0, 160.0], "value": 120.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 101.0, 101.0, 103.0, 108.0, 151.0, 111.0, 85.0, 93.0, 149.0], "value": 110.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 53.0, 55.0, 54.0, 44.0, 44.0, 61.0, 84.0, 78.0, 82.0], "value": 60.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 89.0, 98.0, 63.0, 67.0, 66.0, 61.0, 60.0, 59.0, 65.0], "value": 69.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 115.0, 113.0, 77.0, 104.0, 113.0, 113.0, 86.0, 95.0, 116.0], "value": 101.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 147.0, 164.0, 166.0, 156.0, 147.0, 169.0, 150.0, 198.0, 180.0], "value": 162.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [256.0, 203.0, 235.0, 206.0, 243.0, 241.0, 194.0, 193.0, 195.0, 224.0], "value": 219.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 76.0, 77.0, 71.0, 72.0, 72.0, 69.0, 70.0, 69.0, 73.0], "value": 72.0, "unit": "score"}]}]} 13:35:48 INFO - Return code: 0 13:35:48 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 13:35:48 ERROR - # TBPL SUCCESS # 13:35:48 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 13:35:48 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 13:35:48 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 13:35:48 INFO - 2017-04-04 13:35:48.361 screenresolution[1656:10593] starting screenresolution argv=screenresolution get 13:35:48 INFO - 2017-04-04 13:35:48.364 screenresolution[1656:10593] Display 0: 1600x1200x32@60 13:35:48 INFO - 2017-04-04 13:35:48.370 screenresolution[1657:10596] starting screenresolution argv=screenresolution list 13:35:48 INFO - Available Modes on Display 0 13:35:48 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 13:35:48 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 13:35:48 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 13:35:48 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 13:35:48 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 13:35:48 INFO - Intel Iris: 13:35:48 INFO - Chipset Model: Intel Iris 13:35:48 INFO - Type: GPU 13:35:48 INFO - Bus: Built-In 13:35:48 INFO - VRAM (Dynamic, Max): 1536 MB 13:35:48 INFO - Vendor: Intel (0x8086) 13:35:48 INFO - Device ID: 0x0a2e 13:35:48 INFO - Revision ID: 0x0009 13:35:48 INFO - Displays: 13:35:48 INFO - Display: 13:35:48 INFO - Resolution: 1600 x 1200 @ 60 Hz 13:35:48 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 13:35:48 INFO - Display Serial Number: 1600x1200 60 13:35:48 INFO - Main Display: Yes 13:35:48 INFO - Mirror: Off 13:35:48 INFO - Online: Yes 13:35:48 INFO - Rotation: Supported 13:35:48 INFO - Return code: 0 13:35:48 INFO - Running post-action listener: _resource_record_post_action 13:35:48 INFO - [mozharness: 2017-04-04 20:35:48.603105Z] Finished run-tests step (success) 13:35:48 INFO - Running post-run listener: _resource_record_post_run 13:35:48 INFO - Total resource usage - Wall time: 1200s; CPU: 54.0%; Read bytes: 39098880; Write bytes: 517409280; Read time: 386; Write time: 1648 13:35:48 INFO - TinderboxPrint: CPU usage
54.3% 13:35:48 INFO - TinderboxPrint: I/O read bytes / time
39,098,880 / 386 13:35:48 INFO - TinderboxPrint: I/O write bytes / time
517,409,280 / 1,648 13:35:48 INFO - TinderboxPrint: CPU idle
2,194.7 (45.7%) 13:35:48 INFO - TinderboxPrint: CPU system
968.7 (20.2%) 13:35:48 INFO - TinderboxPrint: CPU user
1,638.2 (34.1%) 13:35:48 INFO - TinderboxPrint: Swap in / out
250,949,632 / 0 13:35:48 INFO - install - Wall time: 21s; CPU: 54.0%; Read bytes: 207370752; Write bytes: 205842432; Read time: 15780; Write time: 475 13:35:48 INFO - run-tests - Wall time: 1181s; CPU: 54.0%; Read bytes: 37100032; Write bytes: 300745216; Read time: 364; Write time: 1139 13:35:49 INFO - Running post-run listener: _upload_blobber_files 13:35:49 INFO - Blob upload gear active. 13:35:49 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 13:35:49 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 13:35:49 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', 'Pine', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 13:35:49 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 Pine -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 13:35:49 INFO - (blobuploader) - INFO - Open directory for files ... 13:35:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 13:35:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:35:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:35:50 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 13:35:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:35:50 INFO - (blobuploader) - INFO - Done attempting. 13:35:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 13:35:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:35:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:35:51 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 13:35:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:35:51 INFO - (blobuploader) - INFO - Done attempting. 13:35:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 13:35:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:35:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:35:52 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 13:35:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:35:52 INFO - (blobuploader) - INFO - Done attempting. 13:35:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 13:35:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:35:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:35:54 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 13:35:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:35:54 INFO - (blobuploader) - INFO - Done attempting. 13:35:54 INFO - (blobuploader) - INFO - Iteration through files over. 13:35:54 INFO - Return code: 0 13:35:54 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 13:35:54 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 13:35:54 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Pine/sha512/7d4703abd64ffecd2a3cf81d537848a4b99762843a5382554a2379811b74c88a8bca14baf7e08469e72cec6a681796c780951c8bb313b38460766a4870c968fe", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Pine/sha512/e27cd5686a0f5a9072e21181c2d8c3b15a081144408b33475eafd927e6a104b92f66495baed2fb162396a1128475b9bb97e52391013512db72596262045fcd10", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Pine/sha512/79861fa8f564850a892ea40a6e57328f9c1f08dd73f541d2689f5bc74426d83991b940bcac6d68e0114260e92a1383bbff07b53a472a9099f5fd29625d0b8eb8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Pine/sha512/57cdc56b559dfa3d5d8375b862a48e5b89b81a7293bbdf246b7d56b9d5a02ec7d62262dac0934cbb023d63264e772415db5dbdd16858a3ffc33d9db251e090bc"} 13:35:54 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 13:35:54 INFO - Writing to file /builds/slave/test/properties/blobber_files 13:35:54 INFO - Contents: 13:35:54 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Pine/sha512/7d4703abd64ffecd2a3cf81d537848a4b99762843a5382554a2379811b74c88a8bca14baf7e08469e72cec6a681796c780951c8bb313b38460766a4870c968fe", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Pine/sha512/e27cd5686a0f5a9072e21181c2d8c3b15a081144408b33475eafd927e6a104b92f66495baed2fb162396a1128475b9bb97e52391013512db72596262045fcd10", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Pine/sha512/79861fa8f564850a892ea40a6e57328f9c1f08dd73f541d2689f5bc74426d83991b940bcac6d68e0114260e92a1383bbff07b53a472a9099f5fd29625d0b8eb8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Pine/sha512/57cdc56b559dfa3d5d8375b862a48e5b89b81a7293bbdf246b7d56b9d5a02ec7d62262dac0934cbb023d63264e772415db5dbdd16858a3ffc33d9db251e090bc"} 13:35:54 INFO - Running post-run listener: copy_logs_to_upload_dir 13:35:54 INFO - Copying logs to upload dir... 13:35:54 INFO - mkdir: /builds/slave/test/build/upload/logs 13:35:54 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1283.000057 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 23 secs) (at 2017-04-04 13:35:54.411149) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-04 13:35:54.414276) ========= 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.4gTHEGQ8w3/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.UgNS6Uc6gj/Listeners TMPDIR=/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/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-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Pine/sha512/7d4703abd64ffecd2a3cf81d537848a4b99762843a5382554a2379811b74c88a8bca14baf7e08469e72cec6a681796c780951c8bb313b38460766a4870c968fe", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Pine/sha512/e27cd5686a0f5a9072e21181c2d8c3b15a081144408b33475eafd927e6a104b92f66495baed2fb162396a1128475b9bb97e52391013512db72596262045fcd10", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Pine/sha512/79861fa8f564850a892ea40a6e57328f9c1f08dd73f541d2689f5bc74426d83991b940bcac6d68e0114260e92a1383bbff07b53a472a9099f5fd29625d0b8eb8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Pine/sha512/57cdc56b559dfa3d5d8375b862a48e5b89b81a7293bbdf246b7d56b9d5a02ec7d62262dac0934cbb023d63264e772415db5dbdd16858a3ffc33d9db251e090bc"} build_url:https://queue.taskcluster.net/v1/task/d4iKk8LgRCqYM8jbxQZwcQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011032 build_url: 'https://queue.taskcluster.net/v1/task/d4iKk8LgRCqYM8jbxQZwcQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Pine/sha512/7d4703abd64ffecd2a3cf81d537848a4b99762843a5382554a2379811b74c88a8bca14baf7e08469e72cec6a681796c780951c8bb313b38460766a4870c968fe", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Pine/sha512/e27cd5686a0f5a9072e21181c2d8c3b15a081144408b33475eafd927e6a104b92f66495baed2fb162396a1128475b9bb97e52391013512db72596262045fcd10", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Pine/sha512/79861fa8f564850a892ea40a6e57328f9c1f08dd73f541d2689f5bc74426d83991b940bcac6d68e0114260e92a1383bbff07b53a472a9099f5fd29625d0b8eb8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Pine/sha512/57cdc56b559dfa3d5d8375b862a48e5b89b81a7293bbdf246b7d56b9d5a02ec7d62262dac0934cbb023d63264e772415db5dbdd16858a3ffc33d9db251e090bc"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-04 13:35:54.453500) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-04 13:35:54.453919) ========= 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.4gTHEGQ8w3/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.UgNS6Uc6gj/Listeners TMPDIR=/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/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.005069 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-04 13:35:54.502456) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-04 13:35:54.502776) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-04 13:35:54.503093) ========= ========= Total master_lag: 0.19 =========