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/tmpriPtuY.json --task-output-dir /b/s/w/ir/k/recipe_cleanup/0YvaShH --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/tmppPufd8merge_script_log --merge-additional-args '[]' --summary-json-file /b/s/w/ir/tmp/t/tmpMtk9GP.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/tmpzu3UNf.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/tmpriPtuY.json', '--task-output-dir', '/b/s/w/ir/k/recipe_cleanup/0YvaShH', '--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/tmppPufd8merge_script_log', '--merge-additional-args', '[]', '--summary-json-file', '/b/s/w/ir/tmp/t/tmpMtk9GP.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/tmpzu3UNf.json'] env: {} env_prefixes: {'PATH': '/b/s/w/ir/cache/swarming_client'} env_suffixes: {} infra_step: False name_tokens: ('ios_chrome_integration_egtests (iPhone X iOS 12.1) on Mac-10.13.6',) ok_ret: ALL_OK step_test_data: <lambda>(...) trigger_specs: () full environment: Apple_PubSub_Socket_Render: /private/tmp/com.apple.launchd.KC4dwyx7W5/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: 56735 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/8918134578517569120 LOGDOG_STREAM_PROJECT: chromium LOGDOG_STREAM_SERVER_PATH: unix:/b/s/w/ir/tmp/ld.sock LOGNAME: chrome-bot LUCI_CONTEXT: /b/s/w/itqBYaTU/luci_context.996285672 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.WvLGjLDjkG/Listeners SWARMING_BOT_ID: build111-m9 SWARMING_HEADLESS: 1 SWARMING_SERVER: https://chromium-swarm.appspot.com SWARMING_TASK_ID: 43c6bda021c3be11 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-23 21:29:14,448 - root: [DEBUG] Using task_output_dir: '/b/s/w/ir/k/recipe_cleanup/0YvaShH' 2019-03-23 21:29:14,448 - root: [WARNING] task_output_dir '/b/s/w/ir/k/recipe_cleanup/0YvaShH' already exists! 2019-03-23 21:29:14,448 - root: [WARNING] task_output_dir existing content: [] 2019-03-23 21:29:14,448 - 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/tmpzu3UNf.json -output-dir /b/s/w/ir/k/recipe_cleanup/0YvaShH -task-summary-json /b/s/w/ir/tmp/t/tmpMtk9GP.json [D2019-03-23T21:29:14.463251-07:00 1775 0 auth.go:1265] Minting a new token {"key":"luci_ctx/937bf9da71f29a1bd341727c0c9572744fc5110b377b458b14faeba5b9554ad4", "scopes":"https://www.googleapis.com/auth/userinfo.email"} [D2019-03-23T21:29:14.463322-07:00 1775 0 luci_ctx.go:138] POST http://127.0.0.1:56724/rpc/LuciLocalAuthService.GetOAuthToken {"key":"luci_ctx/937bf9da71f29a1bd341727c0c9572744fc5110b377b458b14faeba5b9554ad4", "scopes":"https://www.googleapis.com/auth/userinfo.email"} [D2019-03-23T21:29:14.464792-07:00 1775 0 auth.go:1222] Token expires in 21m17.535253s {"key":"luci_ctx/937bf9da71f29a1bd341727c0c9572744fc5110b377b458b14faeba5b9554ad4", "scopes":"https://www.googleapis.com/auth/userinfo.email"} [D2019-03-23T21:29:15.919245-07:00 1775 0 collect.go:344] Waiting task_id: 43c6c6351600a610 [D2019-03-23T21:29:17.262662-07:00 1775 0 collect.go:344] Waiting task_id: 43c6c6351600a610 [D2019-03-23T21:29:18.889370-07:00 1775 0 collect.go:344] Waiting task_id: 43c6c6351600a610 [D2019-03-23T21:29:20.376079-07:00 1775 0 collect.go:344] Waiting task_id: 43c6c6351600a610 [D2019-03-23T21:29:21.944697-07:00 1775 0 collect.go:344] Waiting task_id: 43c6c6351600a610 [D2019-03-23T21:29:24.409824-07:00 1775 0 collect.go:344] Waiting task_id: 43c6c6351600a610 [D2019-03-23T21:29:26.114527-07:00 1775 0 collect.go:344] Waiting task_id: 43c6c6351600a610 [D2019-03-23T21:29:27.848282-07:00 1775 0 collect.go:344] Waiting task_id: 43c6c6351600a610 [D2019-03-23T21:29:29.689022-07:00 1775 0 collect.go:344] Waiting task_id: 43c6c6351600a610 [D2019-03-23T21:29:31.537688-07:00 1775 0 collect.go:344] Waiting task_id: 43c6c6351600a610 [D2019-03-23T21:29:33.520215-07:00 1775 0 collect.go:344] Waiting task_id: 43c6c6351600a610 [D2019-03-23T21:29:35.519945-07:00 1775 0 collect.go:344] Waiting task_id: 43c6c6351600a610 [D2019-03-23T21:29:37.937376-07:00 1775 0 collect.go:344] Waiting task_id: 43c6c6351600a610 [D2019-03-23T21:29:40.147046-07:00 1775 0 collect.go:344] Waiting task_id: 43c6c6351600a610 [D2019-03-23T21:29:42.459485-07:00 1775 0 collect.go:344] Waiting task_id: 43c6c6351600a610 [D2019-03-23T21:29:44.764676-07:00 1775 0 collect.go:344] Waiting task_id: 43c6c6351600a610 [D2019-03-23T21:29:47.057643-07:00 1775 0 collect.go:344] Waiting task_id: 43c6c6351600a610 [D2019-03-23T21:29:49.483236-07:00 1775 0 collect.go:344] Waiting task_id: 43c6c6351600a610 [D2019-03-23T21:29:51.977719-07:00 1775 0 collect.go:344] Waiting task_id: 43c6c6351600a610 [D2019-03-23T21:29:54.435144-07:00 1775 0 collect.go:344] Waiting task_id: 43c6c6351600a610 [D2019-03-23T21:29:57.123647-07:00 1775 0 collect.go:344] Waiting task_id: 43c6c6351600a610 [D2019-03-23T21:30:00.158631-07:00 1775 0 collect.go:344] Waiting task_id: 43c6c6351600a610 [D2019-03-23T21:30:02.986891-07:00 1775 0 collect.go:344] Waiting task_id: 43c6c6351600a610 [D2019-03-23T21:30:05.952991-07:00 1775 0 collect.go:344] Waiting task_id: 43c6c6351600a610 [D2019-03-23T21:30:08.880306-07:00 1775 0 collect.go:344] Waiting task_id: 43c6c6351600a610 [D2019-03-23T21:30:11.904719-07:00 1775 0 collect.go:344] Waiting task_id: 43c6c6351600a610 [D2019-03-23T21:30:15.019201-07:00 1775 0 collect.go:344] Waiting task_id: 43c6c6351600a610 [D2019-03-23T21:30:18.397323-07:00 1775 0 collect.go:344] Waiting task_id: 43c6c6351600a610 [D2019-03-23T21:30:21.892243-07:00 1775 0 collect.go:344] Waiting task_id: 43c6c6351600a610 [D2019-03-23T21:30:25.375853-07:00 1775 0 collect.go:344] Waiting task_id: 43c6c6351600a610 [D2019-03-23T21:30:29.070620-07:00 1775 0 collect.go:344] Waiting task_id: 43c6c6351600a610 [D2019-03-23T21:30:32.859958-07:00 1775 0 collect.go:344] Waiting task_id: 43c6c6351600a610 [D2019-03-23T21:30:36.835260-07:00 1775 0 collect.go:344] Waiting task_id: 43c6c6351600a610 [D2019-03-23T21:30:41.011832-07:00 1775 0 collect.go:344] Waiting task_id: 43c6c6351600a610 [D2019-03-23T21:30:45.418860-07:00 1775 0 collect.go:344] Waiting task_id: 43c6c6351600a610 [D2019-03-23T21:30:49.897554-07:00 1775 0 collect.go:344] Waiting task_id: 43c6c6351600a610 [D2019-03-23T21:30:54.345443-07:00 1775 0 collect.go:344] Waiting task_id: 43c6c6351600a610 [D2019-03-23T21:30:59.005455-07:00 1775 0 collect.go:344] Waiting task_id: 43c6c6351600a610 [D2019-03-23T21:31:03.965744-07:00 1775 0 collect.go:344] Waiting task_id: 43c6c6351600a610 [D2019-03-23T21:31:08.990141-07:00 1775 0 collect.go:344] Waiting task_id: 43c6c6351600a610 [D2019-03-23T21:31:14.209861-07:00 1775 0 collect.go:344] Waiting task_id: 43c6c6351600a610 [D2019-03-23T21:31:19.843751-07:00 1775 0 collect.go:344] Waiting task_id: 43c6c6351600a610 [D2019-03-23T21:31:25.412169-07:00 1775 0 collect.go:344] Waiting task_id: 43c6c6351600a610 [D2019-03-23T21:31:31.155697-07:00 1775 0 collect.go:344] Waiting task_id: 43c6c6351600a610 [D2019-03-23T21:31:37.166572-07:00 1775 0 collect.go:344] Waiting task_id: 43c6c6351600a610 [D2019-03-23T21:31:43.299665-07:00 1775 0 collect.go:344] Waiting task_id: 43c6c6351600a610 [D2019-03-23T21:31:49.619813-07:00 1775 0 collect.go:344] Waiting task_id: 43c6c6351600a610 [D2019-03-23T21:31:56.155796-07:00 1775 0 collect.go:344] Waiting task_id: 43c6c6351600a610 [D2019-03-23T21:32:03.083563-07:00 1775 0 collect.go:344] Waiting task_id: 43c6c6351600a610 [D2019-03-23T21:32:10.663439-07:00 1775 0 collect.go:344] Waiting task_id: 43c6c6351600a610 [D2019-03-23T21:32:17.932399-07:00 1775 0 collect.go:344] Waiting task_id: 43c6c6351600a610 [D2019-03-23T21:32:25.419610-07:00 1775 0 collect.go:344] Waiting task_id: 43c6c6351600a610 [D2019-03-23T21:32:33.139325-07:00 1775 0 collect.go:344] Waiting task_id: 43c6c6351600a610 [D2019-03-23T21:32:41.149888-07:00 1775 0 collect.go:344] Waiting task_id: 43c6c6351600a610 [D2019-03-23T21:32:49.485798-07:00 1775 0 collect.go:344] Waiting task_id: 43c6c6351600a610 [D2019-03-23T21:32:58.001420-07:00 1775 0 collect.go:344] Waiting task_id: 43c6c6351600a610 [D2019-03-23T21:33:06.785189-07:00 1775 0 collect.go:344] Waiting task_id: 43c6c6351600a610 [D2019-03-23T21:33:15.854517-07:00 1775 0 collect.go:344] Waiting task_id: 43c6c6351600a610 [D2019-03-23T21:33:25.423909-07:00 1775 0 collect.go:344] Waiting task_id: 43c6c6351600a610 [D2019-03-23T21:33:35.032527-07:00 1775 0 collect.go:344] Waiting task_id: 43c6c6351600a610 [D2019-03-23T21:33:45.098468-07:00 1775 0 collect.go:344] Waiting task_id: 43c6c6351600a610 [D2019-03-23T21:33:55.555695-07:00 1775 0 collect.go:344] Waiting task_id: 43c6c6351600a610 [D2019-03-23T21:34:06.325100-07:00 1775 0 collect.go:344] Waiting task_id: 43c6c6351600a610 [D2019-03-23T21:34:17.402215-07:00 1775 0 collect.go:344] Waiting task_id: 43c6c6351600a610 [D2019-03-23T21:34:28.868179-07:00 1775 0 collect.go:344] Waiting task_id: 43c6c6351600a610 [D2019-03-23T21:34:40.736837-07:00 1775 0 collect.go:344] Waiting task_id: 43c6c6351600a610 [D2019-03-23T21:34:52.958630-07:00 1775 0 collect.go:344] Waiting task_id: 43c6c6351600a610 [D2019-03-23T21:35:05.456606-07:00 1775 0 collect.go:344] Waiting task_id: 43c6c6351600a610 [D2019-03-23T21:35:18.654417-07:00 1775 0 collect.go:344] Waiting task_id: 43c6c6351600a610 [D2019-03-23T21:35:32.149158-07:00 1775 0 collect.go:344] Waiting task_id: 43c6c6351600a610 [D2019-03-23T21:35:46.023827-07:00 1775 0 collect.go:344] Waiting task_id: 43c6c6351600a610 [D2019-03-23T21:36:00.320100-07:00 1775 0 collect.go:344] Waiting task_id: 43c6c6351600a610 [D2019-03-23T21:36:15.175430-07:00 1775 0 collect.go:344] Waiting task_id: 43c6c6351600a610 [D2019-03-23T21:36:30.414586-07:00 1775 0 collect.go:344] Waiting task_id: 43c6c6351600a610 [D2019-03-23T21:36:45.754330-07:00 1775 0 collect.go:344] Waiting task_id: 43c6c6351600a610 [D2019-03-23T21:37:01.053708-07:00 1775 0 collect.go:344] Waiting task_id: 43c6c6351600a610 [D2019-03-23T21:37:16.394715-07:00 1775 0 collect.go:344] Waiting task_id: 43c6c6351600a610 [D2019-03-23T21:37:31.807169-07:00 1775 0 collect.go:344] Waiting task_id: 43c6c6351600a610 [D2019-03-23T21:37:47.146839-07:00 1775 0 collect.go:344] Waiting task_id: 43c6c6351600a610 [D2019-03-23T21:38:02.479756-07:00 1775 0 collect.go:344] Waiting task_id: 43c6c6351600a610 [D2019-03-23T21:38:17.965498-07:00 1775 0 collect.go:344] Waiting task_id: 43c6c6351600a610 [D2019-03-23T21:38:33.382472-07:00 1775 0 collect.go:344] Waiting task_id: 43c6c6351600a610 [D2019-03-23T21:38:48.714986-07:00 1775 0 collect.go:344] Waiting task_id: 43c6c6351600a610 [D2019-03-23T21:39:04.138599-07:00 1775 0 collect.go:344] Waiting task_id: 43c6c6351600a610 [D2019-03-23T21:39:19.480862-07:00 1775 0 collect.go:344] Waiting task_id: 43c6c6351600a610 [D2019-03-23T21:39:35.445884-07:00 1775 0 collect.go:344] Waiting task_id: 43c6c6351600a610 43c6c6351600a610: exit 0 [I 2019-03-23 21:28:22] About to install Xcode 10b61 in Xcode.app for ios [09:28:22:INFO] Using Xcode version 10.1 build 10B61 at /b/s/w/ir/Xcode.app/Contents/Developer [09:28:28:INFO] Start test attempt #0 for command [xcodebuild test-without-building -xctestrun /b/s/w/ioH9Guh8/run_1553401708.xctestrun -destination platform=iOS Simulator,OS=12.1,name=iPhone X -resultBundlePath /b/s/w/ioH9Guh8/12.1 iPhone X/attempt_0 -parallel-testing-enabled YES -parallel-testing-worker-count 4] [09:28:29:INFO] User defaults from command line: Erasing all simulators. Launching ['xcodebuild', 'test-without-building', '-xctestrun', '/b/s/w/ioH9Guh8/run_1553401708.xctestrun', '-destination', 'platform=iOS Simulator,OS=12.1,name=iPhone X', '-resultBundlePath', '/b/s/w/ioH9Guh8/12.1 iPhone X/attempt_0', '-parallel-testing-enabled', 'YES', '-parallel-testing-worker-count', '4'] with env {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'MAC_CHROMIUM_TMPDIR': '/b/s/w/itbLEGkV', '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': 'build767-m4', 'VIRTUAL_ENV': '/b/s/w/ir/.swarming_module_cache/vpython/b6ec90', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.gYy7Wkg8KX/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/itbLEGkV/luci_ctx.QjRyOS.json', 'CIPD_CACHE_DIR': '/b/s/cipd_cache/cache', 'XPC_SERVICE_NAME': 'org.swarm.bot.plist', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.NIkISitVNy/Listeners', 'VPYTHON_VIRTUALENV_ROOT': '/b/s/w/ir/.swarming_module_cache/vpython', 'SWARMING_TASK_ID': '43c6c6351600a611', 'SHELL': '/bin/bash', 'NO_GCE_CHECK': 'False', 'TMPDIR': '/b/s/w/itbLEGkV', 'CIPD_PROTOCOL': 'v2', '__CF_USER_TEXT_ENCODING': '0x1F4:0x0:0x0', 'NSUnbufferedIO': 'YES'} [09:28:29:INFO] IDEBuildOperationResultBundlePath = /b/s/w/ioH9Guh8/12.1 iPhone X/attempt_0 [09:28:29:INFO] IDETestRunSpecificationPath = /b/s/w/ioH9Guh8/run_1553401708.xctestrun [09:28:29:INFO] [09:28:29:INFO] Testing started on 'iPhone X' [09:28:29:INFO] 2019-03-23 21:28:29.682 xcodebuild[34119:453456] IDETestOperationsObserverDebug: Writing diagnostic log for test session to: [09:28:29:INFO] /b/s/w/ioH9Guh8/12.1 iPhone X/attempt_0/1_Test/Diagnostics/ios_chrome_integration_egtests_module-A7A6B010-6437-4822-AA11-CD9A921859E2/ios_chrome_integration_egtests_module-C2E4E6F5-10D0-4129-9301-EBC4674D2015/Session-ios_chrome_integration_egtests_module-2019-03-23_212829-2doPAK.log [09:28:29:INFO] 2019-03-23 21:28:29.682 xcodebuild[34119:453397] [MT] IDETestOperationsObserverDebug: (0DDEFF33-4D47-4225-AE02-2FE1ECD21ADA) Beginning test session ios_chrome_integration_egtests_module-0DDEFF33-4D47-4225-AE02-2FE1ECD21ADA at 2019-03-23 21:28:29.682 with Xcode 10B61 on target <DVTiPhoneSimulator: 0x7fd0db1185c0> { [09:28:29:INFO] SimDevice: Clone 1 of iPhone X (5FB5FEB1-E5C6-4A96-AF18-A1FEB5FC8115, iOS 12.1, Shutdown) [09:28:29:INFO] } (12.1 (16B91)) [09:28:53:INFO] 2019-03-23 21:28:53.869 xcodebuild[34119:453397] [MT] IDETestOperationsObserverDebug: (804F5A6F-EC26-4AD4-90FE-D96D238EAE44) Beginning test session ios_chrome_integration_egtests_module-804F5A6F-EC26-4AD4-90FE-D96D238EAE44 at 2019-03-23 21:28:53.866 with Xcode 10B61 on target <DVTiPhoneSimulator: 0x7fd0db0451e0> { [09:28:53:INFO] SimDevice: Clone 2 of iPhone X (4C2393E5-4FA1-4770-85DF-00FABE59D674, iOS 12.1, Shutdown) [09:28:53:INFO] } (12.1 (16B91)) [09:28:53:INFO] 2019-03-23 21:28:53.883 xcodebuild[34119:453499] IDETestOperationsObserverDebug: Writing diagnostic log for test session to: [09:28:53:INFO] /b/s/w/ioH9Guh8/12.1 iPhone X/attempt_0/1_Test/Diagnostics/ios_chrome_integration_egtests_module-A7A6B010-6437-4822-AA11-CD9A921859E2/ios_chrome_integration_egtests_module-F4DE1BAC-DDF7-4BAA-877E-D74D5F4AB38C/Session-ios_chrome_integration_egtests_module-2019-03-23_212853-nUEIj3.log [09:28:54:INFO] 2019-03-23 21:28:54.229 xcodebuild[34119:453397] [MT] IDETestOperationsObserverDebug: (7445A940-3BCE-4EA5-B862-76BEA40AE022) Beginning test session ios_chrome_integration_egtests_module-7445A940-3BCE-4EA5-B862-76BEA40AE022 at 2019-03-23 21:28:54.230 with Xcode 10B61 on target <DVTiPhoneSimulator: 0x7fd0db132ff0> { [09:28:54:INFO] SimDevice: Clone 3 of iPhone X (79EFB358-B213-4342-9509-BEC9992AE3D5, iOS 12.1, Shutdown) [09:28:54:INFO] } (12.1 (16B91)) [09:28:54:INFO] 2019-03-23 21:28:54.230 xcodebuild[34119:454756] IDETestOperationsObserverDebug: Writing diagnostic log for test session to: [09:28:54:INFO] /b/s/w/ioH9Guh8/12.1 iPhone X/attempt_0/1_Test/Diagnostics/ios_chrome_integration_egtests_module-A7A6B010-6437-4822-AA11-CD9A921859E2/ios_chrome_integration_egtests_module-B450F184-5E47-41B0-BABA-FFE6AE9486DB/Session-ios_chrome_integration_egtests_module-2019-03-23_212854-IoW2rf.log [09:28:54:INFO] 2019-03-23 21:28:54.244 xcodebuild[34119:454835] IDETestOperationsObserverDebug: Writing diagnostic log for test session to: [09:28:54:INFO] /b/s/w/ioH9Guh8/12.1 iPhone X/attempt_0/1_Test/Diagnostics/ios_chrome_integration_egtests_module-A7A6B010-6437-4822-AA11-CD9A921859E2/ios_chrome_integration_egtests_module-42FCC2B2-8C38-4D54-930C-16C049C62AA8/Session-ios_chrome_integration_egtests_module-2019-03-23_212854-em6WjO.log [09:28:54:INFO] 2019-03-23 21:28:54.245 xcodebuild[34119:453397] [MT] IDETestOperationsObserverDebug: (F694A1EA-1DDD-4F9E-AF52-62FA6A19B5BC) Beginning test session ios_chrome_integration_egtests_module-F694A1EA-1DDD-4F9E-AF52-62FA6A19B5BC at 2019-03-23 21:28:54.245 with Xcode 10B61 on target <DVTiPhoneSimulator: 0x7fd0d8787ed0> { [09:28:54:INFO] SimDevice: Clone 4 of iPhone X (FF1C5065-23F4-47D1-BF90-483021EAC5C8, iOS 12.1, Shutdown) [09:28:54:INFO] } (12.1 (16B91)) [09:28:58:INFO] Test suite 'CredentialManagerEGTest' started on 'Clone 1 of iPhone X - ios_chrome_integration_egtests.app (34233)' [09:29:07:INFO] Test case '-[CredentialManagerEGTest testNotificationAppearsOnAutoSignIn]' passed on 'Clone 1 of iPhone X - ios_chrome_integration_egtests.app (34233)' (7.629 seconds) [09:29:13:INFO] Test case '-[CredentialManagerEGTest testNotificationAppearsWhenTabIsActive]' passed on 'Clone 1 of iPhone X - ios_chrome_integration_egtests.app (34233)' (5.653 seconds) [09:29:13:INFO] Test suite 'UKMTestCase' started on 'Clone 1 of iPhone X - ios_chrome_integration_egtests.app (34233)' [09:30:19:INFO] Test case '-[UKMTestCase testConsentAddedButNoSync]' passed on 'Clone 1 of iPhone X - ios_chrome_integration_egtests.app (34233)' (65.530 seconds) [09:30:40:INFO] Test suite 'NTPTilesTest' started on 'Clone 4 of iPhone X - ios_chrome_integration_egtests.app (34561)' [09:30:40:INFO] Test suite 'FormInputTestCase' started on 'Clone 2 of iPhone X - ios_chrome_integration_egtests.app (34564)' [09:30:50:INFO] Test case '-[FormInputTestCase testCloseKeyboardWhenNotVisible]' passed on 'Clone 2 of iPhone X - ios_chrome_integration_egtests.app (34564)' (7.031 seconds) [09:31:00:INFO] Test suite 'BrowserStateServicesTestCase' started on 'Clone 3 of iPhone X - ios_chrome_integration_egtests.app (34600)' [09:31:00:INFO] Test case '-[UKMTestCase testIncognitoPlusRegular]' passed on 'Clone 1 of iPhone X - ios_chrome_integration_egtests.app (34233)' (41.543 seconds) [09:31:02:INFO] Test case '-[NTPTilesTest testTopSitesTileAfterLoadURL]' passed on 'Clone 4 of iPhone X - ios_chrome_integration_egtests.app (34561)' (19.683 seconds) [09:31:03:INFO] Test case '-[FormInputTestCase testFindDefaultFormAssistControls]' passed on 'Clone 2 of iPhone X - ios_chrome_integration_egtests.app (34564)' (13.560 seconds) [09:31:04:INFO] Test suite 'HandoffManagerTestCase' started on 'Clone 2 of iPhone X - ios_chrome_integration_egtests.app (34564)' [09:31:09:INFO] Test case '-[BrowserStateServicesTestCase testConnectionToIdentityService]' passed on 'Clone 3 of iPhone X - ios_chrome_integration_egtests.app (34600)' (7.201 seconds) [09:31:09:INFO] Test suite 'TabUsageRecorderTestCase' started on 'Clone 3 of iPhone X - ios_chrome_integration_egtests.app (34600)' [09:31:20:INFO] Test case '-[HandoffManagerTestCase testMultipleSwitchingTabs]' passed on 'Clone 2 of iPhone X - ios_chrome_integration_egtests.app (34564)' (16.603 seconds) [09:31:25:INFO] Test case '-[HandoffManagerTestCase testNewTabPageEmptyURL]' passed on 'Clone 2 of iPhone X - ios_chrome_integration_egtests.app (34564)' (5.199 seconds) [09:31:32:INFO] Test case '-[TabUsageRecorderTestCase testEvictedTabReloadBackgrounded]' passed on 'Clone 3 of iPhone X - ios_chrome_integration_egtests.app (34600)' (22.807 seconds) [09:31:35:INFO] Test case '-[UKMTestCase testMetricsConsent]' passed on 'Clone 1 of iPhone X - ios_chrome_integration_egtests.app (34233)' (34.376 seconds) [09:31:42:INFO] Test case '-[HandoffManagerTestCase testSwitchBetweenNormalAndIncognitoTabs]' passed on 'Clone 2 of iPhone X - ios_chrome_integration_egtests.app (34564)' (16.334 seconds) [09:31:49:INFO] Test case '-[HandoffManagerTestCase testTypicalURL]' passed on 'Clone 2 of iPhone X - ios_chrome_integration_egtests.app (34564)' (7.021 seconds) [09:31:51:INFO] Test case '-[NTPTilesTest testTopSitesTileAfterRedirect]' failed on 'Clone 4 of iPhone X - ios_chrome_integration_egtests.app (34561)' (48.880 seconds) [09:31:51:INFO] Test suite 'CookiesTestCase' started on 'Clone 4 of iPhone X - ios_chrome_integration_egtests.app (34561)' [09:32:01:INFO] Test case '-[HandoffManagerTestCase testTypicalURLInNewIncognitoTab]' passed on 'Clone 2 of iPhone X - ios_chrome_integration_egtests.app (34564)' (12.536 seconds) [09:32:08:INFO] Test case '-[TabUsageRecorderTestCase testEvictedTabReloadSettingsAndBack]' passed on 'Clone 3 of iPhone X - ios_chrome_integration_egtests.app (34600)' (35.478 seconds) [09:32:10:INFO] Test case '-[HandoffManagerTestCase testTypicalURLInNewTab]' passed on 'Clone 2 of iPhone X - ios_chrome_integration_egtests.app (34564)' (9.101 seconds) [09:32:11:INFO] Test suite 'ContextMenuTestCase' started on 'Clone 2 of iPhone X - ios_chrome_integration_egtests.app (34564)' [09:32:19:INFO] Test case '-[CookiesTestCase testClearIncognitoFromIncognito]' passed on 'Clone 4 of iPhone X - ios_chrome_integration_egtests.app (34561)' (26.226 seconds) [09:32:22:INFO] Test case '-[ContextMenuTestCase testAppropriateContextMenu]' passed on 'Clone 2 of iPhone X - ios_chrome_integration_egtests.app (34564)' (11.524 seconds) [09:32:25:INFO] Test case '-[UKMTestCase testRegularPlusIncognito]' passed on 'Clone 1 of iPhone X - ios_chrome_integration_egtests.app (34233)' (50.240 seconds) [09:32:34:INFO] Test case '-[ContextMenuTestCase testContextMenuCancelSystemTouchesMetric]' passed on 'Clone 2 of iPhone X - ios_chrome_integration_egtests.app (34564)' (12.151 seconds) [09:32:36:INFO] Test case '-[TabUsageRecorderTestCase testEvictedTabReloadSwitchToNTP]' passed on 'Clone 3 of iPhone X - ios_chrome_integration_egtests.app (34600)' (28.004 seconds) [09:32:42:INFO] Test case '-[CookiesTestCase testClearIncognitoFromMain]' passed on 'Clone 4 of iPhone X - ios_chrome_integration_egtests.app (34561)' (22.865 seconds) [09:32:49:INFO] Test case '-[ContextMenuTestCase testContextMenuDisplayedOnImage]' passed on 'Clone 2 of iPhone X - ios_chrome_integration_egtests.app (34564)' (15.026 seconds) [09:33:00:INFO] Test case '-[ContextMenuTestCase testContextMenuElementFetchDurationMetric]' passed on 'Clone 2 of iPhone X - ios_chrome_integration_egtests.app (34564)' (11.078 seconds) [09:33:04:INFO] Test case '-[TabUsageRecorderTestCase testEvictedTabSlowReload]' passed on 'Clone 3 of iPhone X - ios_chrome_integration_egtests.app (34600)' (28.109 seconds) [09:33:04:INFO] Test case '-[CookiesTestCase testShareCookiesBetweenTabs]' passed on 'Clone 4 of iPhone X - ios_chrome_integration_egtests.app (34561)' (22.189 seconds) [09:33:13:INFO] Test case '-[ContextMenuTestCase testContextMenuOpenInNewTab]' passed on 'Clone 2 of iPhone X - ios_chrome_integration_egtests.app (34564)' (12.645 seconds) [09:33:22:INFO] Test case '-[ContextMenuTestCase testContextMenuSelectedTextCallout]' passed on 'Clone 2 of iPhone X - ios_chrome_integration_egtests.app (34564)' (8.818 seconds) [09:33:25:INFO] Test case '-[CookiesTestCase testSwitchToIncognito]' passed on 'Clone 4 of iPhone X - ios_chrome_integration_egtests.app (34561)' (20.883 seconds) [09:33:35:INFO] Test case '-[TabUsageRecorderTestCase testLinkClickNavigation]' passed on 'Clone 3 of iPhone X - ios_chrome_integration_egtests.app (34600)' (31.139 seconds) [09:33:38:INFO] Test case '-[ContextMenuTestCase testDismissContextMenu]' passed on 'Clone 2 of iPhone X - ios_chrome_integration_egtests.app (34564)' (15.773 seconds) [09:33:45:INFO] Test case '-[TabUsageRecorderTestCase testLiveTabReloadBackgrounded]' passed on 'Clone 3 of iPhone X - ios_chrome_integration_egtests.app (34600)' (9.761 seconds) [09:33:47:INFO] Test case '-[CookiesTestCase testSwitchToMain]' passed on 'Clone 4 of iPhone X - ios_chrome_integration_egtests.app (34561)' (21.399 seconds) [09:33:47:INFO] Test suite 'FeatureEngagementTestCase' started on 'Clone 4 of iPhone X - ios_chrome_integration_egtests.app (34561)' [09:33:50:INFO] Test case '-[ContextMenuTestCase testOpenImageInCurrentTabFromContextMenu]' passed on 'Clone 2 of iPhone X - ios_chrome_integration_egtests.app (34564)' (12.155 seconds) [09:33:54:INFO] Test case '-[TabUsageRecorderTestCase testOpenFromApp]' passed on 'Clone 3 of iPhone X - ios_chrome_integration_egtests.app (34600)' (9.336 seconds) [09:34:00:INFO] Test case '-[FeatureEngagementTestCase testBadgedReadingListFeatureReadingListAlreadyUsed]' passed on 'Clone 4 of iPhone X - ios_chrome_integration_egtests.app (34561)' (12.907 seconds) [09:34:01:INFO] Test case '-[UKMTestCase testSecondaryPassphrase]' passed on 'Clone 1 of iPhone X - ios_chrome_integration_egtests.app (34233)' (95.781 seconds) [09:34:04:INFO] Test case '-[ContextMenuTestCase testOpenImageInNewTabFromContextMenu]' passed on 'Clone 2 of iPhone X - ios_chrome_integration_egtests.app (34564)' (14.162 seconds) [09:34:04:INFO] Test suite 'PrerenderTestCase' started on 'Clone 2 of iPhone X - ios_chrome_integration_egtests.app (34564)' [09:34:10:INFO] Test case '-[TabUsageRecorderTestCase testOpenLinkInNewTab]' passed on 'Clone 3 of iPhone X - ios_chrome_integration_egtests.app (34600)' (15.620 seconds) [09:34:20:INFO] Test case '-[FeatureEngagementTestCase testBadgedReadingListFeatureShouldShow]' passed on 'Clone 4 of iPhone X - ios_chrome_integration_egtests.app (34561)' (20.073 seconds) [09:34:28:INFO] Test case '-[FeatureEngagementTestCase testBadgedReadingListFeatureTooFewChromeOpens]' passed on 'Clone 4 of iPhone X - ios_chrome_integration_egtests.app (34561)' (8.242 seconds) [09:34:34:INFO] Test case '-[FeatureEngagementTestCase testBottomToolbarDontAppearOnNonSplitToolbar]' passed on 'Clone 4 of iPhone X - ios_chrome_integration_egtests.app (34561)' (6.485 seconds) [09:34:44:INFO] Test case '-[PrerenderTestCase testTapPrerenderSuggestions]' passed on 'Clone 2 of iPhone X - ios_chrome_integration_egtests.app (34564)' (40.308 seconds) [09:34:47:INFO] Test case '-[FeatureEngagementTestCase testNewTabTipPromoShouldShow]' passed on 'Clone 4 of iPhone X - ios_chrome_integration_egtests.app (34561)' (12.735 seconds) [09:34:55:INFO] Test case '-[UKMTestCase testSingleDisableSync]' passed on 'Clone 1 of iPhone X - ios_chrome_integration_egtests.app (34233)' (54.351 seconds) [09:35:01:INFO] Test case '-[TabUsageRecorderTestCase testPageLoadCountBeforeEvictedTab]' passed on 'Clone 3 of iPhone X - ios_chrome_integration_egtests.app (34600)' (51.432 seconds) [09:35:22:INFO] Test case '-[TabUsageRecorderTestCase testPageRedirect]' passed on 'Clone 3 of iPhone X - ios_chrome_integration_egtests.app (34600)' (21.295 seconds) [09:35:40:INFO] Test case '-[TabUsageRecorderTestCase testTabDeletion]' passed on 'Clone 3 of iPhone X - ios_chrome_integration_egtests.app (34600)' (17.437 seconds) [09:35:50:INFO] Test case '-[UKMTestCase testSingleSyncSignout]' passed on 'Clone 1 of iPhone X - ios_chrome_integration_egtests.app (34233)' (54.934 seconds) [09:37:17:INFO] 2019-03-23 21:37:17.837 xcodebuild[34119:453397] [MT] IDETestOperationsObserverDebug: 528.358 elapsed -- Testing started completed. [09:37:17:INFO] 2019-03-23 21:37:17.837 xcodebuild[34119:453397] [MT] IDETestOperationsObserverDebug: 0.000 sec, +0.000 sec -- start [09:37:17:INFO] 2019-03-23 21:37:17.838 xcodebuild[34119:453397] [MT] IDETestOperationsObserverDebug: 528.358 sec, +528.358 sec -- end [09:37:17:INFO] Failing tests: [09:37:17:INFO] -[NTPTilesTest testTopSitesTileAfterRedirect] [09:37:17:INFO] ** TEST EXECUTE FAILED ** [09:37:17:INFO] [09:37:42:INFO] Command ['xcodebuild', 'test-without-building', '-xctestrun', '/b/s/w/ioH9Guh8/run_1553401708.xctestrun', '-destination', 'platform=iOS Simulator,OS=12.1,name=iPhone X', '-resultBundlePath', '/b/s/w/ioH9Guh8/12.1 iPhone X/attempt_0', '-parallel-testing-enabled', 'YES', '-parallel-testing-worker-count', '4'] finished with 65 [09:37:42:INFO] Start test attempt #1 for command [xcodebuild test-without-building -xctestrun /b/s/w/ioH9Guh8/run_1553402262.xctestrun -destination platform=iOS Simulator,OS=12.1,name=iPhone X -resultBundlePath /b/s/w/ioH9Guh8/12.1 iPhone X/attempt_1 -parallel-testing-enabled YES -parallel-testing-worker-count 1] [09:37:43:INFO] User defaults from command line: Screenshots for failure "-[NTPTilesTest testTopSitesTileAfterRedirect]" in "/b/s/w/ioH9Guh8/12.1 iPhone X/attempt_0/failures/NTPTilesTest_testTopSitesTileAfterRedirect" /b/s/w/ioH9Guh8/12.1 iPhone X/attempt_0/failures/NTPTilesTest_testTopSitesTileAfterRedirect/NTPTilesTest_testTopSitesTileAfterRedirect_before.png /b/s/w/ioH9Guh8/12.1 iPhone X/attempt_0/failures/NTPTilesTest_testTopSitesTileAfterRedirect/NTPTilesTest_testTopSitesTileAfterRedirect_after_actual.png /b/s/w/ioH9Guh8/12.1 iPhone X/attempt_0/failures/NTPTilesTest_testTopSitesTileAfterRedirect/NTPTilesTest_testTopSitesTileAfterRedirect.png /b/s/w/ioH9Guh8/12.1 iPhone X/attempt_0/failures/NTPTilesTest_testTopSitesTileAfterRedirect/NTPTilesTest_testTopSitesTileAfterRedirect_after_expected.png Launching ['xcodebuild', 'test-without-building', '-xctestrun', '/b/s/w/ioH9Guh8/run_1553402262.xctestrun', '-destination', 'platform=iOS Simulator,OS=12.1,name=iPhone X', '-resultBundlePath', '/b/s/w/ioH9Guh8/12.1 iPhone X/attempt_1', '-parallel-testing-enabled', 'YES', '-parallel-testing-worker-count', '1'] with env {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'MAC_CHROMIUM_TMPDIR': '/b/s/w/itbLEGkV', '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': 'build767-m4', 'VIRTUAL_ENV': '/b/s/w/ir/.swarming_module_cache/vpython/b6ec90', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.gYy7Wkg8KX/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/itbLEGkV/luci_ctx.QjRyOS.json', 'CIPD_CACHE_DIR': '/b/s/cipd_cache/cache', 'XPC_SERVICE_NAME': 'org.swarm.bot.plist', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.NIkISitVNy/Listeners', 'VPYTHON_VIRTUALENV_ROOT': '/b/s/w/ir/.swarming_module_cache/vpython', 'SWARMING_TASK_ID': '43c6c6351600a611', 'SHELL': '/bin/bash', 'NO_GCE_CHECK': 'False', 'TMPDIR': '/b/s/w/itbLEGkV', 'CIPD_PROTOCOL': 'v2', '__CF_USER_TEXT_ENCODING': '0x1F4:0x0:0x0', 'NSUnbufferedIO': 'YES'} [09:37:43:INFO] IDEBuildOperationResultBundlePath = /b/s/w/ioH9Guh8/12.1 iPhone X/attempt_1 [09:37:43:INFO] IDETestRunSpecificationPath = /b/s/w/ioH9Guh8/run_1553402262.xctestrun [09:37:43:INFO] [09:37:43:INFO] Testing started on 'iPhone X' [09:37:43:INFO] 2019-03-23 21:37:43.486 xcodebuild[35880:473973] IDETestOperationsObserverDebug: Writing diagnostic log for test session to: [09:37:43:INFO] /b/s/w/ioH9Guh8/12.1 iPhone X/attempt_1/1_Test/Diagnostics/ios_chrome_integration_egtests_module-D664471C-6A9E-4434-846F-99376224649C/ios_chrome_integration_egtests_module-C18ECB74-3F4C-49FB-8274-E29F6616547A/Session-ios_chrome_integration_egtests_module-2019-03-23_213743-ipk7NX.log [09:37:43:INFO] 2019-03-23 21:37:43.486 xcodebuild[35880:473814] [MT] IDETestOperationsObserverDebug: (5C49EE4C-43A5-4514-884D-EC9243C487D8) Beginning test session ios_chrome_integration_egtests_module-5C49EE4C-43A5-4514-884D-EC9243C487D8 at 2019-03-23 21:37:43.487 with Xcode 10B61 on target <DVTiPhoneSimulator: 0x7ff7654cb1f0> { [09:37:43:INFO] SimDevice: Clone 1 of iPhone X (65FBBCA8-6157-48E3-8980-BFCA40B9C513, iOS 12.1, Shutdown) [09:37:43:INFO] } (12.1 (16B91)) [09:38:06:INFO] Test suite 'NTPTilesTest' started on 'Clone 1 of iPhone X - ios_chrome_integration_egtests.app (35989)' [09:38:39:INFO] Test case '-[NTPTilesTest testTopSitesTileAfterRedirect]' passed on 'Clone 1 of iPhone X - ios_chrome_integration_egtests.app (35989)' (26.701 seconds) [09:38:40:INFO] 2019-03-23 21:38:40.123 xcodebuild[35880:473814] [MT] IDETestOperationsObserverDebug: 56.922 elapsed -- Testing started completed. [09:38:40:INFO] 2019-03-23 21:38:40.123 xcodebuild[35880:473814] [MT] IDETestOperationsObserverDebug: 0.000 sec, +0.000 sec -- start [09:38:40:INFO] 2019-03-23 21:38:40.123 xcodebuild[35880:473814] [MT] IDETestOperationsObserverDebug: 56.922 sec, +56.922 sec -- end [09:38:40:INFO] ** TEST EXECUTE SUCCEEDED ** [09:38:40:INFO] [09:38:46:INFO] Command ['xcodebuild', 'test-without-building', '-xctestrun', '/b/s/w/ioH9Guh8/run_1553402262.xctestrun', '-destination', 'platform=iOS Simulator,OS=12.1,name=iPhone X', '-resultBundlePath', '/b/s/w/ioH9Guh8/12.1 iPhone X/attempt_1', '-parallel-testing-enabled', 'YES', '-parallel-testing-worker-count', '1'] finished with 0 [09:38:46:DEBUG] Test ended. [09:38:46:DEBUG] Extracting test data. [09:38:46:DEBUG] Retrieving crash reports. [09:38:46:DEBUG] Retrieving derived data. [09:38:46:DEBUG] Making desktop screenshots. [09:38:46:DEBUG] Killing simulators. [09:38:51:DEBUG] Wiping simulator. Device wiped. [09:38:52:DEBUG] End of tear_down. 2019-03-23 21:39:40,916 - root: [DEBUG] Contents of task_output_dir: ['/b/s/w/ir/k/recipe_cleanup/0YvaShH/43c6c6351600a610'] 2019-03-23 21:39:40,916 - root: [WARNING] Expected output.json file missing: set(['/b/s/w/ir/k/recipe_cleanup/0YvaShH/43c6c6351600a610/output.json']) Found: [] Expected: ['/b/s/w/ir/k/recipe_cleanup/0YvaShH/43c6c6351600a610/output.json'] 2019-03-23 21:39:40,917 - root: [WARNING] No shard json files found in task_output_dir: '/b/s/w/ir/k/recipe_cleanup/0YvaShH' Found ['/b/s/w/ir/k/recipe_cleanup/0YvaShH/43c6c6351600a610'] 2019-03-23 21:39:40,917 - root: [DEBUG] Found shard_json_files: ['/b/s/w/ir/k/recipe_cleanup/0YvaShH/43c6c6351600a610/output.json'] 2019-03-23 21:39:40,917 - 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/tmpMtk9GP.json --task-output-dir /b/s/w/ir/k/recipe_cleanup/0YvaShH -o /b/s/w/ir/tmp/t/tmpriPtuY.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/tmpMtk9GP.json', '--task-output-dir', '/b/s/w/ir/k/recipe_cleanup/0YvaShH', '-o', '/b/s/w/ir/tmp/t/tmpriPtuY.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/tmpMtk9GP.json', '--task-output-dir', '/b/s/w/ir/k/recipe_cleanup/0YvaShH', '-o', '/b/s/w/ir/tmp/t/tmpriPtuY.json'] returned exit code 0