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/tmpKgl64u.json --task-output-dir /b/s/w/ir/k/recipe_cleanup/0GqpKrP --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/tmppw6jZVmerge_script_log --merge-additional-args '[]' --summary-json-file /b/s/w/ir/tmp/t/tmpnDupWf.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/tmpJVwzyj.json in dir /b/s/w/ir/k: allow_subannotations: False base_name: 'ios_chrome_integration_egtests (iPhone X iOS 12.1) on Mac-10.13.6' 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/tmpKgl64u.json', '--task-output-dir', '/b/s/w/ir/k/recipe_cleanup/0GqpKrP', '--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/tmppw6jZVmerge_script_log', '--merge-additional-args', '[]', '--summary-json-file', '/b/s/w/ir/tmp/t/tmpnDupWf.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/tmpJVwzyj.json'] env: {} env_prefixes: {'PATH': '/b/s/w/ir/cache/swarming_client'} env_suffixes: {} infra_step: False name: 'ios_chrome_integration_egtests (iPhone X iOS 12.1) on Mac-10.13.6' nest_level: 0 ok_ret: frozenset([0]) step_test_data: <lambda>(...) trigger_specs: () full environment: Apple_PubSub_Socket_Render: /private/tmp/com.apple.launchd.2sVTT5xEAX/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: 55721 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/8919510525749022720 LOGDOG_STREAM_PROJECT: chromium LOGDOG_STREAM_SERVER_PATH: unix:/b/s/w/ir/tmp/ld.sock LOGNAME: chrome-bot LUCI_CONTEXT: /b/s/w/itCSXPkd/luci_context.339208732 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.z99Yhbl5cD/Listeners SWARMING_BOT_ID: vm1094-m4 SWARMING_HEADLESS: 1 SWARMING_SERVER: https://chromium-swarm.appspot.com SWARMING_TASK_ID: 437886f9f8bc7111 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-08 16:07:23,361 - root: [DEBUG] Using task_output_dir: '/b/s/w/ir/k/recipe_cleanup/0GqpKrP' 2019-03-08 16:07:23,361 - root: [WARNING] task_output_dir '/b/s/w/ir/k/recipe_cleanup/0GqpKrP' already exists! 2019-03-08 16:07:23,362 - root: [WARNING] task_output_dir existing content: [] 2019-03-08 16:07:23,362 - 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/tmpJVwzyj.json -output-dir /b/s/w/ir/k/recipe_cleanup/0GqpKrP -task-summary-json /b/s/w/ir/tmp/t/tmpnDupWf.json [D2019-03-08T16:07:23.384225-08:00 81833 0 auth.go:1265] Minting a new token {"key":"luci_ctx/25e56bfd3b62485793b90b7bbdb4d5d65ca5bd2f0d964e399b24939692f2ce11", "scopes":"https://www.googleapis.com/auth/userinfo.email"} [D2019-03-08T16:07:23.384344-08:00 81833 0 luci_ctx.go:138] POST http://127.0.0.1:55710/rpc/LuciLocalAuthService.GetOAuthToken {"key":"luci_ctx/25e56bfd3b62485793b90b7bbdb4d5d65ca5bd2f0d964e399b24939692f2ce11", "scopes":"https://www.googleapis.com/auth/userinfo.email"} [D2019-03-08T16:07:23.386351-08:00 81833 0 auth.go:1222] Token expires in 57m35.613674s {"key":"luci_ctx/25e56bfd3b62485793b90b7bbdb4d5d65ca5bd2f0d964e399b24939692f2ce11", "scopes":"https://www.googleapis.com/auth/userinfo.email"} [D2019-03-08T16:07:25.031751-08:00 81833 0 collect.go:344] Waiting task_id: 4378968b5b256710 [D2019-03-08T16:07:26.525521-08:00 81833 0 collect.go:344] Waiting task_id: 4378968b5b256710 [D2019-03-08T16:07:28.023457-08:00 81833 0 collect.go:344] Waiting task_id: 4378968b5b256710 [D2019-03-08T16:07:29.553095-08:00 81833 0 collect.go:344] Waiting task_id: 4378968b5b256710 [D2019-03-08T16:07:31.056718-08:00 81833 0 collect.go:344] Waiting task_id: 4378968b5b256710 [D2019-03-08T16:07:32.616825-08:00 81833 0 collect.go:344] Waiting task_id: 4378968b5b256710 [D2019-03-08T16:07:34.306815-08:00 81833 0 collect.go:344] Waiting task_id: 4378968b5b256710 [D2019-03-08T16:07:36.019728-08:00 81833 0 collect.go:344] Waiting task_id: 4378968b5b256710 [D2019-03-08T16:07:37.708219-08:00 81833 0 collect.go:344] Waiting task_id: 4378968b5b256710 [D2019-03-08T16:07:39.543543-08:00 81833 0 collect.go:344] Waiting task_id: 4378968b5b256710 [D2019-03-08T16:07:41.411188-08:00 81833 0 collect.go:344] Waiting task_id: 4378968b5b256710 [D2019-03-08T16:07:43.304590-08:00 81833 0 collect.go:344] Waiting task_id: 4378968b5b256710 [D2019-03-08T16:07:45.440795-08:00 81833 0 collect.go:344] Waiting task_id: 4378968b5b256710 [D2019-03-08T16:07:47.505831-08:00 81833 0 collect.go:344] Waiting task_id: 4378968b5b256710 [D2019-03-08T16:07:49.634212-08:00 81833 0 collect.go:344] Waiting task_id: 4378968b5b256710 [D2019-03-08T16:07:51.897335-08:00 81833 0 collect.go:344] Waiting task_id: 4378968b5b256710 [D2019-03-08T16:07:54.248089-08:00 81833 0 collect.go:344] Waiting task_id: 4378968b5b256710 [D2019-03-08T16:07:56.590845-08:00 81833 0 collect.go:344] Waiting task_id: 4378968b5b256710 [D2019-03-08T16:07:59.109045-08:00 81833 0 collect.go:344] Waiting task_id: 4378968b5b256710 [D2019-03-08T16:08:01.582997-08:00 81833 0 collect.go:344] Waiting task_id: 4378968b5b256710 [D2019-03-08T16:08:04.140664-08:00 81833 0 collect.go:344] Waiting task_id: 4378968b5b256710 [D2019-03-08T16:08:06.801801-08:00 81833 0 collect.go:344] Waiting task_id: 4378968b5b256710 [D2019-03-08T16:08:09.511798-08:00 81833 0 collect.go:344] Waiting task_id: 4378968b5b256710 [D2019-03-08T16:08:12.298977-08:00 81833 0 collect.go:344] Waiting task_id: 4378968b5b256710 [D2019-03-08T16:08:15.313117-08:00 81833 0 collect.go:344] Waiting task_id: 4378968b5b256710 [D2019-03-08T16:08:18.358213-08:00 81833 0 collect.go:344] Waiting task_id: 4378968b5b256710 [D2019-03-08T16:08:21.518491-08:00 81833 0 collect.go:344] Waiting task_id: 4378968b5b256710 [D2019-03-08T16:08:24.786999-08:00 81833 0 collect.go:344] Waiting task_id: 4378968b5b256710 [D2019-03-08T16:08:28.217694-08:00 81833 0 collect.go:344] Waiting task_id: 4378968b5b256710 [D2019-03-08T16:08:31.771488-08:00 81833 0 collect.go:344] Waiting task_id: 4378968b5b256710 [D2019-03-08T16:08:35.402146-08:00 81833 0 collect.go:344] Waiting task_id: 4378968b5b256710 [D2019-03-08T16:08:39.139346-08:00 81833 0 collect.go:344] Waiting task_id: 4378968b5b256710 [D2019-03-08T16:08:42.962413-08:00 81833 0 collect.go:344] Waiting task_id: 4378968b5b256710 [D2019-03-08T16:08:46.922000-08:00 81833 0 collect.go:344] Waiting task_id: 4378968b5b256710 [D2019-03-08T16:08:51.273935-08:00 81833 0 collect.go:344] Waiting task_id: 4378968b5b256710 [D2019-03-08T16:08:55.560794-08:00 81833 0 collect.go:344] Waiting task_id: 4378968b5b256710 [D2019-03-08T16:08:59.908353-08:00 81833 0 collect.go:344] Waiting task_id: 4378968b5b256710 [D2019-03-08T16:09:04.409521-08:00 81833 0 collect.go:344] Waiting task_id: 4378968b5b256710 [D2019-03-08T16:09:09.109065-08:00 81833 0 collect.go:344] Waiting task_id: 4378968b5b256710 [D2019-03-08T16:09:15.807492-08:00 81833 0 collect.go:344] Waiting task_id: 4378968b5b256710 [D2019-03-08T16:09:20.869309-08:00 81833 0 collect.go:344] Waiting task_id: 4378968b5b256710 [D2019-03-08T16:09:26.112934-08:00 81833 0 collect.go:344] Waiting task_id: 4378968b5b256710 [D2019-03-08T16:09:31.496561-08:00 81833 0 collect.go:344] Waiting task_id: 4378968b5b256710 [D2019-03-08T16:09:37.022076-08:00 81833 0 collect.go:344] Waiting task_id: 4378968b5b256710 [D2019-03-08T16:09:42.857461-08:00 81833 0 collect.go:344] Waiting task_id: 4378968b5b256710 [D2019-03-08T16:09:48.801297-08:00 81833 0 collect.go:344] Waiting task_id: 4378968b5b256710 [D2019-03-08T16:09:54.971149-08:00 81833 0 collect.go:344] Waiting task_id: 4378968b5b256710 [D2019-03-08T16:10:01.401596-08:00 81833 0 collect.go:344] Waiting task_id: 4378968b5b256710 [D2019-03-08T16:10:07.946778-08:00 81833 0 collect.go:344] Waiting task_id: 4378968b5b256710 [D2019-03-08T16:10:14.800229-08:00 81833 0 collect.go:344] Waiting task_id: 4378968b5b256710 [D2019-03-08T16:10:21.808604-08:00 81833 0 collect.go:344] Waiting task_id: 4378968b5b256710 [D2019-03-08T16:10:29.017438-08:00 81833 0 collect.go:344] Waiting task_id: 4378968b5b256710 [D2019-03-08T16:10:36.924000-08:00 81833 0 collect.go:344] Waiting task_id: 4378968b5b256710 [D2019-03-08T16:10:44.734059-08:00 81833 0 collect.go:344] Waiting task_id: 4378968b5b256710 [D2019-03-08T16:10:52.763956-08:00 81833 0 collect.go:344] Waiting task_id: 4378968b5b256710 [D2019-03-08T16:11:01.236553-08:00 81833 0 collect.go:344] Waiting task_id: 4378968b5b256710 [D2019-03-08T16:11:09.835889-08:00 81833 0 collect.go:344] Waiting task_id: 4378968b5b256710 [D2019-03-08T16:11:18.730816-08:00 81833 0 collect.go:344] Waiting task_id: 4378968b5b256710 [D2019-03-08T16:11:27.930250-08:00 81833 0 collect.go:344] Waiting task_id: 4378968b5b256710 [D2019-03-08T16:11:37.419292-08:00 81833 0 collect.go:344] Waiting task_id: 4378968b5b256710 [D2019-03-08T16:11:47.283976-08:00 81833 0 collect.go:344] Waiting task_id: 4378968b5b256710 [D2019-03-08T16:11:57.449106-08:00 81833 0 collect.go:344] Waiting task_id: 4378968b5b256710 [D2019-03-08T16:12:07.861475-08:00 81833 0 collect.go:344] Waiting task_id: 4378968b5b256710 [D2019-03-08T16:12:18.720773-08:00 81833 0 collect.go:344] Waiting task_id: 4378968b5b256710 [D2019-03-08T16:12:29.976135-08:00 81833 0 collect.go:344] Waiting task_id: 4378968b5b256710 [D2019-03-08T16:12:41.468126-08:00 81833 0 collect.go:344] Waiting task_id: 4378968b5b256710 [D2019-03-08T16:12:53.416695-08:00 81833 0 collect.go:344] Waiting task_id: 4378968b5b256710 [D2019-03-08T16:13:06.870514-08:00 81833 0 collect.go:344] Waiting task_id: 4378968b5b256710 [D2019-03-08T16:13:19.798235-08:00 81833 0 collect.go:344] Waiting task_id: 4378968b5b256710 [D2019-03-08T16:13:33.012248-08:00 81833 0 collect.go:344] Waiting task_id: 4378968b5b256710 [D2019-03-08T16:13:46.672134-08:00 81833 0 collect.go:344] Waiting task_id: 4378968b5b256710 [D2019-03-08T16:14:00.789017-08:00 81833 0 collect.go:344] Waiting task_id: 4378968b5b256710 [D2019-03-08T16:14:15.338528-08:00 81833 0 collect.go:344] Waiting task_id: 4378968b5b256710 [D2019-03-08T16:14:30.431283-08:00 81833 0 collect.go:344] Waiting task_id: 4378968b5b256710 [D2019-03-08T16:14:45.754775-08:00 81833 0 collect.go:344] Waiting task_id: 4378968b5b256710 [D2019-03-08T16:15:00.994027-08:00 81833 0 collect.go:344] Waiting task_id: 4378968b5b256710 [D2019-03-08T16:15:16.295934-08:00 81833 0 collect.go:344] Waiting task_id: 4378968b5b256710 [D2019-03-08T16:15:31.734852-08:00 81833 0 collect.go:344] Waiting task_id: 4378968b5b256710 [D2019-03-08T16:15:47.144692-08:00 81833 0 collect.go:344] Waiting task_id: 4378968b5b256710 [D2019-03-08T16:16:02.454305-08:00 81833 0 collect.go:344] Waiting task_id: 4378968b5b256710 [D2019-03-08T16:16:17.850974-08:00 81833 0 collect.go:344] Waiting task_id: 4378968b5b256710 [D2019-03-08T16:16:33.199336-08:00 81833 0 collect.go:344] Waiting task_id: 4378968b5b256710 [D2019-03-08T16:16:48.492944-08:00 81833 0 collect.go:344] Waiting task_id: 4378968b5b256710 [D2019-03-08T16:17:03.786948-08:00 81833 0 collect.go:344] Waiting task_id: 4378968b5b256710 [D2019-03-08T16:17:19.176625-08:00 81833 0 collect.go:344] Waiting task_id: 4378968b5b256710 [D2019-03-08T16:17:34.505956-08:00 81833 0 collect.go:344] Waiting task_id: 4378968b5b256710 [D2019-03-08T16:17:49.752288-08:00 81833 0 collect.go:344] Waiting task_id: 4378968b5b256710 [D2019-03-08T16:18:05.120014-08:00 81833 0 collect.go:344] Waiting task_id: 4378968b5b256710 [D2019-03-08T16:18:20.429035-08:00 81833 0 collect.go:344] Waiting task_id: 4378968b5b256710 [D2019-03-08T16:18:35.733488-08:00 81833 0 collect.go:344] Waiting task_id: 4378968b5b256710 [D2019-03-08T16:18:51.021470-08:00 81833 0 collect.go:344] Waiting task_id: 4378968b5b256710 [D2019-03-08T16:19:06.381531-08:00 81833 0 collect.go:344] Waiting task_id: 4378968b5b256710 [D2019-03-08T16:19:21.686438-08:00 81833 0 collect.go:344] Waiting task_id: 4378968b5b256710 [D2019-03-08T16:19:36.956091-08:00 81833 0 collect.go:344] Waiting task_id: 4378968b5b256710 [D2019-03-08T16:19:52.248534-08:00 81833 0 collect.go:344] Waiting task_id: 4378968b5b256710 [D2019-03-08T16:20:07.533433-08:00 81833 0 collect.go:344] Waiting task_id: 4378968b5b256710 [D2019-03-08T16:20:22.823919-08:00 81833 0 collect.go:344] Waiting task_id: 4378968b5b256710 [D2019-03-08T16:20:38.185891-08:00 81833 0 collect.go:344] Waiting task_id: 4378968b5b256710 [D2019-03-08T16:20:53.492735-08:00 81833 0 collect.go:344] Waiting task_id: 4378968b5b256710 [D2019-03-08T16:21:08.949655-08:00 81833 0 collect.go:344] Waiting task_id: 4378968b5b256710 [D2019-03-08T16:21:24.213895-08:00 81833 0 collect.go:344] Waiting task_id: 4378968b5b256710 [D2019-03-08T16:21:39.552748-08:00 81833 0 collect.go:344] Waiting task_id: 4378968b5b256710 [D2019-03-08T16:21:54.939567-08:00 81833 0 collect.go:344] Waiting task_id: 4378968b5b256710 [D2019-03-08T16:22:10.304638-08:00 81833 0 collect.go:344] Waiting task_id: 4378968b5b256710 [D2019-03-08T16:22:25.568970-08:00 81833 0 collect.go:344] Waiting task_id: 4378968b5b256710 [D2019-03-08T16:22:40.835113-08:00 81833 0 collect.go:344] Waiting task_id: 4378968b5b256710 [D2019-03-08T16:22:56.076995-08:00 81833 0 collect.go:344] Waiting task_id: 4378968b5b256710 [D2019-03-08T16:23:11.652801-08:00 81833 0 collect.go:344] Waiting task_id: 4378968b5b256710 [D2019-03-08T16:23:27.284819-08:00 81833 0 collect.go:344] Waiting task_id: 4378968b5b256710 [D2019-03-08T16:23:42.586777-08:00 81833 0 collect.go:344] Waiting task_id: 4378968b5b256710 [D2019-03-08T16:23:57.956414-08:00 81833 0 collect.go:344] Waiting task_id: 4378968b5b256710 [D2019-03-08T16:24:13.214093-08:00 81833 0 collect.go:344] Waiting task_id: 4378968b5b256710 [D2019-03-08T16:24:28.453050-08:00 81833 0 collect.go:344] Waiting task_id: 4378968b5b256710 [D2019-03-08T16:24:43.765237-08:00 81833 0 collect.go:344] Waiting task_id: 4378968b5b256710 [D2019-03-08T16:24:59.030579-08:00 81833 0 collect.go:344] Waiting task_id: 4378968b5b256710 [D2019-03-08T16:25:14.324660-08:00 81833 0 collect.go:344] Waiting task_id: 4378968b5b256710 [D2019-03-08T16:25:29.691528-08:00 81833 0 collect.go:344] Waiting task_id: 4378968b5b256710 [D2019-03-08T16:25:45.107312-08:00 81833 0 collect.go:344] Waiting task_id: 4378968b5b256710 [D2019-03-08T16:26:00.341944-08:00 81833 0 collect.go:344] Waiting task_id: 4378968b5b256710 [D2019-03-08T16:26:15.577153-08:00 81833 0 collect.go:344] Waiting task_id: 4378968b5b256710 [D2019-03-08T16:26:30.830082-08:00 81833 0 collect.go:344] Waiting task_id: 4378968b5b256710 [D2019-03-08T16:26:46.090043-08:00 81833 0 collect.go:344] Waiting task_id: 4378968b5b256710 [D2019-03-08T16:27:01.477535-08:00 81833 0 collect.go:344] Waiting task_id: 4378968b5b256710 [D2019-03-08T16:27:16.812784-08:00 81833 0 collect.go:344] Waiting task_id: 4378968b5b256710 [D2019-03-08T16:27:32.163574-08:00 81833 0 collect.go:344] Waiting task_id: 4378968b5b256710 [D2019-03-08T16:27:47.478045-08:00 81833 0 collect.go:344] Waiting task_id: 4378968b5b256710 [D2019-03-08T16:28:02.844586-08:00 81833 0 collect.go:344] Waiting task_id: 4378968b5b256710 [D2019-03-08T16:28:18.173519-08:00 81833 0 collect.go:344] Waiting task_id: 4378968b5b256710 [D2019-03-08T16:28:33.536207-08:00 81833 0 collect.go:344] Waiting task_id: 4378968b5b256710 [D2019-03-08T16:28:49.067302-08:00 81833 0 collect.go:344] Waiting task_id: 4378968b5b256710 [D2019-03-08T16:29:04.412539-08:00 81833 0 collect.go:344] Waiting task_id: 4378968b5b256710 [D2019-03-08T16:29:19.753244-08:00 81833 0 collect.go:344] Waiting task_id: 4378968b5b256710 [D2019-03-08T16:29:35.006430-08:00 81833 0 collect.go:344] Waiting task_id: 4378968b5b256710 [D2019-03-08T16:29:50.273469-08:00 81833 0 collect.go:344] Waiting task_id: 4378968b5b256710 [D2019-03-08T16:30:05.537975-08:00 81833 0 collect.go:344] Waiting task_id: 4378968b5b256710 [D2019-03-08T16:30:20.884692-08:00 81833 0 collect.go:344] Waiting task_id: 4378968b5b256710 [D2019-03-08T16:30:36.171150-08:00 81833 0 collect.go:344] Waiting task_id: 4378968b5b256710 [D2019-03-08T16:30:51.868955-08:00 81833 0 collect.go:344] Waiting task_id: 4378968b5b256710 [D2019-03-08T16:31:07.136559-08:00 81833 0 collect.go:344] Waiting task_id: 4378968b5b256710 [D2019-03-08T16:31:22.466546-08:00 81833 0 collect.go:344] Waiting task_id: 4378968b5b256710 [D2019-03-08T16:31:37.758433-08:00 81833 0 collect.go:344] Waiting task_id: 4378968b5b256710 [D2019-03-08T16:31:53.283824-08:00 81833 0 collect.go:344] Waiting task_id: 4378968b5b256710 [D2019-03-08T16:32:08.749247-08:00 81833 0 collect.go:344] Waiting task_id: 4378968b5b256710 [D2019-03-08T16:32:24.070302-08:00 81833 0 collect.go:344] Waiting task_id: 4378968b5b256710 [D2019-03-08T16:32:39.477007-08:00 81833 0 collect.go:344] Waiting task_id: 4378968b5b256710 [D2019-03-08T16:32:54.871546-08:00 81833 0 collect.go:344] Waiting task_id: 4378968b5b256710 [D2019-03-08T16:33:10.369500-08:00 81833 0 collect.go:344] Waiting task_id: 4378968b5b256710 [D2019-03-08T16:33:25.922890-08:00 81833 0 collect.go:344] Waiting task_id: 4378968b5b256710 [D2019-03-08T16:33:41.249300-08:00 81833 0 collect.go:344] Waiting task_id: 4378968b5b256710 [D2019-03-08T16:33:56.625034-08:00 81833 0 collect.go:344] Waiting task_id: 4378968b5b256710 [D2019-03-08T16:34:11.943764-08:00 81833 0 collect.go:344] Waiting task_id: 4378968b5b256710 [D2019-03-08T16:34:27.240141-08:00 81833 0 collect.go:344] Waiting task_id: 4378968b5b256710 [D2019-03-08T16:34:42.563491-08:00 81833 0 collect.go:344] Waiting task_id: 4378968b5b256710 [D2019-03-08T16:34:57.940466-08:00 81833 0 collect.go:344] Waiting task_id: 4378968b5b256710 [D2019-03-08T16:35:13.194422-08:00 81833 0 collect.go:344] Waiting task_id: 4378968b5b256710 [D2019-03-08T16:35:28.638310-08:00 81833 0 collect.go:344] Waiting task_id: 4378968b5b256710 [D2019-03-08T16:35:43.955570-08:00 81833 0 collect.go:344] Waiting task_id: 4378968b5b256710 [D2019-03-08T16:35:59.221239-08:00 81833 0 collect.go:344] Waiting task_id: 4378968b5b256710 [D2019-03-08T16:36:14.585704-08:00 81833 0 collect.go:344] Waiting task_id: 4378968b5b256710 [D2019-03-08T16:36:29.965452-08:00 81833 0 collect.go:344] Waiting task_id: 4378968b5b256710 [D2019-03-08T16:36:45.360270-08:00 81833 0 collect.go:344] Waiting task_id: 4378968b5b256710 [D2019-03-08T16:37:00.827058-08:00 81833 0 collect.go:344] Waiting task_id: 4378968b5b256710 [D2019-03-08T16:37:16.148521-08:00 81833 0 collect.go:344] Waiting task_id: 4378968b5b256710 [D2019-03-08T16:37:31.556488-08:00 81833 0 collect.go:344] Waiting task_id: 4378968b5b256710 [D2019-03-08T16:37:47.257567-08:00 81833 0 collect.go:344] Waiting task_id: 4378968b5b256710 [D2019-03-08T16:38:02.557649-08:00 81833 0 collect.go:344] Waiting task_id: 4378968b5b256710 [D2019-03-08T16:38:17.976108-08:00 81833 0 collect.go:344] Waiting task_id: 4378968b5b256710 [D2019-03-08T16:38:33.315204-08:00 81833 0 collect.go:344] Waiting task_id: 4378968b5b256710 [D2019-03-08T16:38:48.671949-08:00 81833 0 collect.go:344] Waiting task_id: 4378968b5b256710 [D2019-03-08T16:39:03.992189-08:00 81833 0 collect.go:344] Waiting task_id: 4378968b5b256710 [D2019-03-08T16:39:19.325550-08:00 81833 0 collect.go:344] Waiting task_id: 4378968b5b256710 [D2019-03-08T16:39:34.620287-08:00 81833 0 collect.go:344] Waiting task_id: 4378968b5b256710 [D2019-03-08T16:39:49.972173-08:00 81833 0 collect.go:344] Waiting task_id: 4378968b5b256710 [D2019-03-08T16:40:05.287358-08:00 81833 0 collect.go:344] Waiting task_id: 4378968b5b256710 [D2019-03-08T16:40:20.574935-08:00 81833 0 collect.go:344] Waiting task_id: 4378968b5b256710 [D2019-03-08T16:40:35.970818-08:00 81833 0 collect.go:344] Waiting task_id: 4378968b5b256710 [D2019-03-08T16:40:51.322220-08:00 81833 0 collect.go:344] Waiting task_id: 4378968b5b256710 4378968b5b256710: exit 0 [I 2019-03-08 16:31:38] About to install Xcode 10b61 in Xcode.app for ios [04:31:40:INFO] Using Xcode version 10.1 build 10B61 at /b/s/w/ir/Xcode.app/Contents/Developer [04:31:40:INFO] Erasing all simulators. [04:31:49:INFO] Start test attempt #0 for command [xcodebuild test-without-building -xctestrun /b/s/w/ioH0RCjG/run_1552091509.xctestrun -destination platform=iOS Simulator,OS=12.1,name=iPhone X -resultBundlePath /b/s/w/ioH0RCjG/12.1 iPhone X/attempt_0 -parallel-testing-enabled YES -parallel-testing-worker-count 3] [04:31:49:INFO] Launching ['xcodebuild', 'test-without-building', '-xctestrun', '/b/s/w/ioH0RCjG/run_1552091509.xctestrun', '-destination', 'platform=iOS Simulator,OS=12.1,name=iPhone X', '-resultBundlePath', '/b/s/w/ioH0RCjG/12.1 iPhone X/attempt_0', '-parallel-testing-enabled', 'YES', '-parallel-testing-worker-count', '3'] with env {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'MAC_CHROMIUM_TMPDIR': '/b/s/w/it_xuc28', '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/80b654/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': 'vm345-m9', 'VIRTUAL_ENV': '/b/s/w/ir/.swarming_module_cache/vpython/80b654', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7tiLmRfXUa/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/it_xuc28/luci_ctx._hKfT6.json', 'CIPD_CACHE_DIR': '/b/s/cipd_cache/cache', 'XPC_SERVICE_NAME': 'org.swarm.bot.plist', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.NiXvv3fO4h/Listeners', 'VPYTHON_VIRTUALENV_ROOT': '/b/s/w/ir/.swarming_module_cache/vpython', 'SWARMING_TASK_ID': '4378968b5b256711', 'SHELL': '/bin/bash', 'NO_GCE_CHECK': 'False', 'TMPDIR': '/b/s/w/it_xuc28', 'CIPD_PROTOCOL': 'v2', '__CF_USER_TEXT_ENCODING': '0x1F4:0x0:0x0', 'NSUnbufferedIO': 'YES'} [04:31:50:INFO] User defaults from command line: [04:31:50:INFO] IDEBuildOperationResultBundlePath = /b/s/w/ioH0RCjG/12.1 iPhone X/attempt_0 [04:31:50:INFO] IDETestRunSpecificationPath = /b/s/w/ioH0RCjG/run_1552091509.xctestrun [04:31:50:INFO] [04:31:50:INFO] Testing started on 'iPhone X' [04:31:50:INFO] 2019-03-08 16:31:50.641 xcodebuild[28786:4378925] IDETestOperationsObserverDebug: Writing diagnostic log for test session to: [04:31:50:INFO] /b/s/w/ioH0RCjG/12.1 iPhone X/attempt_0/1_Test/Diagnostics/ios_chrome_integration_egtests_module-C5F331D0-D9E5-4C70-A450-2E17726E0A5F/ios_chrome_integration_egtests_module-E07B9568-BB66-4B26-9318-0ECEC6E21D42/Session-ios_chrome_integration_egtests_module-2019-03-08_163150-Mkp9iH.log [04:31:50:INFO] 2019-03-08 16:31:50.642 xcodebuild[28786:4378902] [MT] IDETestOperationsObserverDebug: (8B62BE35-8663-49D2-972B-E3BB2E0B5229) Beginning test session ios_chrome_integration_egtests_module-8B62BE35-8663-49D2-972B-E3BB2E0B5229 at 2019-03-08 16:31:50.642 with Xcode 10B61 on target <DVTiPhoneSimulator: 0x7f9413b681d0> { [04:31:50:INFO] SimDevice: Clone 1 of iPhone X (1E7515DE-6018-4F4F-AFAB-12EC1D06B34F, iOS 12.1, Shutdown) [04:31:50:INFO] } (12.1 (16B91)) [04:32:10:INFO] 2019-03-08 16:32:10.874 xcodebuild[28786:4379018] IDETestOperationsObserverDebug: Writing diagnostic log for test session to: [04:32:10:INFO] /b/s/w/ioH0RCjG/12.1 iPhone X/attempt_0/1_Test/Diagnostics/ios_chrome_integration_egtests_module-C5F331D0-D9E5-4C70-A450-2E17726E0A5F/ios_chrome_integration_egtests_module-60DE4F8F-2DDA-4D5C-AD7F-482B8E981356/Session-ios_chrome_integration_egtests_module-2019-03-08_163210-zFnKth.log [04:32:10:INFO] 2019-03-08 16:32:10.875 xcodebuild[28786:4378902] [MT] IDETestOperationsObserverDebug: (9333EAC6-EA7D-49AA-B943-895E8BDC57F6) Beginning test session ios_chrome_integration_egtests_module-9333EAC6-EA7D-49AA-B943-895E8BDC57F6 at 2019-03-08 16:32:10.875 with Xcode 10B61 on target <DVTiPhoneSimulator: 0x7f940ee7cf10> { [04:32:10:INFO] SimDevice: Clone 3 of iPhone X (1DB3C77C-A203-48A3-B120-9C625AA1FC37, iOS 12.1, Shutdown) [04:32:10:INFO] } (12.1 (16B91)) [04:32:10:INFO] 2019-03-08 16:32:10.878 xcodebuild[28786:4379917] IDETestOperationsObserverDebug: Writing diagnostic log for test session to: [04:32:10:INFO] /b/s/w/ioH0RCjG/12.1 iPhone X/attempt_0/1_Test/Diagnostics/ios_chrome_integration_egtests_module-C5F331D0-D9E5-4C70-A450-2E17726E0A5F/ios_chrome_integration_egtests_module-84AAB58D-CA54-4F35-8E4C-7580B2B4C319/Session-ios_chrome_integration_egtests_module-2019-03-08_163210-ofyEbc.log [04:32:10:INFO] 2019-03-08 16:32:10.879 xcodebuild[28786:4378902] [MT] IDETestOperationsObserverDebug: (C41C3A2C-02EA-49FE-8E5B-399FF50A2C17) Beginning test session ios_chrome_integration_egtests_module-C41C3A2C-02EA-49FE-8E5B-399FF50A2C17 at 2019-03-08 16:32:10.879 with Xcode 10B61 on target <DVTiPhoneSimulator: 0x7f941385ccd0> { [04:32:10:INFO] SimDevice: Clone 2 of iPhone X (DC852051-92F8-4499-A962-1CB716DEB455, iOS 12.1, Shutdown) [04:32:10:INFO] } (12.1 (16B91)) [04:32:17:INFO] Test suite 'CredentialManagerEGTest' started on 'Clone 1 of iPhone X - ios_chrome_integration_egtests.app (28903)' [04:32:23:INFO] Test case '-[CredentialManagerEGTest testNotificationAppearsOnAutoSignIn]' passed on 'Clone 1 of iPhone X - ios_chrome_integration_egtests.app (28903)' (4.206 seconds) [04:32:28:INFO] Test case '-[CredentialManagerEGTest testNotificationAppearsWhenTabIsActive]' passed on 'Clone 1 of iPhone X - ios_chrome_integration_egtests.app (28903)' (5.054 seconds) [04:32:28:INFO] Test suite 'UKMTestCase' started on 'Clone 1 of iPhone X - ios_chrome_integration_egtests.app (28903)' [04:32:53:INFO] Test suite 'FormInputTestCase' started on 'Clone 2 of iPhone X - ios_chrome_integration_egtests.app (29134)' [04:32:57:INFO] Test suite 'NTPTilesTest' started on 'Clone 3 of iPhone X - ios_chrome_integration_egtests.app (29138)' [04:32:59:INFO] Test case '-[FormInputTestCase testCloseKeyboardWhenNotVisible]' passed on 'Clone 2 of iPhone X - ios_chrome_integration_egtests.app (29134)' (4.875 seconds) [04:33:13:INFO] Test case '-[NTPTilesTest testTopSitesTileAfterLoadURL]' passed on 'Clone 3 of iPhone X - ios_chrome_integration_egtests.app (29138)' (13.095 seconds) [04:33:13:INFO] Test case '-[FormInputTestCase testFindDefaultFormAssistControls]' passed on 'Clone 2 of iPhone X - ios_chrome_integration_egtests.app (29134)' (13.330 seconds) [04:33:13:INFO] Test suite 'BrowserStateServicesTestCase' started on 'Clone 2 of iPhone X - ios_chrome_integration_egtests.app (29134)' [04:33:17:INFO] Test case '-[BrowserStateServicesTestCase testConnectionToIdentityService]' passed on 'Clone 2 of iPhone X - ios_chrome_integration_egtests.app (29134)' (4.152 seconds) [04:33:17:INFO] Test suite 'HandoffManagerTestCase' started on 'Clone 2 of iPhone X - ios_chrome_integration_egtests.app (29134)' [04:33:30:INFO] Test case '-[HandoffManagerTestCase testMultipleSwitchingTabs]' passed on 'Clone 2 of iPhone X - ios_chrome_integration_egtests.app (29134)' (13.100 seconds) [04:33:34:INFO] Test case '-[HandoffManagerTestCase testNewTabPageEmptyURL]' passed on 'Clone 2 of iPhone X - ios_chrome_integration_egtests.app (29134)' (3.961 seconds) [04:33:45:INFO] Test case '-[HandoffManagerTestCase testSwitchBetweenNormalAndIncognitoTabs]' passed on 'Clone 2 of iPhone X - ios_chrome_integration_egtests.app (29134)' (11.166 seconds) [04:33:49:INFO] Test case '-[NTPTilesTest testTopSitesTileAfterRedirect]' passed on 'Clone 3 of iPhone X - ios_chrome_integration_egtests.app (29138)' (36.181 seconds) [04:33:49:INFO] Test suite 'TabUsageRecorderTestCase' started on 'Clone 3 of iPhone X - ios_chrome_integration_egtests.app (29138)' [04:33:50:INFO] Test case '-[HandoffManagerTestCase testTypicalURL]' passed on 'Clone 2 of iPhone X - ios_chrome_integration_egtests.app (29134)' (5.202 seconds) [04:33:58:INFO] Test case '-[UKMTestCase testConsentAddedButNoSync]' passed on 'Clone 1 of iPhone X - ios_chrome_integration_egtests.app (28903)' (89.788 seconds) [04:33:59:INFO] Test case '-[HandoffManagerTestCase testTypicalURLInNewIncognitoTab]' passed on 'Clone 2 of iPhone X - ios_chrome_integration_egtests.app (29134)' (9.043 seconds) [04:34:07:INFO] Test case '-[HandoffManagerTestCase testTypicalURLInNewTab]' passed on 'Clone 2 of iPhone X - ios_chrome_integration_egtests.app (29134)' (7.333 seconds) [04:34:07:INFO] Test suite 'CookiesTestCase' started on 'Clone 2 of iPhone X - ios_chrome_integration_egtests.app (29134)' [04:34:09:INFO] Test case '-[TabUsageRecorderTestCase testEvictedTabReloadBackgrounded]' passed on 'Clone 3 of iPhone X - ios_chrome_integration_egtests.app (29138)' (20.429 seconds) [04:34:25:INFO] Test case '-[CookiesTestCase testClearIncognitoFromIncognito]' passed on 'Clone 2 of iPhone X - ios_chrome_integration_egtests.app (29134)' (18.283 seconds) [04:34:38:INFO] Test case '-[UKMTestCase testIncognitoPlusRegular]' passed on 'Clone 1 of iPhone X - ios_chrome_integration_egtests.app (28903)' (40.062 seconds) [04:34:41:INFO] Test case '-[CookiesTestCase testClearIncognitoFromMain]' passed on 'Clone 2 of iPhone X - ios_chrome_integration_egtests.app (29134)' (15.849 seconds) [04:34:44:INFO] Test case '-[TabUsageRecorderTestCase testEvictedTabReloadSettingsAndBack]' passed on 'Clone 3 of iPhone X - ios_chrome_integration_egtests.app (29138)' (34.431 seconds) [04:34:50:INFO] Test case '-[CookiesTestCase testShareCookiesBetweenTabs]' passed on 'Clone 2 of iPhone X - ios_chrome_integration_egtests.app (29134)' (9.109 seconds) [04:35:04:INFO] Test case '-[CookiesTestCase testSwitchToIncognito]' passed on 'Clone 2 of iPhone X - ios_chrome_integration_egtests.app (29134)' (13.956 seconds) [04:35:07:INFO] Test case '-[TabUsageRecorderTestCase testEvictedTabReloadSwitchToNTP]' passed on 'Clone 3 of iPhone X - ios_chrome_integration_egtests.app (29138)' (22.821 seconds) [04:35:13:INFO] Test case '-[UKMTestCase testMetricsConsent]' passed on 'Clone 1 of iPhone X - ios_chrome_integration_egtests.app (28903)' (34.535 seconds) [04:35:20:INFO] Test case '-[CookiesTestCase testSwitchToMain]' passed on 'Clone 2 of iPhone X - ios_chrome_integration_egtests.app (29134)' (15.572 seconds) [04:35:20:INFO] Test suite 'ContextMenuTestCase' started on 'Clone 2 of iPhone X - ios_chrome_integration_egtests.app (29134)' [04:35:29:INFO] Test case '-[TabUsageRecorderTestCase testEvictedTabSlowReload]' passed on 'Clone 3 of iPhone X - ios_chrome_integration_egtests.app (29138)' (22.715 seconds) [04:35:32:INFO] Test case '-[ContextMenuTestCase testAppropriateContextMenu]' passed on 'Clone 2 of iPhone X - ios_chrome_integration_egtests.app (29134)' (11.808 seconds) [04:35:42:INFO] Test case '-[ContextMenuTestCase testContextMenuCancelSystemTouchesMetric]' passed on 'Clone 2 of iPhone X - ios_chrome_integration_egtests.app (29134)' (10.275 seconds) [04:35:53:INFO] Test case '-[TabUsageRecorderTestCase testLinkClickNavigation]' passed on 'Clone 3 of iPhone X - ios_chrome_integration_egtests.app (29138)' (24.215 seconds) [04:35:54:INFO] Test case '-[ContextMenuTestCase testContextMenuDisplayedOnImage]' passed on 'Clone 2 of iPhone X - ios_chrome_integration_egtests.app (29134)' (11.751 seconds) [04:35:59:INFO] Test case '-[UKMTestCase testRegularPlusIncognito]' passed on 'Clone 1 of iPhone X - ios_chrome_integration_egtests.app (28903)' (45.944 seconds) [04:36:01:INFO] Test case '-[TabUsageRecorderTestCase testLiveTabReloadBackgrounded]' passed on 'Clone 3 of iPhone X - ios_chrome_integration_egtests.app (29138)' (7.264 seconds) [04:36:03:INFO] Test case '-[ContextMenuTestCase testContextMenuElementFetchDurationMetric]' passed on 'Clone 2 of iPhone X - ios_chrome_integration_egtests.app (29134)' (9.585 seconds) [04:36:09:INFO] Test case '-[TabUsageRecorderTestCase testOpenFromApp]' passed on 'Clone 3 of iPhone X - ios_chrome_integration_egtests.app (29138)' (8.234 seconds) [04:36:14:INFO] Test case '-[ContextMenuTestCase testContextMenuOpenInNewTab]' passed on 'Clone 2 of iPhone X - ios_chrome_integration_egtests.app (29134)' (10.705 seconds) [04:36:21:INFO] Test case '-[ContextMenuTestCase testContextMenuSelectedTextCallout]' passed on 'Clone 2 of iPhone X - ios_chrome_integration_egtests.app (29134)' (6.861 seconds) [04:36:21:INFO] Test case '-[TabUsageRecorderTestCase testOpenLinkInNewTab]' passed on 'Clone 3 of iPhone X - ios_chrome_integration_egtests.app (29138)' (11.913 seconds) [04:36:36:INFO] Test case '-[ContextMenuTestCase testDismissContextMenu]' passed on 'Clone 2 of iPhone X - ios_chrome_integration_egtests.app (29134)' (14.868 seconds) [04:36:45:INFO] Test case '-[ContextMenuTestCase testOpenImageInCurrentTabFromContextMenu]' passed on 'Clone 2 of iPhone X - ios_chrome_integration_egtests.app (29134)' (9.731 seconds) [04:36:56:INFO] Test case '-[ContextMenuTestCase testOpenImageInNewTabFromContextMenu]' passed on 'Clone 2 of iPhone X - ios_chrome_integration_egtests.app (29134)' (10.882 seconds) [04:36:56:INFO] Test suite 'FeatureEngagementTestCase' started on 'Clone 2 of iPhone X - ios_chrome_integration_egtests.app (29134)' [04:37:08:INFO] Test case '-[TabUsageRecorderTestCase testPageLoadCountBeforeEvictedTab]' passed on 'Clone 3 of iPhone X - ios_chrome_integration_egtests.app (29138)' (46.886 seconds) [04:37:08:INFO] Test case '-[FeatureEngagementTestCase testBadgedReadingListFeatureReadingListAlreadyUsed]' passed on 'Clone 2 of iPhone X - ios_chrome_integration_egtests.app (29134)' (11.714 seconds) [04:37:22:INFO] Test case '-[FeatureEngagementTestCase testBadgedReadingListFeatureShouldShow]' passed on 'Clone 2 of iPhone X - ios_chrome_integration_egtests.app (29134)' (14.401 seconds) [04:37:27:INFO] Test case '-[UKMTestCase testSecondaryPassphrase]' passed on 'Clone 1 of iPhone X - ios_chrome_integration_egtests.app (28903)' (88.327 seconds) [04:37:30:INFO] Test case '-[FeatureEngagementTestCase testBadgedReadingListFeatureTooFewChromeOpens]' passed on 'Clone 2 of iPhone X - ios_chrome_integration_egtests.app (29134)' (7.353 seconds) [04:37:32:INFO] Test case '-[TabUsageRecorderTestCase testPageRedirect]' passed on 'Clone 3 of iPhone X - ios_chrome_integration_egtests.app (29138)' (24.404 seconds) [04:37:34:INFO] Test case '-[FeatureEngagementTestCase testBottomToolbarDontAppearOnNonSplitToolbar]' passed on 'Clone 2 of iPhone X - ios_chrome_integration_egtests.app (29134)' (3.994 seconds) [04:37:46:INFO] Test case '-[FeatureEngagementTestCase testNewTabTipPromoShouldShow]' passed on 'Clone 2 of iPhone X - ios_chrome_integration_egtests.app (29134)' (11.857 seconds) [04:37:46:INFO] Test suite 'PrerenderTestCase' started on 'Clone 2 of iPhone X - ios_chrome_integration_egtests.app (29134)' [04:37:48:INFO] Test case '-[TabUsageRecorderTestCase testTabDeletion]' passed on 'Clone 3 of iPhone X - ios_chrome_integration_egtests.app (29138)' (16.198 seconds) [04:38:20:INFO] Test case '-[PrerenderTestCase testTapPrerenderSuggestions]' passed on 'Clone 2 of iPhone X - ios_chrome_integration_egtests.app (29134)' (34.486 seconds) [04:38:21:INFO] Test case '-[UKMTestCase testSingleDisableSync]' passed on 'Clone 1 of iPhone X - ios_chrome_integration_egtests.app (28903)' (54.089 seconds) [04:39:24:INFO] Test case '-[UKMTestCase testSingleSyncSignout]' passed on 'Clone 1 of iPhone X - ios_chrome_integration_egtests.app (28903)' (62.801 seconds) [04:39:24:INFO] 2019-03-08 16:39:24.876 xcodebuild[28786:4378902] [MT] IDETestOperationsObserverDebug: 454.501 elapsed -- Testing started completed. [04:39:24:INFO] 2019-03-08 16:39:24.876 xcodebuild[28786:4378902] [MT] IDETestOperationsObserverDebug: 0.000 sec, +0.000 sec -- start [04:39:24:INFO] 2019-03-08 16:39:24.876 xcodebuild[28786:4378902] [MT] IDETestOperationsObserverDebug: 454.501 sec, +454.501 sec -- end [04:39:24:INFO] ** TEST EXECUTE SUCCEEDED ** [04:39:24:INFO] [04:39:43:INFO] Command ['xcodebuild', 'test-without-building', '-xctestrun', '/b/s/w/ioH0RCjG/run_1552091509.xctestrun', '-destination', 'platform=iOS Simulator,OS=12.1,name=iPhone X', '-resultBundlePath', '/b/s/w/ioH0RCjG/12.1 iPhone X/attempt_0', '-parallel-testing-enabled', 'YES', '-parallel-testing-worker-count', '3'] finished with 0 [04:39:43:DEBUG] self.logs: [04:39:43:DEBUG] {'failed': [], 'flaked': [], 'passed': ['CredentialManagerEGTest/testNotificationAppearsOnAutoSignIn', 'CredentialManagerEGTest/testNotificationAppearsWhenTabIsActive', 'UKMTestCase/testConsentAddedButNoSync', 'UKMTestCase/testIncognitoPlusRegular', 'UKMTestCase/testMetricsConsent', 'UKMTestCase/testRegularPlusIncognito', 'UKMTestCase/testSecondaryPassphrase', 'UKMTestCase/testSingleDisableSync', 'UKMTestCase/testSingleSyncSignout', 'FormInputTestCase/testCloseKeyboardWhenNotVisible', 'FormInputTestCase/testFindDefaultFormAssistControls', 'NTPTilesTest/testTopSitesTileAfterLoadURL', 'NTPTilesTest/testTopSitesTileAfterRedirect', 'BrowserStateServicesTestCase/testConnectionToIdentityService', 'HandoffManagerTestCase/testMultipleSwitchingTabs', 'HandoffManagerTestCase/testNewTabPageEmptyURL', 'HandoffManagerTestCase/testSwitchBetweenNormalAndIncognitoTabs', 'HandoffManagerTestCase/testTypicalURL', 'HandoffManagerTestCase/testTypicalURLInNewIncognitoTab', 'HandoffManagerTestCase/testTypicalURLInNewTab', 'TabUsageRecorderTestCase/testEvictedTabReloadBackgrounded', 'TabUsageRecorderTestCase/testEvictedTabReloadSettingsAndBack', 'TabUsageRecorderTestCase/testEvictedTabReloadSwitchToNTP', 'TabUsageRecorderTestCase/testEvictedTabSlowReload', 'TabUsageRecorderTestCase/testLinkClickNavigation', 'TabUsageRecorderTestCase/testLiveTabReloadBackgrounded', 'TabUsageRecorderTestCase/testOpenFromApp', 'TabUsageRecorderTestCase/testOpenLinkInNewTab', 'TabUsageRecorderTestCase/testPageLoadCountBeforeEvictedTab', 'TabUsageRecorderTestCase/testPageRedirect', 'TabUsageRecorderTestCase/testTabDeletion', 'CookiesTestCase/testClearIncognitoFromIncognito', 'CookiesTestCase/testClearIncognitoFromMain', 'CookiesTestCase/testShareCookiesBetweenTabs', 'CookiesTestCase/testSwitchToIncognito', 'CookiesTestCase/testSwitchToMain', 'ContextMenuTestCase/testAppropriateContextMenu', 'ContextMenuTestCase/testContextMenuCancelSystemTouchesMetric', 'ContextMenuTestCase/testContextMenuDisplayedOnImage', 'ContextMenuTestCase/testContextMenuElementFetchDurationMetric', 'ContextMenuTestCase/testContextMenuOpenInNewTab', 'ContextMenuTestCase/testContextMenuSelectedTextCallout', 'ContextMenuTestCase/testDismissContextMenu', 'ContextMenuTestCase/testOpenImageInCurrentTabFromContextMenu', 'ContextMenuTestCase/testOpenImageInNewTabFromContextMenu', 'FeatureEngagementTestCase/testBadgedReadingListFeatureReadingListAlreadyUsed', 'FeatureEngagementTestCase/testBadgedReadingListFeatureShouldShow', 'FeatureEngagementTestCase/testBadgedReadingListFeatureTooFewChromeOpens', 'FeatureEngagementTestCase/testBottomToolbarDontAppearOnNonSplitToolbar', 'FeatureEngagementTestCase/testNewTabTipPromoShouldShow', 'PrerenderTestCase/testTapPrerenderSuggestions']} 2019-03-08 16:40:51,965 - root: [DEBUG] Contents of task_output_dir: ['/b/s/w/ir/k/recipe_cleanup/0GqpKrP/4378968b5b256710'] 2019-03-08 16:40:51,966 - root: [WARNING] Expected output.json file missing: set(['/b/s/w/ir/k/recipe_cleanup/0GqpKrP/4378968b5b256710/output.json']) Found: [] Expected: ['/b/s/w/ir/k/recipe_cleanup/0GqpKrP/4378968b5b256710/output.json'] 2019-03-08 16:40:51,966 - root: [WARNING] No shard json files found in task_output_dir: '/b/s/w/ir/k/recipe_cleanup/0GqpKrP' Found ['/b/s/w/ir/k/recipe_cleanup/0GqpKrP/4378968b5b256710'] 2019-03-08 16:40:51,966 - root: [DEBUG] Found shard_json_files: ['/b/s/w/ir/k/recipe_cleanup/0GqpKrP/4378968b5b256710/output.json'] 2019-03-08 16:40:51,966 - 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/tmpnDupWf.json --task-output-dir /b/s/w/ir/k/recipe_cleanup/0GqpKrP -o /b/s/w/ir/tmp/t/tmpKgl64u.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/tmpnDupWf.json', '--task-output-dir', '/b/s/w/ir/k/recipe_cleanup/0GqpKrP', '-o', '/b/s/w/ir/tmp/t/tmpKgl64u.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/tmpnDupWf.json', '--task-output-dir', '/b/s/w/ir/k/recipe_cleanup/0GqpKrP', '-o', '/b/s/w/ir/tmp/t/tmpKgl64u.json'] returned exit code 0