Back to build
Raw log | Switch to full mode | Login

python -u /b/s/w/ir/kitchen-checkout/build/scripts/tools/runit.py --show-path --with-third-party-lib -- python /b/s/w/ir/kitchen-checkout/build/scripts/slave/recipe_modules/chromium_swarming/resources/collect_task.py --verbose -o /b/s/w/ir/tmp/t/tmpolLnT2.json --task-output-dir /b/s/w/ir/k/recipe_cleanup/4_2wc2pRe --merge-script /b/s/w/ir/kitchen-checkout/build/scripts/slave/recipe_modules/chromium_swarming/resources/noop_merge.py --merge-script-stdout-file /b/s/w/ir/tmp/t/tmpUTdtd6merge_script_log --merge-additional-args '[]' --summary-json-file /b/s/w/ir/tmp/t/tmpaRJwko.json -- swarming collect -server https://chromium-swarm.appspot.com -worker 50 -task-summary-python -task-output-stdout all -verbose -requests-json /b/s/w/ir/tmp/t/tmprPj6U5.json in dir /b/s/w/ir/k: allow_subannotations: False cmd: ['python', '-u', '/b/s/w/ir/kitchen-checkout/build/scripts/tools/runit.py', '--show-path', '--with-third-party-lib', '--', 'python', '/b/s/w/ir/kitchen-checkout/build/scripts/slave/recipe_modules/chromium_swarming/resources/collect_task.py', '--verbose', '-o', '/b/s/w/ir/tmp/t/tmpolLnT2.json', '--task-output-dir', '/b/s/w/ir/k/recipe_cleanup/4_2wc2pRe', '--merge-script', '/b/s/w/ir/kitchen-checkout/build/scripts/slave/recipe_modules/chromium_swarming/resources/noop_merge.py', '--merge-script-stdout-file', '/b/s/w/ir/tmp/t/tmpUTdtd6merge_script_log', '--merge-additional-args', '[]', '--summary-json-file', '/b/s/w/ir/tmp/t/tmpaRJwko.json', '--', 'swarming', 'collect', '-server', 'https://chromium-swarm.appspot.com', '-worker', '50', '-task-summary-python', '-task-output-stdout', 'all', '-verbose', '-requests-json', '/b/s/w/ir/tmp/t/tmprPj6U5.json'] env: {} env_prefixes: {'PATH': '/b/s/w/ir/cache/swarming_client'} env_suffixes: {} infra_step: False name_tokens: ('ios_chrome_ui_egtests (iPhone X iOS 12.1) shard 2 on Mac-10.13.6',) ok_ret: frozenset([0]) step_test_data: <lambda>(...) trigger_specs: () full environment: Apple_PubSub_Socket_Render: /private/tmp/com.apple.launchd.dqbP7GmasA/Render BOTO_CONFIG: /b/s/w/ir/tmp/gsutil_task/.boto BUILDBUCKET_EXPERIMENTAL: FALSE CIPD_CACHE_DIR: /b/s/cipd_cache/cache CIPD_PROTOCOL: v2 DEVSHELL_CLIENT_PORT: 49185 DOCKER_CONFIG: /b/s/w/ir/tmp/docker_cfg_task DOCKER_TMPDIR: /b/s/w/ir/tmp/docker_tmp_task GIT_CONFIG_NOSYSTEM: 1 GIT_TERMINAL_PROMPT: 0 HOME: /Users/chrome-bot INFRA_GIT_WRAPPER_HOME: /b/s/w/ir/tmp/git_home_task LOGDOG_COORDINATOR_HOST: logs.chromium.org LOGDOG_STREAM_PREFIX: buildbucket/cr-buildbucket.appspot.com/8918667408964835664 LOGDOG_STREAM_PROJECT: chromium LOGDOG_STREAM_SERVER_PATH: unix:/b/s/w/ir/tmp/ld.sock LOGNAME: chrome-bot LUCI_CONTEXT: /b/s/w/ito74W78/luci_context.074526663 MAC_CHROMIUM_TMPDIR: /b/s/w/ir/tmp/t NO_GCE_CHECK: False PATH: /b/s/w/ir/cache/swarming_client:/b/s/w/ir/cipd_bin_packages:/b/s/w/ir/cipd_bin_packages/bin:/b/s/cipd_cache/bin:/opt/local/bin:/opt/local/sbin:/usr/local/sbin:/usr/local/git/bin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin PWD: /b/s/w/ir/k PYTHONIOENCODING: UTF-8 PYTHONUNBUFFERED: 1 SHELL: /bin/bash SHLVL: 1 SSH_AUTH_SOCK: /private/tmp/com.apple.launchd.eDt2D83itn/Listeners SWARMING_BOT_ID: build111-m9 SWARMING_HEADLESS: 1 SWARMING_SERVER: https://chromium-swarm.appspot.com SWARMING_TASK_ID: 43a873ecda1c4811 TEMP: /b/s/w/ir/tmp/t TEMPDIR: /b/s/w/ir/tmp/t TMP: /b/s/w/ir/tmp/t TMPDIR: /b/s/w/ir/tmp/t USER: chrome-bot VERSIONER_PYTHON_PREFER_32_BIT: no VERSIONER_PYTHON_VERSION: 2.7 VPYTHON_VIRTUALENV_ROOT: /b/s/w/ir/cache/vpython XPC_FLAGS: 0x0 XPC_SERVICE_NAME: 0 _: /b/s/w/ir/cipd_bin_packages/vpython __CF_USER_TEXT_ENCODING: 0x1F4:0x0:0x0 Set PYTHONPATH: /b/s/w/ir/kitchen-checkout/build/scripts:/b/s/w/ir/kitchen-checkout/build/site_config:/b/s/w/ir/kitchen-checkout/build/third_party:/b/s/w/ir/kitchen-checkout/build/third_party/buildbot_8_4p1:/b/s/w/ir/kitchen-checkout/build/third_party/buildbot_slave_8_4:/b/s/w/ir/kitchen-checkout/build/third_party/coverage-3.7.1:/b/s/w/ir/kitchen-checkout/build/third_party/decorator_3_3_1:/b/s/w/ir/kitchen-checkout/build/third_party/google_api_python_client:/b/s/w/ir/kitchen-checkout/build/third_party/httplib2/python2:/b/s/w/ir/kitchen-checkout/build/third_party/infra_libs:/b/s/w/ir/kitchen-checkout/build/third_party/jinja2:/b/s/w/ir/kitchen-checkout/build/third_party/markupsafe:/b/s/w/ir/kitchen-checkout/build/third_party/oauth2client:/b/s/w/ir/kitchen-checkout/build/third_party/pyasn1:/b/s/w/ir/kitchen-checkout/build/third_party/pyasn1-modules:/b/s/w/ir/kitchen-checkout/build/third_party/python-rsa:/b/s/w/ir/kitchen-checkout/build/third_party/requests_2_10_0:/b/s/w/ir/kitchen-checkout/build/third_party/setuptools-0.6c11:/b/s/w/ir/kitchen-checkout/build/third_party/sqlalchemy_0_7_1:/b/s/w/ir/kitchen-checkout/build/third_party/sqlalchemy_migrate_0_7_1:/b/s/w/ir/kitchen-checkout/build/third_party/tempita_0_5:/b/s/w/ir/kitchen-checkout/build/third_party/twisted_10_2:/b/s/w/ir/kitchen-checkout/build/third_party/uritemplate:/b/s/w/ir/kitchen-checkout/build/third_party/site-packages 2019-03-18 00:59:57,426 - root: [DEBUG] Using task_output_dir: '/b/s/w/ir/k/recipe_cleanup/4_2wc2pRe' 2019-03-18 00:59:57,426 - root: [WARNING] task_output_dir '/b/s/w/ir/k/recipe_cleanup/4_2wc2pRe' already exists! 2019-03-18 00:59:57,426 - root: [WARNING] task_output_dir existing content: [] 2019-03-18 00:59:57,426 - root: [INFO] collect_cmd: swarming collect -server https://chromium-swarm.appspot.com -worker 50 -task-summary-python -task-output-stdout all -verbose -requests-json /b/s/w/ir/tmp/t/tmprPj6U5.json -output-dir /b/s/w/ir/k/recipe_cleanup/4_2wc2pRe -task-summary-json /b/s/w/ir/tmp/t/tmpaRJwko.json [D2019-03-18T00:59:57.440761-07:00 14685 0 auth.go:1265] Minting a new token {"key":"luci_ctx/9325f3615011cc8c14f653e5172e564fa0e32864a83ec7afe5fee2a432c89e65", "scopes":"https://www.googleapis.com/auth/userinfo.email"} [D2019-03-18T00:59:57.440833-07:00 14685 0 luci_ctx.go:138] POST http://127.0.0.1:49174/rpc/LuciLocalAuthService.GetOAuthToken {"key":"luci_ctx/9325f3615011cc8c14f653e5172e564fa0e32864a83ec7afe5fee2a432c89e65", "scopes":"https://www.googleapis.com/auth/userinfo.email"} [D2019-03-18T00:59:57.442238-07:00 14685 0 auth.go:1222] Token expires in 48m56.557799s {"key":"luci_ctx/9325f3615011cc8c14f653e5172e564fa0e32864a83ec7afe5fee2a432c89e65", "scopes":"https://www.googleapis.com/auth/userinfo.email"} 43a87d47c8e9ab10: exit 0 [I 2019-03-18 00:20:10] About to install Xcode 10b61 in Xcode.app for ios [12:20:11:INFO] Using Xcode version 10.1 build 10B61 at /b/s/w/ir/Xcode.app/Contents/Developer [12:20:20:INFO] Start test attempt #0 for command [xcodebuild test-without-building -xctestrun /b/s/w/iolJ40sB/run_1552893620.xctestrun -destination platform=iOS Simulator,OS=12.1,name=iPhone X -resultBundlePath /b/s/w/iolJ40sB/12.1 iPhone X/attempt_0] [12:20:21:INFO] User defaults from command line: Erasing all simulators. Launching ['xcodebuild', 'test-without-building', '-xctestrun', '/b/s/w/iolJ40sB/run_1552893620.xctestrun', '-destination', 'platform=iOS Simulator,OS=12.1,name=iPhone X', '-resultBundlePath', '/b/s/w/iolJ40sB/12.1 iPhone X/attempt_0'] with env {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'MAC_CHROMIUM_TMPDIR': '/b/s/w/itkvWeOd', 'LOGNAME': 'chrome-bot', 'USER': 'chrome-bot', 'HOME': '/Users/chrome-bot', 'BOTO_CONFIG': '/Users/chrome-bot/.boto', 'PATH': '/b/s/w/ir/.swarming_module_cache/vpython/b6ec90/bin:/b/s/w/ir/.swarming_module:/b/s/w/ir/.swarming_module/bin:/b/s/cipd_cache/bin:/opt/local/bin:/opt/local/sbin:/usr/local/sbin:/usr/local/git/bin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin', 'SWARMING_BOT_ID': 'vm241-m9', 'VIRTUAL_ENV': '/b/s/w/ir/.swarming_module_cache/vpython/b6ec90', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4zmTao27pn/Render', 'SWARMING_SERVER': 'https://chromium-swarm.appspot.com', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'SWARMING_HEADLESS': '1', 'PYTHONNOUSERSITE': '1', 'LUCI_CONTEXT': '/b/s/w/itkvWeOd/luci_ctx.FTBUNg.json', 'CIPD_CACHE_DIR': '/b/s/cipd_cache/cache', 'XPC_SERVICE_NAME': 'org.swarm.bot.plist', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RHzDWoSZi3/Listeners', 'VPYTHON_VIRTUALENV_ROOT': '/b/s/w/ir/.swarming_module_cache/vpython', 'SWARMING_TASK_ID': '43a87d47c8e9ab11', 'SHELL': '/bin/bash', 'NO_GCE_CHECK': 'False', 'TMPDIR': '/b/s/w/itkvWeOd', 'CIPD_PROTOCOL': 'v2', '__CF_USER_TEXT_ENCODING': '0x1F4:0x0:0x0', 'NSUnbufferedIO': 'YES'} [12:20:21:INFO] IDEBuildOperationResultBundlePath = /b/s/w/iolJ40sB/12.1 iPhone X/attempt_0 [12:20:21:INFO] IDETestRunSpecificationPath = /b/s/w/iolJ40sB/run_1552893620.xctestrun [12:20:21:INFO] [12:20:22:INFO] Testing started on 'iPhone X' [12:20:22:INFO] 2019-03-18 00:20:22.269 xcodebuild[63700:992434] IDETestOperationsObserverDebug: Writing diagnostic log for test session to: [12:20:22:INFO] /b/s/w/iolJ40sB/12.1 iPhone X/attempt_0/1_Test/Diagnostics/ios_chrome_ui_egtests_module-C80E169B-AE2C-4FCF-9F04-A2BDE9B56391/ios_chrome_ui_egtests_module-32416117-029C-4F69-9DB9-094893A1F610/Session-ios_chrome_ui_egtests_module-2019-03-18_002022-zPtS4f.log [12:20:22:INFO] 2019-03-18 00:20:22.269 xcodebuild[63700:992433] [MT] IDETestOperationsObserverDebug: (94DE457A-7345-4465-9CDB-681C05F93250) Beginning test session ios_chrome_ui_egtests_module-94DE457A-7345-4465-9CDB-681C05F93250 at 2019-03-18 00:20:22.269 with Xcode 10B61 on target <DVTiPhoneSimulator: 0x7fb5c39dd270> { [12:20:22:INFO] SimDevice: iPhone X (4649A5A2-4168-4045-8410-898C54BFA308, iOS 12.1, Shutdown) [12:20:22:INFO] } (12.1 (16B91)) [12:20:39:INFO] 2019-03-18 00:20:39.684 ios_chrome_ui_egtests[63821:993709] Crash handler setup started. [12:20:39:INFO] 2019-03-18 00:20:39.685 ios_chrome_ui_egtests[63821:993709] Crash handler setup completed. [12:20:39:INFO] 2019-03-18 00:20:39.685 ios_chrome_ui_egtests[63821:993709] Enabling accessibility for automation on Simulator. [12:20:42:INFO] 2019-03-18 00:20:42.146 ios_chrome_ui_egtests[63821:993709] Unbalanced calls to begin/end appearance transitions for <TabGridViewController: 0x7fd7c502b000>. [12:20:43:INFO] [0318/002043.076521:WARNING:leveldb_database.cc(106)] Unable to open /Users/chrome-bot/Library/Developer/CoreSimulator/Devices/4649A5A2-4168-4045-8410-898C54BFA308/data/Containers/Data/Application/CD5960AF-83CB-416F-B73E-79B423878593/Library/Application Support/Chromium/Default/shared_proto_db: Invalid argument: /Users/chrome-bot/Library/Developer/CoreSimulator/Devices/4649A5A2-4168-4045-8410-898C54BFA308/data/Containers/Data/Application/CD5960AF-83CB-416F-B73E-79B423878593/Library/Application Support/Chromium/Default/shared_proto_db: does not exist (create_if_missing is false) [12:20:49:INFO] Test Suite 'Selected tests' started at 2019-03-18 00:20:49.220 [12:20:49:INFO] Test Suite 'ios_chrome_ui_egtests_module.xctest' started at 2019-03-18 00:20:49.221 [12:20:49:INFO] Test Suite 'NewTabPageTestCase' started at 2019-03-18 00:20:49.222 [12:20:49:INFO] [0318/002049.232220:WARNING:loopback_server.cc(820)] Loopback sync persistent state file does not exist. [12:20:51:INFO] Test Case '-[NewTabPageTestCase testAccessibilityOnIncognitoTab]' started. [12:21:00:INFO] Test Case '-[NewTabPageTestCase testAccessibilityOnIncognitoTab]' passed (9.122 seconds). [12:21:00:INFO] Test Case '-[NewTabPageTestCase testAccessibilityOnMostVisited]' started. [12:21:03:INFO] Test Case '-[NewTabPageTestCase testAccessibilityOnMostVisited]' passed (3.454 seconds). [12:21:03:INFO] Test Suite 'NewTabPageTestCase' passed at 2019-03-18 00:21:03.682. [12:21:03:INFO] Executed 2 tests, with 0 failures (0 unexpected) in 12.576 (14.460) seconds [12:21:03:INFO] Test Suite 'OmniboxPopupTestCase' started at 2019-03-18 00:21:03.682 [12:21:03:INFO] [0318/002103.683779:WARNING:loopback_server.cc(820)] Loopback sync persistent state file does not exist. [12:21:03:INFO] Test Case '-[OmniboxPopupTestCase testCloseNTPWhenSwitching]' started. [12:21:06:INFO] [0318/002106.177445:WARNING:embedded_test_server.cc(238)] Request not handled. Returning 404: /favicon.ico [12:21:10:INFO] 2019-03-18 00:21:10.805 ios_chrome_ui_egtests[63821:993709] Attempting to type key 1. [12:21:10:INFO] 2019-03-18 00:21:10.908 ios_chrome_ui_egtests[63821:993709] Tapping on key: more, numbers. [12:21:10:INFO] 2019-03-18 00:21:10.994 ios_chrome_ui_egtests[63821:993709] Tapping on key: 1. [12:21:11:INFO] 2019-03-18 00:21:11.124 ios_chrome_ui_egtests[63821:993709] Attempting to type key 2. [12:21:11:INFO] 2019-03-18 00:21:11.125 ios_chrome_ui_egtests[63821:993709] Tapping on key: 2. [12:21:11:INFO] [0318/002111.172381:WARNING:spdy_session.cc(3232)] Received HEADERS for invalid stream 3 [12:21:11:INFO] 2019-03-18 00:21:11.194 ios_chrome_ui_egtests[63821:993709] Attempting to type key 7. [12:21:11:INFO] 2019-03-18 00:21:11.195 ios_chrome_ui_egtests[63821:993709] Tapping on key: 7. [12:21:11:INFO] [0318/002111.242713:WARNING:spdy_session.cc(3232)] Received HEADERS for invalid stream 5 [12:21:11:INFO] 2019-03-18 00:21:11.264 ios_chrome_ui_egtests[63821:993709] Attempting to type key .. [12:21:11:INFO] 2019-03-18 00:21:11.266 ios_chrome_ui_egtests[63821:993709] Tapping on key: .. [12:21:11:INFO] [0318/002111.317835:WARNING:spdy_session.cc(3232)] Received HEADERS for invalid stream 7 [12:21:11:INFO] 2019-03-18 00:21:11.335 ios_chrome_ui_egtests[63821:993709] Attempting to type key 0. [12:21:11:INFO] 2019-03-18 00:21:11.338 ios_chrome_ui_egtests[63821:993709] Tapping on key: 0. [12:21:11:INFO] 2019-03-18 00:21:11.622 ios_chrome_ui_egtests[63821:993709] Attempting to type key .. [12:21:11:INFO] 2019-03-18 00:21:11.624 ios_chrome_ui_egtests[63821:993709] Tapping on key: .. [12:21:11:INFO] [0318/002111.668719:WARNING:spdy_session.cc(3232)] Received HEADERS for invalid stream 9 [12:21:11:INFO] 2019-03-18 00:21:11.690 ios_chrome_ui_egtests[63821:993709] Attempting to type key 0. [12:21:11:INFO] 2019-03-18 00:21:11.691 ios_chrome_ui_egtests[63821:993709] Tapping on key: 0. [12:21:11:INFO] 2019-03-18 00:21:11.886 ios_chrome_ui_egtests[63821:993709] Attempting to type key .. [12:21:11:INFO] 2019-03-18 00:21:11.887 ios_chrome_ui_egtests[63821:993709] Tapping on key: .. [12:21:11:INFO] [0318/002111.937504:WARNING:spdy_session.cc(3232)] Received HEADERS for invalid stream 13 [12:21:11:INFO] 2019-03-18 00:21:11.956 ios_chrome_ui_egtests[63821:993709] Attempting to type key 1. [12:21:11:INFO] 2019-03-18 00:21:11.957 ios_chrome_ui_egtests[63821:993709] Tapping on key: 1. [12:21:16:INFO] Test Case '-[OmniboxPopupTestCase testCloseNTPWhenSwitching]' passed (13.179 seconds). [12:21:16:INFO] Test Case '-[OmniboxPopupTestCase testDontCloseNTPWhenSwitchingWithForwardHistory]' started. [12:21:19:INFO] [0318/002119.496859:WARNING:embedded_test_server.cc(238)] Request not handled. Returning 404: /favicon.ico [12:21:25:INFO] 2019-03-18 00:21:25.616 ios_chrome_ui_egtests[63821:993709] Attempting to type key 1. [12:21:25:INFO] 2019-03-18 00:21:25.717 ios_chrome_ui_egtests[63821:993709] Tapping on key: more, numbers. [12:21:25:INFO] 2019-03-18 00:21:25.787 ios_chrome_ui_egtests[63821:993709] Tapping on key: 1. [12:21:25:INFO] 2019-03-18 00:21:25.880 ios_chrome_ui_egtests[63821:993709] Attempting to type key 2. [12:21:25:INFO] 2019-03-18 00:21:25.881 ios_chrome_ui_egtests[63821:993709] Tapping on key: 2. [12:21:25:INFO] 2019-03-18 00:21:25.956 ios_chrome_ui_egtests[63821:993709] Attempting to type key 7. [12:21:25:INFO] 2019-03-18 00:21:25.957 ios_chrome_ui_egtests[63821:993709] Tapping on key: 7. [12:21:26:INFO] [0318/002126.010736:WARNING:spdy_session.cc(3232)] Received HEADERS for invalid stream 21 [12:21:26:INFO] 2019-03-18 00:21:26.030 ios_chrome_ui_egtests[63821:993709] Attempting to type key .. [12:21:26:INFO] 2019-03-18 00:21:26.032 ios_chrome_ui_egtests[63821:993709] Tapping on key: .. [12:21:26:INFO] 2019-03-18 00:21:26.201 ios_chrome_ui_egtests[63821:993709] Attempting to type key 0. [12:21:26:INFO] 2019-03-18 00:21:26.203 ios_chrome_ui_egtests[63821:993709] Tapping on key: 0. [12:21:26:INFO] 2019-03-18 00:21:26.279 ios_chrome_ui_egtests[63821:993709] Attempting to type key .. [12:21:26:INFO] 2019-03-18 00:21:26.280 ios_chrome_ui_egtests[63821:993709] Tapping on key: .. [12:21:26:INFO] 2019-03-18 00:21:26.452 ios_chrome_ui_egtests[63821:993709] Attempting to type key 0. [12:21:26:INFO] 2019-03-18 00:21:26.455 ios_chrome_ui_egtests[63821:993709] Tapping on key: 0. [12:21:26:INFO] 2019-03-18 00:21:26.528 ios_chrome_ui_egtests[63821:993709] Attempting to type key .. [12:21:26:INFO] 2019-03-18 00:21:26.530 ios_chrome_ui_egtests[63821:993709] Tapping on key: .. [12:21:26:INFO] 2019-03-18 00:21:26.638 ios_chrome_ui_egtests[63821:993709] Attempting to type key 1. [12:21:26:INFO] 2019-03-18 00:21:26.639 ios_chrome_ui_egtests[63821:993709] Tapping on key: 1. [12:21:31:INFO] Test Case '-[OmniboxPopupTestCase testDontCloseNTPWhenSwitchingWithForwardHistory]' passed (14.143 seconds). [12:21:31:INFO] Test Case '-[OmniboxPopupTestCase testIncognitoSeparation]' started. [12:21:33:INFO] [0318/002133.628936:WARNING:embedded_test_server.cc(238)] Request not handled. Returning 404: /favicon.ico [12:21:48:INFO] 2019-03-18 00:21:48.458 ios_chrome_ui_egtests[63821:993709] Attempting to type key 1. [12:21:48:INFO] 2019-03-18 00:21:48.562 ios_chrome_ui_egtests[63821:993709] Tapping on key: more, numbers. [12:21:48:INFO] 2019-03-18 00:21:48.613 ios_chrome_ui_egtests[63821:993709] Tapping on key: 1. [12:21:48:INFO] 2019-03-18 00:21:48.719 ios_chrome_ui_egtests[63821:993709] Attempting to type key 2. [12:21:48:INFO] 2019-03-18 00:21:48.722 ios_chrome_ui_egtests[63821:993709] Tapping on key: 2. [12:21:48:INFO] 2019-03-18 00:21:48.828 ios_chrome_ui_egtests[63821:993709] Attempting to type key 7. [12:21:48:INFO] 2019-03-18 00:21:48.829 ios_chrome_ui_egtests[63821:993709] Tapping on key: 7. [12:21:48:INFO] [0318/002148.876123:WARNING:spdy_session.cc(3232)] Received HEADERS for invalid stream 39 [12:21:48:INFO] 2019-03-18 00:21:48.920 ios_chrome_ui_egtests[63821:993709] Attempting to type key .. [12:21:48:INFO] 2019-03-18 00:21:48.922 ios_chrome_ui_egtests[63821:993709] Tapping on key: .. [12:21:49:INFO] 2019-03-18 00:21:49.014 ios_chrome_ui_egtests[63821:993709] Attempting to type key 0. [12:21:49:INFO] 2019-03-18 00:21:49.015 ios_chrome_ui_egtests[63821:993709] Tapping on key: 0. [12:21:49:INFO] [0318/002149.061252:WARNING:spdy_session.cc(3232)] Received HEADERS for invalid stream 43 [12:21:49:INFO] 2019-03-18 00:21:49.106 ios_chrome_ui_egtests[63821:993709] Attempting to type key .. [12:21:49:INFO] 2019-03-18 00:21:49.107 ios_chrome_ui_egtests[63821:993709] Tapping on key: .. [12:21:49:INFO] [0318/002149.157176:WARNING:spdy_session.cc(3232)] Received HEADERS for invalid stream 45 [12:21:49:INFO] 2019-03-18 00:21:49.200 ios_chrome_ui_egtests[63821:993709] Attempting to type key 0. [12:21:49:INFO] 2019-03-18 00:21:49.204 ios_chrome_ui_egtests[63821:993709] Tapping on key: 0. [12:21:49:INFO] [0318/002149.261645:WARNING:spdy_session.cc(3232)] Received HEADERS for invalid stream 47 [12:21:49:INFO] 2019-03-18 00:21:49.298 ios_chrome_ui_egtests[63821:993709] Attempting to type key .. [12:21:49:INFO] 2019-03-18 00:21:49.300 ios_chrome_ui_egtests[63821:993709] Tapping on key: .. [12:21:49:INFO] 2019-03-18 00:21:49.392 ios_chrome_ui_egtests[63821:993709] Attempting to type key 1. [12:21:49:INFO] 2019-03-18 00:21:49.392 ios_chrome_ui_egtests[63821:993709] Tapping on key: 1. [12:21:56:INFO] 2019-03-18 00:21:56.792 ios_chrome_ui_egtests[63821:993709] Attempting to type key 1. [12:21:56:INFO] 2019-03-18 00:21:56.895 ios_chrome_ui_egtests[63821:993709] Tapping on key: more, numbers. [12:21:56:INFO] 2019-03-18 00:21:56.947 ios_chrome_ui_egtests[63821:993709] Tapping on key: 1. [12:21:57:INFO] 2019-03-18 00:21:57.036 ios_chrome_ui_egtests[63821:993709] Attempting to type key 2. [12:21:57:INFO] 2019-03-18 00:21:57.036 ios_chrome_ui_egtests[63821:993709] Tapping on key: 2. [12:21:57:INFO] 2019-03-18 00:21:57.112 ios_chrome_ui_egtests[63821:993709] Attempting to type key 7. [12:21:57:INFO] 2019-03-18 00:21:57.113 ios_chrome_ui_egtests[63821:993709] Tapping on key: 7. [12:21:57:INFO] 2019-03-18 00:21:57.190 ios_chrome_ui_egtests[63821:993709] Attempting to type key .. [12:21:57:INFO] 2019-03-18 00:21:57.192 ios_chrome_ui_egtests[63821:993709] Tapping on key: .. [12:21:57:INFO] 2019-03-18 00:21:57.270 ios_chrome_ui_egtests[63821:993709] Attempting to type key 0. [12:21:57:INFO] 2019-03-18 00:21:57.271 ios_chrome_ui_egtests[63821:993709] Tapping on key: 0. [12:21:57:INFO] 2019-03-18 00:21:57.349 ios_chrome_ui_egtests[63821:993709] Attempting to type key .. [12:21:57:INFO] 2019-03-18 00:21:57.351 ios_chrome_ui_egtests[63821:993709] Tapping on key: .. [12:21:57:INFO] 2019-03-18 00:21:57.427 ios_chrome_ui_egtests[63821:993709] Attempting to type key 0. [12:21:57:INFO] 2019-03-18 00:21:57.428 ios_chrome_ui_egtests[63821:993709] Tapping on key: 0. [12:21:57:INFO] 2019-03-18 00:21:57.547 ios_chrome_ui_egtests[63821:993709] Attempting to type key .. [12:21:57:INFO] 2019-03-18 00:21:57.549 ios_chrome_ui_egtests[63821:993709] Tapping on key: .. [12:21:57:INFO] 2019-03-18 00:21:57.624 ios_chrome_ui_egtests[63821:993709] Attempting to type key 1. [12:21:57:INFO] 2019-03-18 00:21:57.625 ios_chrome_ui_egtests[63821:993709] Tapping on key: 1. [12:22:03:INFO] Test Case '-[OmniboxPopupTestCase testIncognitoSeparation]' passed (32.436 seconds). [12:22:03:INFO] Test Case '-[OmniboxPopupTestCase testMultiplePageOpened]' started. [12:22:05:INFO] [0318/002205.676989:WARNING:embedded_test_server.cc(238)] Request not handled. Returning 404: /favicon.ico [12:22:12:INFO] 2019-03-18 00:22:12.300 ios_chrome_ui_egtests[63821:993709] Attempting to type key p. [12:22:12:INFO] 2019-03-18 00:22:12.302 ios_chrome_ui_egtests[63821:993709] Tapping on key: p. [12:22:12:INFO] 2019-03-18 00:22:12.385 ios_chrome_ui_egtests[63821:993709] Attempting to type key a. [12:22:12:INFO] 2019-03-18 00:22:12.386 ios_chrome_ui_egtests[63821:993709] Tapping on key: a. [12:22:12:INFO] 2019-03-18 00:22:12.454 ios_chrome_ui_egtests[63821:993709] Attempting to type key g. [12:22:12:INFO] 2019-03-18 00:22:12.455 ios_chrome_ui_egtests[63821:993709] Tapping on key: g. [12:22:12:INFO] [0318/002212.503963:WARNING:spdy_session.cc(3232)] Received HEADERS for invalid stream 57 [12:22:12:INFO] 2019-03-18 00:22:12.524 ios_chrome_ui_egtests[63821:993709] Attempting to type key e. [12:22:12:INFO] 2019-03-18 00:22:12.524 ios_chrome_ui_egtests[63821:993709] Tapping on key: e. [12:22:18:INFO] Test Case '-[OmniboxPopupTestCase testMultiplePageOpened]' passed (14.989 seconds). [12:22:18:INFO] Test Case '-[OmniboxPopupTestCase testNotSwitchButtonOnCurrentTab]' started. [12:22:21:INFO] [0318/002221.095142:WARNING:embedded_test_server.cc(238)] Request not handled. Returning 404: /favicon.ico [12:22:29:INFO] 2019-03-18 00:22:29.350 ios_chrome_ui_egtests[63821:993709] Attempting to type key /. [12:22:29:INFO] 2019-03-18 00:22:29.454 ios_chrome_ui_egtests[63821:993709] Tapping on key: more, numbers. [12:22:29:INFO] 2019-03-18 00:22:29.509 ios_chrome_ui_egtests[63821:993709] Tapping on key: /. [12:22:29:INFO] 2019-03-18 00:22:29.614 ios_chrome_ui_egtests[63821:993709] Attempting to type key p. [12:22:29:INFO] 2019-03-18 00:22:29.921 ios_chrome_ui_egtests[63821:993709] Tapping on key: more, letters. [12:22:29:INFO] 2019-03-18 00:22:29.975 ios_chrome_ui_egtests[63821:993709] Tapping on key: p. [12:22:30:INFO] 2019-03-18 00:22:30.047 ios_chrome_ui_egtests[63821:993709] Attempting to type key a. [12:22:30:INFO] 2019-03-18 00:22:30.048 ios_chrome_ui_egtests[63821:993709] Tapping on key: a. [12:22:30:INFO] 2019-03-18 00:22:30.116 ios_chrome_ui_egtests[63821:993709] Attempting to type key g. [12:22:30:INFO] 2019-03-18 00:22:30.117 ios_chrome_ui_egtests[63821:993709] Tapping on key: g. [12:22:30:INFO] 2019-03-18 00:22:30.186 ios_chrome_ui_egtests[63821:993709] Attempting to type key e. [12:22:30:INFO] 2019-03-18 00:22:30.186 ios_chrome_ui_egtests[63821:993709] Tapping on key: e. [12:22:30:INFO] 2019-03-18 00:22:30.265 ios_chrome_ui_egtests[63821:993709] Attempting to type key 2. [12:22:30:INFO] 2019-03-18 00:22:30.368 ios_chrome_ui_egtests[63821:993709] Tapping on key: more, numbers. [12:22:30:INFO] 2019-03-18 00:22:30.421 ios_chrome_ui_egtests[63821:993709] Tapping on key: 2. [12:22:30:INFO] 2019-03-18 00:22:30.487 ios_chrome_ui_egtests[63821:993709] Attempting to type key .. [12:22:30:INFO] 2019-03-18 00:22:30.489 ios_chrome_ui_egtests[63821:993709] Tapping on key: .. [12:22:30:INFO] 2019-03-18 00:22:30.551 ios_chrome_ui_egtests[63821:993709] Attempting to type key h. [12:22:30:INFO] 2019-03-18 00:22:30.858 ios_chrome_ui_egtests[63821:993709] Tapping on key: more, letters. [12:22:30:INFO] 2019-03-18 00:22:30.910 ios_chrome_ui_egtests[63821:993709] Tapping on key: h. [12:22:30:INFO] 2019-03-18 00:22:30.972 ios_chrome_ui_egtests[63821:993709] Attempting to type key t. [12:22:30:INFO] 2019-03-18 00:22:30.973 ios_chrome_ui_egtests[63821:993709] Tapping on key: t. [12:22:31:INFO] 2019-03-18 00:22:31.033 ios_chrome_ui_egtests[63821:993709] Attempting to type key m. [12:22:31:INFO] 2019-03-18 00:22:31.035 ios_chrome_ui_egtests[63821:993709] Tapping on key: m. [12:22:31:INFO] 2019-03-18 00:22:31.099 ios_chrome_ui_egtests[63821:993709] Attempting to type key l. [12:22:31:INFO] 2019-03-18 00:22:31.100 ios_chrome_ui_egtests[63821:993709] Tapping on key: l. [12:22:35:INFO] Test Case '-[OmniboxPopupTestCase testNotSwitchButtonOnCurrentTab]' passed (16.737 seconds). [12:22:35:INFO] Test Case '-[OmniboxPopupTestCase testSwitchToClosedTab]' started. [12:22:37:INFO] [0318/002237.845336:WARNING:embedded_test_server.cc(238)] Request not handled. Returning 404: /favicon.ico [12:22:42:INFO] 2019-03-18 00:22:42.712 ios_chrome_ui_egtests[63821:993709] Attempting to type key /. [12:22:42:INFO] 2019-03-18 00:22:42.816 ios_chrome_ui_egtests[63821:993709] Tapping on key: more, numbers. [12:22:42:INFO] 2019-03-18 00:22:42.868 ios_chrome_ui_egtests[63821:993709] Tapping on key: /. [12:22:42:INFO] 2019-03-18 00:22:42.939 ios_chrome_ui_egtests[63821:993709] Attempting to type key p. [12:22:43:INFO] 2019-03-18 00:22:43.259 ios_chrome_ui_egtests[63821:993709] Tapping on key: more, letters. [12:22:43:INFO] 2019-03-18 00:22:43.311 ios_chrome_ui_egtests[63821:993709] Tapping on key: p. [12:22:43:INFO] 2019-03-18 00:22:43.379 ios_chrome_ui_egtests[63821:993709] Attempting to type key a. [12:22:43:INFO] 2019-03-18 00:22:43.380 ios_chrome_ui_egtests[63821:993709] Tapping on key: a. [12:22:43:INFO] 2019-03-18 00:22:43.446 ios_chrome_ui_egtests[63821:993709] Attempting to type key g. [12:22:43:INFO] 2019-03-18 00:22:43.447 ios_chrome_ui_egtests[63821:993709] Tapping on key: g. [12:22:43:INFO] 2019-03-18 00:22:43.517 ios_chrome_ui_egtests[63821:993709] Attempting to type key e. [12:22:43:INFO] 2019-03-18 00:22:43.517 ios_chrome_ui_egtests[63821:993709] Tapping on key: e. [12:22:43:INFO] 2019-03-18 00:22:43.587 ios_chrome_ui_egtests[63821:993709] Attempting to type key 1. [12:22:43:INFO] 2019-03-18 00:22:43.690 ios_chrome_ui_egtests[63821:993709] Tapping on key: more, numbers. [12:22:43:INFO] 2019-03-18 00:22:43.743 ios_chrome_ui_egtests[63821:993709] Tapping on key: 1. [12:22:43:INFO] 2019-03-18 00:22:43.809 ios_chrome_ui_egtests[63821:993709] Attempting to type key .. [12:22:43:INFO] 2019-03-18 00:22:43.811 ios_chrome_ui_egtests[63821:993709] Tapping on key: .. [12:22:43:INFO] 2019-03-18 00:22:43.876 ios_chrome_ui_egtests[63821:993709] Attempting to type key h. [12:22:44:INFO] 2019-03-18 00:22:44.181 ios_chrome_ui_egtests[63821:993709] Tapping on key: more, letters. [12:22:44:INFO] 2019-03-18 00:22:44.234 ios_chrome_ui_egtests[63821:993709] Tapping on key: h. [12:22:44:INFO] 2019-03-18 00:22:44.297 ios_chrome_ui_egtests[63821:993709] Attempting to type key t. [12:22:44:INFO] 2019-03-18 00:22:44.298 ios_chrome_ui_egtests[63821:993709] Tapping on key: t. [12:22:44:INFO] 2019-03-18 00:22:44.358 ios_chrome_ui_egtests[63821:993709] Attempting to type key m. [12:22:44:INFO] 2019-03-18 00:22:44.360 ios_chrome_ui_egtests[63821:993709] Tapping on key: m. [12:22:44:INFO] 2019-03-18 00:22:44.421 ios_chrome_ui_egtests[63821:993709] Attempting to type key l. [12:22:44:INFO] 2019-03-18 00:22:44.422 ios_chrome_ui_egtests[63821:993709] Tapping on key: l. [12:22:47:INFO] [0318/002247.760925:WARNING:web_state_impl.mm(657)] Script execution has failed: A JavaScript exception occurred [12:22:47:INFO] [0318/002247.769282:WARNING:web_state_impl.mm(657)] Script execution has failed: A JavaScript exception occurred [12:22:47:INFO] [0318/002247.769858:WARNING:web_state_impl.mm(657)] Script execution has failed: A JavaScript exception occurred [12:22:47:INFO] [0318/002247.791026:WARNING:web_state_impl.mm(657)] Script execution has failed: A JavaScript exception occurred [12:22:50:INFO] Test Case '-[OmniboxPopupTestCase testSwitchToClosedTab]' passed (15.598 seconds). [12:22:50:INFO] Test Case '-[OmniboxPopupTestCase testSwitchToOpenTab]' started. [12:22:53:INFO] [0318/002253.386152:WARNING:embedded_test_server.cc(238)] Request not handled. Returning 404: /favicon.ico [12:23:00:INFO] 2019-03-18 00:23:00.935 ios_chrome_ui_egtests[63821:993709] Attempting to type key /. [12:23:01:INFO] 2019-03-18 00:23:01.038 ios_chrome_ui_egtests[63821:993709] Tapping on key: more, numbers. [12:23:01:INFO] 2019-03-18 00:23:01.092 ios_chrome_ui_egtests[63821:993709] Tapping on key: /. [12:23:01:INFO] 2019-03-18 00:23:01.163 ios_chrome_ui_egtests[63821:993709] Attempting to type key p. [12:23:01:INFO] 2019-03-18 00:23:01.471 ios_chrome_ui_egtests[63821:993709] Tapping on key: more, letters. [12:23:01:INFO] 2019-03-18 00:23:01.524 ios_chrome_ui_egtests[63821:993709] Tapping on key: p. [12:23:01:INFO] 2019-03-18 00:23:01.595 ios_chrome_ui_egtests[63821:993709] Attempting to type key a. [12:23:01:INFO] 2019-03-18 00:23:01.596 ios_chrome_ui_egtests[63821:993709] Tapping on key: a. [12:23:01:INFO] 2019-03-18 00:23:01.665 ios_chrome_ui_egtests[63821:993709] Attempting to type key g. [12:23:01:INFO] 2019-03-18 00:23:01.666 ios_chrome_ui_egtests[63821:993709] Tapping on key: g. [12:23:01:INFO] 2019-03-18 00:23:01.734 ios_chrome_ui_egtests[63821:993709] Attempting to type key e. [12:23:01:INFO] 2019-03-18 00:23:01.734 ios_chrome_ui_egtests[63821:993709] Tapping on key: e. [12:23:01:INFO] 2019-03-18 00:23:01.802 ios_chrome_ui_egtests[63821:993709] Attempting to type key 1. [12:23:01:INFO] 2019-03-18 00:23:01.906 ios_chrome_ui_egtests[63821:993709] Tapping on key: more, numbers. [12:23:01:INFO] 2019-03-18 00:23:01.959 ios_chrome_ui_egtests[63821:993709] Tapping on key: 1. [12:23:02:INFO] 2019-03-18 00:23:02.026 ios_chrome_ui_egtests[63821:993709] Attempting to type key .. [12:23:02:INFO] 2019-03-18 00:23:02.028 ios_chrome_ui_egtests[63821:993709] Tapping on key: .. [12:23:02:INFO] 2019-03-18 00:23:02.093 ios_chrome_ui_egtests[63821:993709] Attempting to type key h. [12:23:02:INFO] 2019-03-18 00:23:02.401 ios_chrome_ui_egtests[63821:993709] Tapping on key: more, letters. [12:23:02:INFO] 2019-03-18 00:23:02.455 ios_chrome_ui_egtests[63821:993709] Tapping on key: h. [12:23:02:INFO] 2019-03-18 00:23:02.517 ios_chrome_ui_egtests[63821:993709] Attempting to type key t. [12:23:02:INFO] 2019-03-18 00:23:02.518 ios_chrome_ui_egtests[63821:993709] Tapping on key: t. [12:23:02:INFO] 2019-03-18 00:23:02.578 ios_chrome_ui_egtests[63821:993709] Attempting to type key m. [12:23:02:INFO] 2019-03-18 00:23:02.580 ios_chrome_ui_egtests[63821:993709] Tapping on key: m. [12:23:02:INFO] 2019-03-18 00:23:02.642 ios_chrome_ui_egtests[63821:993709] Attempting to type key l. [12:23:02:INFO] 2019-03-18 00:23:02.642 ios_chrome_ui_egtests[63821:993709] Tapping on key: l. [12:23:09:INFO] Test Case '-[OmniboxPopupTestCase testSwitchToOpenTab]' passed (19.093 seconds). [12:23:09:INFO] Test Suite 'OmniboxPopupTestCase' passed at 2019-03-18 00:23:09.870. [12:23:09:INFO] Executed 7 tests, with 0 failures (0 unexpected) in 126.175 (126.187) seconds [12:23:09:INFO] Test Suite 'PageInfoTestCase' started at 2019-03-18 00:23:09.870 [12:23:09:INFO] [0318/002309.871812:WARNING:loopback_server.cc(820)] Loopback sync persistent state file does not exist. [12:23:09:INFO] Test Case '-[PageInfoTestCase testShowPageInfoAndDismissOnDeviceRotation]' started. [12:23:22:INFO] Test Case '-[PageInfoTestCase testShowPageInfoAndDismissOnDeviceRotation]' passed (13.122 seconds). [12:23:22:INFO] Test Suite 'PageInfoTestCase' passed at 2019-03-18 00:23:22.998. [12:23:22:INFO] Executed 1 test, with 0 failures (0 unexpected) in 13.122 (13.127) seconds [12:23:23:INFO] Test Suite 'PassKitEGTest' started at 2019-03-18 00:23:22.998 [12:23:23:INFO] [0318/002322.999951:WARNING:loopback_server.cc(820)] Loopback sync persistent state file does not exist. [12:23:23:INFO] Test Case '-[PassKitEGTest testPassKitDownload]' started. [12:23:33:INFO] Test Case '-[PassKitEGTest testPassKitDownload]' passed (10.047 seconds). [12:23:33:INFO] Test Case '-[PassKitEGTest testPassKitParsingError]' started. [12:23:39:INFO] Test Case '-[PassKitEGTest testPassKitParsingError]' passed (6.802 seconds). [12:23:39:INFO] Test Suite 'PassKitEGTest' passed at 2019-03-18 00:23:39.852. [12:23:39:INFO] Executed 2 tests, with 0 failures (0 unexpected) in 16.848 (16.854) seconds [12:23:39:INFO] Test Suite 'PaymentRequestAccessibilityEGTest' started at 2019-03-18 00:23:39.853 [12:23:39:INFO] [0318/002339.854330:WARNING:loopback_server.cc(820)] Loopback sync persistent state file does not exist. [12:23:39:INFO] Test Case '-[PaymentRequestAccessibilityEGTest testAccessibilityOnPaymentRequestCardUnmaskPage]' started. [12:23:42:INFO] [0318/002342.338158:WARNING:embedded_test_server.cc(238)] Request not handled. Returning 404: /favicon.ico [12:23:45:INFO] 2019-03-18 00:23:45.177 ios_chrome_ui_egtests[63821:993709] Button touch target does not meet minimum size guidlines of (48, 48). Button: <MDCButton: 0x7fd7cb64b880; baseClass = UIButton; frame = (0 11.6667; 57 33); opaque = NO; layer = <MDCShapedShadowLayer: 0x6000007deb80>>, Touch Target: {57, 33} [12:23:45:INFO] 2019-03-18 00:23:45.300 ios_chrome_ui_egtests[63821:993709] Can't find keyplane that supports type 4 for keyboard iPhone-PortraitChoco-NumberPad; using 20603_PortraitChoco_iPhone-Simple-Pad_Default [12:23:49:INFO] Test Case '-[PaymentRequestAccessibilityEGTest testAccessibilityOnPaymentRequestCardUnmaskPage]' passed (9.751 seconds). [12:23:49:INFO] Test Case '-[PaymentRequestAccessibilityEGTest testAccessibilityOnPaymentRequestContactInfoAndSubPages]' started. [12:24:00:INFO] Test Case '-[PaymentRequestAccessibilityEGTest testAccessibilityOnPaymentRequestContactInfoAndSubPages]' passed (11.032 seconds). [12:24:00:INFO] Test Case '-[PaymentRequestAccessibilityEGTest testAccessibilityOnPaymentRequestDeliveryMethodPage]' started. [12:24:10:INFO] Test Case '-[PaymentRequestAccessibilityEGTest testAccessibilityOnPaymentRequestDeliveryMethodPage]' passed (9.536 seconds). [12:24:10:INFO] Test Case '-[PaymentRequestAccessibilityEGTest testAccessibilityOnPaymentRequestOrderSummaryPage]' started. [12:24:19:INFO] Test Case '-[PaymentRequestAccessibilityEGTest testAccessibilityOnPaymentRequestOrderSummaryPage]' passed (9.069 seconds). [12:24:19:INFO] Test Case '-[PaymentRequestAccessibilityEGTest testAccessibilityOnPaymentRequestPaymentMethodAndSubPages]' started. [12:24:32:INFO] Test Case '-[PaymentRequestAccessibilityEGTest testAccessibilityOnPaymentRequestPaymentMethodAndSubPages]' passed (12.762 seconds). [12:24:32:INFO] Test Case '-[PaymentRequestAccessibilityEGTest testAccessibilityOnPaymentRequestShippingAddressAndSubPages]' started. [12:24:45:INFO] Test Case '-[PaymentRequestAccessibilityEGTest testAccessibilityOnPaymentRequestShippingAddressAndSubPages]' passed (13.695 seconds). [12:24:45:INFO] Test Case '-[PaymentRequestAccessibilityEGTest testAccessibilityOnPaymentRequestSummaryPage]' started. [12:24:53:INFO] Test Case '-[PaymentRequestAccessibilityEGTest testAccessibilityOnPaymentRequestSummaryPage]' passed (7.711 seconds). [12:24:53:INFO] Test Suite 'PaymentRequestAccessibilityEGTest' passed at 2019-03-18 00:24:53.418. [12:24:53:INFO] Executed 7 tests, with 0 failures (0 unexpected) in 73.556 (73.565) seconds [12:24:53:INFO] Test Suite 'PaymentRequestCanMakePaymentEGTest' started at 2019-03-18 00:24:53.419 [12:24:53:INFO] [0318/002453.420103:WARNING:loopback_server.cc(820)] Loopback sync persistent state file does not exist. [12:24:53:INFO] Test Case '-[PaymentRequestCanMakePaymentEGTest testCanMakePaymentIsNotSupported]' started. [12:24:55:INFO] [0318/002455.686053:WARNING:embedded_test_server.cc(238)] Request not handled. Returning 404: /favicon.ico [12:24:58:INFO] Test Case '-[PaymentRequestCanMakePaymentEGTest testCanMakePaymentIsNotSupported]' passed (5.244 seconds). [12:24:58:INFO] Test Case '-[PaymentRequestCanMakePaymentEGTest testCanMakePaymentIsNotSupportedInIncognitoMode]' started. [12:25:09:INFO] Test Case '-[PaymentRequestCanMakePaymentEGTest testCanMakePaymentIsNotSupportedInIncognitoMode]' passed (11.108 seconds). [12:25:09:INFO] Test Case '-[PaymentRequestCanMakePaymentEGTest testCanMakePaymentIsSupported]' started. [12:25:14:INFO] Test Case '-[PaymentRequestCanMakePaymentEGTest testCanMakePaymentIsSupported]' passed (4.697 seconds). [12:25:14:INFO] Test Case '-[PaymentRequestCanMakePaymentEGTest testCanMakePaymentIsSupportedInIncognitoMode]' started. [12:25:26:INFO] Test Case '-[PaymentRequestCanMakePaymentEGTest testCanMakePaymentIsSupportedInIncognitoMode]' passed (12.444 seconds). [12:25:26:INFO] Test Case '-[PaymentRequestCanMakePaymentEGTest testCanMakePaymentIsSupportedInIncognitoModeNoUserConsent]' started. [12:25:39:INFO] Test Case '-[PaymentRequestCanMakePaymentEGTest testCanMakePaymentIsSupportedInIncognitoModeNoUserConsent]' passed (12.444 seconds). [12:25:39:INFO] Test Case '-[PaymentRequestCanMakePaymentEGTest testCanMakePaymentIsSupportedNoUserConsent]' started. [12:25:44:INFO] Test Case '-[PaymentRequestCanMakePaymentEGTest testCanMakePaymentIsSupportedNoUserConsent]' passed (4.712 seconds). [12:25:44:INFO] Test Suite 'PaymentRequestCanMakePaymentEGTest' passed at 2019-03-18 00:25:44.081. [12:25:44:INFO] Executed 6 tests, with 0 failures (0 unexpected) in 50.650 (50.663) seconds [12:25:44:INFO] Test Suite 'PaymentRequestCanMakePaymentExceedsQueryQuotaBasicaCardEGTest' started at 2019-03-18 00:25:44.082 [12:25:44:INFO] [0318/002544.083601:WARNING:loopback_server.cc(820)] Loopback sync persistent state file does not exist. [12:25:44:INFO] Test Case '-[PaymentRequestCanMakePaymentExceedsQueryQuotaBasicaCardEGTest testCanMakePaymentExceedsQueryQuotaBasicaCard]' started. [12:25:46:INFO] [0318/002546.386155:WARNING:embedded_test_server.cc(238)] Request not handled. Returning 404: /favicon.ico [12:25:49:INFO] Test Case '-[PaymentRequestCanMakePaymentExceedsQueryQuotaBasicaCardEGTest testCanMakePaymentExceedsQueryQuotaBasicaCard]' passed (5.440 seconds). [12:25:49:INFO] Test Suite 'PaymentRequestCanMakePaymentExceedsQueryQuotaBasicaCardEGTest' passed at 2019-03-18 00:25:49.526. [12:25:49:INFO] Executed 1 test, with 0 failures (0 unexpected) in 5.440 (5.444) seconds [12:25:49:INFO] Test Suite 'PaymentRequestCanMakePaymentExceedsQueryQuotaEGTest' started at 2019-03-18 00:25:49.527 [12:25:49:INFO] [0318/002549.528635:WARNING:loopback_server.cc(820)] Loopback sync persistent state file does not exist. [12:25:49:INFO] Test Case '-[PaymentRequestCanMakePaymentExceedsQueryQuotaEGTest testCanMakePaymentExceedsQueryQuota]' started. [12:25:51:INFO] [0318/002551.818003:WARNING:embedded_test_server.cc(238)] Request not handled. Returning 404: /favicon.ico [12:25:54:INFO] Test Case '-[PaymentRequestCanMakePaymentExceedsQueryQuotaEGTest testCanMakePaymentExceedsQueryQuota]' passed (5.411 seconds). [12:25:54:INFO] Test Suite 'PaymentRequestCanMakePaymentExceedsQueryQuotaEGTest' passed at 2019-03-18 00:25:54.942. [12:25:54:INFO] Executed 1 test, with 0 failures (0 unexpected) in 5.411 (5.415) seconds [12:25:54:INFO] Test Suite 'ios_chrome_ui_egtests_module.xctest' passed at 2019-03-18 00:25:54.943. [12:25:54:INFO] Executed 27 tests, with 0 failures (0 unexpected) in 303.778 (305.722) seconds [12:25:54:INFO] Test Suite 'Selected tests' passed at 2019-03-18 00:25:54.944. [12:25:54:INFO] Executed 27 tests, with 0 failures (0 unexpected) in 303.778 (305.724) seconds [12:25:55:INFO] [12:25:55:INFO] [12:25:55:INFO] Test session log: [12:25:55:INFO] /b/s/w/iolJ40sB/12.1 iPhone X/attempt_0/1_Test/Diagnostics/ios_chrome_ui_egtests_module-C80E169B-AE2C-4FCF-9F04-A2BDE9B56391/ios_chrome_ui_egtests_module-32416117-029C-4F69-9DB9-094893A1F610/Session-ios_chrome_ui_egtests_module-2019-03-18_002022-zPtS4f.log [12:25:55:INFO] [12:25:55:INFO] 2019-03-18 00:25:55.371 xcodebuild[63700:992433] [MT] IDETestOperationsObserverDebug: 333.192 elapsed -- Testing started completed. [12:25:55:INFO] 2019-03-18 00:25:55.372 xcodebuild[63700:992433] [MT] IDETestOperationsObserverDebug: 0.000 sec, +0.000 sec -- start [12:25:55:INFO] 2019-03-18 00:25:55.372 xcodebuild[63700:992433] [MT] IDETestOperationsObserverDebug: 333.192 sec, +333.192 sec -- end [12:25:55:INFO] ** TEST EXECUTE SUCCEEDED ** [12:25:55:INFO] [12:26:01:INFO] Command ['xcodebuild', 'test-without-building', '-xctestrun', '/b/s/w/iolJ40sB/run_1552893620.xctestrun', '-destination', 'platform=iOS Simulator,OS=12.1,name=iPhone X', '-resultBundlePath', '/b/s/w/iolJ40sB/12.1 iPhone X/attempt_0'] finished with 0 [12:26:01:DEBUG] Test ended. [12:26:01:DEBUG] Extracting test data. [12:26:01:DEBUG] Retrieving crash reports. [12:26:01:DEBUG] Retrieving derived data. [12:26:01:DEBUG] Making desktop screenshots. [12:26:01:DEBUG] Killing simulators. [12:26:06:DEBUG] Wiping simulator. Device wiped. [12:26:09:DEBUG] End of tear_down. 2019-03-18 00:59:58,353 - root: [DEBUG] Contents of task_output_dir: ['/b/s/w/ir/k/recipe_cleanup/4_2wc2pRe/43a87d47c8e9ab10'] 2019-03-18 00:59:58,354 - root: [WARNING] Expected output.json file missing: set(['/b/s/w/ir/k/recipe_cleanup/4_2wc2pRe/43a87d47c8e9ab10/output.json']) Found: [] Expected: ['/b/s/w/ir/k/recipe_cleanup/4_2wc2pRe/43a87d47c8e9ab10/output.json'] 2019-03-18 00:59:58,354 - root: [WARNING] No shard json files found in task_output_dir: '/b/s/w/ir/k/recipe_cleanup/4_2wc2pRe' Found ['/b/s/w/ir/k/recipe_cleanup/4_2wc2pRe/43a87d47c8e9ab10'] 2019-03-18 00:59:58,354 - root: [DEBUG] Found shard_json_files: ['/b/s/w/ir/k/recipe_cleanup/4_2wc2pRe/43a87d47c8e9ab10/output.json'] 2019-03-18 00:59:58,354 - root: [INFO] merge_cmd: /b/s/w/ir/cache/vpython/5b0713/bin/python /b/s/w/ir/kitchen-checkout/build/scripts/slave/recipe_modules/chromium_swarming/resources/noop_merge.py --summary-json /b/s/w/ir/tmp/t/tmpaRJwko.json --task-output-dir /b/s/w/ir/k/recipe_cleanup/4_2wc2pRe -o /b/s/w/ir/tmp/t/tmpolLnT2.json Running ['/b/s/w/ir/cache/vpython/5b0713/bin/python', '/b/s/w/ir/kitchen-checkout/build/scripts/slave/recipe_modules/chromium_swarming/resources/noop_merge.py', '--summary-json', '/b/s/w/ir/tmp/t/tmpaRJwko.json', '--task-output-dir', '/b/s/w/ir/k/recipe_cleanup/4_2wc2pRe', '-o', '/b/s/w/ir/tmp/t/tmpolLnT2.json'] in None (env: None) Command ['/b/s/w/ir/cache/vpython/5b0713/bin/python', '/b/s/w/ir/kitchen-checkout/build/scripts/slave/recipe_modules/chromium_swarming/resources/noop_merge.py', '--summary-json', '/b/s/w/ir/tmp/t/tmpaRJwko.json', '--task-output-dir', '/b/s/w/ir/k/recipe_cleanup/4_2wc2pRe', '-o', '/b/s/w/ir/tmp/t/tmpolLnT2.json'] returned exit code 0