[20:57:40.444] New invocation is queued and will start shortly
[20:57:41.558] Starting the invocation (attempt 1)
[20:57:41.598] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[20:57:41.598] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[20:57:41.598] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9018543766797653552",
"parameters_json": "{\"builder_name\":\"linux-chromeos-rel\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"a2927e33d04c24872f2ce8f5ff2297196e0ab83b\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:linux-chromeos-rel",
"scheduler_invocation_id:9018543766797653552",
"scheduler_job_id:chromium/linux-chromeos-rel",
"user_agent:luci-scheduler",
"buildset:commit/git/a2927e33d04c24872f2ce8f5ff2297196e0ab83b",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/a2927e33d04c24872f2ce8f5ff2297196e0ab83b",
"gitiles_ref:refs/heads/master"
]
}
[20:57:42.234] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1615409861695438",
"id": "8853113704821824784",
"parameters_json": "{\"builder_name\": \"linux-chromeos-rel\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"a2927e33d04c24872f2ce8f5ff2297196e0ab83b\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1615409862108641",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-rel/46059",
"builder:linux-chromeos-rel",
"buildset:commit/git/a2927e33d04c24872f2ce8f5ff2297196e0ab83b",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/a2927e33d04c24872f2ce8f5ff2297196e0ab83b",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9018543766797653552",
"scheduler_job_id:chromium/linux-chromeos-rel",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8853113704821824784/+/annotations",
"swarming_tag:luci_project:chromium",
"swarming_tag:recipe_name:chromium",
"swarming_tag:recipe_package:infra/recipe_bundles/chromium.googlesource.com/chromium/tools/build",
"swarming_task_id:",
"user_agent:luci-scheduler"
],
"updated_ts": "1615409862108827",
"url": "https://ci.chromium.org/b/8853113704821824784",
"utcnow_ts": "1615409862226598"
}
}
[20:57:42.234] Task URL: https://ci.chromium.org/b/8853113704821824784
[20:57:42.234] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018543766797653552:2:0) after 1m0s
[20:57:49.355] Received PubSub notification, asking Buildbucket for the build status
[20:57:49.430] Build 8853113704821824784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:58:42.328] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018543766797653552:2:0)
[20:58:42.328] Timer tick, asking Buildbucket for the build status
[20:58:42.421] Build 8853113704821824784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:58:42.421] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018543766797653552:4:0) after 1m0s
[20:59:42.477] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018543766797653552:4:0)
[20:59:42.477] Timer tick, asking Buildbucket for the build status
[20:59:42.572] Build 8853113704821824784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:59:42.572] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018543766797653552:5:0) after 1m0s
[21:00:42.612] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018543766797653552:5:0)
[21:00:42.612] Timer tick, asking Buildbucket for the build status
[21:00:42.739] Build 8853113704821824784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:00:42.739] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018543766797653552:6:0) after 1m0s
[21:01:42.780] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018543766797653552:6:0)
[21:01:42.780] Timer tick, asking Buildbucket for the build status
[21:01:42.865] Build 8853113704821824784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:01:42.865] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018543766797653552:7:0) after 1m0s
[21:02:42.943] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018543766797653552:7:0)
[21:02:42.943] Timer tick, asking Buildbucket for the build status
[21:02:43.040] Build 8853113704821824784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:02:43.040] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018543766797653552:8:0) after 1m0s
[21:03:43.084] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018543766797653552:8:0)
[21:03:43.084] Timer tick, asking Buildbucket for the build status
[21:03:43.350] Build 8853113704821824784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:03:43.350] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018543766797653552:9:0) after 1m0s
[21:04:43.411] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018543766797653552:9:0)
[21:04:43.411] Timer tick, asking Buildbucket for the build status
[21:04:44.901] Build 8853113704821824784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:04:44.901] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018543766797653552:10:0) after 1m0s
[21:05:44.917] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018543766797653552:10:0)
[21:05:44.917] Timer tick, asking Buildbucket for the build status
[21:05:44.993] Build 8853113704821824784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:05:44.993] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018543766797653552:11:0) after 1m0s
[21:06:45.050] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018543766797653552:11:0)
[21:06:45.050] Timer tick, asking Buildbucket for the build status
[21:06:45.322] Build 8853113704821824784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:06:45.322] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018543766797653552:12:0) after 1m0s
[21:07:45.421] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018543766797653552:12:0)
[21:07:45.421] Timer tick, asking Buildbucket for the build status
[21:07:45.591] Build 8853113704821824784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:07:45.591] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018543766797653552:13:0) after 1m0s
[21:08:45.654] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018543766797653552:13:0)
[21:08:45.654] Timer tick, asking Buildbucket for the build status
[21:08:45.717] Build 8853113704821824784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:08:45.717] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018543766797653552:14:0) after 1m0s
[21:09:45.795] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018543766797653552:14:0)
[21:09:45.795] Timer tick, asking Buildbucket for the build status
[21:09:45.975] Build 8853113704821824784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:09:45.975] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018543766797653552:15:0) after 1m0s
[21:10:46.039] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018543766797653552:15:0)
[21:10:46.039] Timer tick, asking Buildbucket for the build status
[21:10:46.111] Build 8853113704821824784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:10:46.111] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018543766797653552:16:0) after 1m0s
[21:11:46.212] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018543766797653552:16:0)
[21:11:46.212] Timer tick, asking Buildbucket for the build status
[21:11:46.296] Build 8853113704821824784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:11:46.296] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018543766797653552:17:0) after 1m0s
[21:12:46.334] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018543766797653552:17:0)
[21:12:46.334] Timer tick, asking Buildbucket for the build status
[21:12:46.410] Build 8853113704821824784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:12:46.410] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018543766797653552:18:0) after 1m0s
[21:13:46.488] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018543766797653552:18:0)
[21:13:46.488] Timer tick, asking Buildbucket for the build status
[21:13:46.562] Build 8853113704821824784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:13:46.562] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018543766797653552:19:0) after 1m0s
[21:14:46.584] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018543766797653552:19:0)
[21:14:46.584] Timer tick, asking Buildbucket for the build status
[21:14:46.662] Build 8853113704821824784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:14:46.662] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018543766797653552:20:0) after 1m0s
[21:15:46.654] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018543766797653552:20:0)
[21:15:46.654] Timer tick, asking Buildbucket for the build status
[21:15:46.739] Build 8853113704821824784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:15:46.739] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018543766797653552:21:0) after 1m0s
[21:16:46.760] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018543766797653552:21:0)
[21:16:46.760] Timer tick, asking Buildbucket for the build status
[21:16:46.837] Build 8853113704821824784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:16:46.837] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018543766797653552:22:0) after 1m0s
[21:17:46.900] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018543766797653552:22:0)
[21:17:46.900] Timer tick, asking Buildbucket for the build status
[21:17:47.149] Build 8853113704821824784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:17:47.149] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018543766797653552:23:0) after 1m0s
[21:18:47.170] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018543766797653552:23:0)
[21:18:47.170] Timer tick, asking Buildbucket for the build status
[21:18:47.248] Build 8853113704821824784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:18:47.248] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018543766797653552:24:0) after 1m0s
[21:19:47.328] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018543766797653552:24:0)
[21:19:47.328] Timer tick, asking Buildbucket for the build status
[21:19:47.747] Build 8853113704821824784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:19:47.747] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018543766797653552:25:0) after 1m0s
[21:20:47.814] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018543766797653552:25:0)
[21:20:47.814] Timer tick, asking Buildbucket for the build status
[21:20:47.885] Build 8853113704821824784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:20:47.885] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018543766797653552:26:0) after 1m0s
[21:21:48.049] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018543766797653552:26:0)
[21:21:48.049] Timer tick, asking Buildbucket for the build status
[21:21:48.111] Build 8853113704821824784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:21:48.111] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018543766797653552:27:0) after 1m0s
[21:22:48.259] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018543766797653552:27:0)
[21:22:48.259] Timer tick, asking Buildbucket for the build status
[21:22:48.370] Build 8853113704821824784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:22:48.370] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018543766797653552:28:0) after 1m0s
[21:23:48.459] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018543766797653552:28:0)
[21:23:48.459] Timer tick, asking Buildbucket for the build status
[21:23:48.598] Build 8853113704821824784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:23:48.598] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018543766797653552:29:0) after 1m0s
[21:24:48.566] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018543766797653552:29:0)
[21:24:48.566] Timer tick, asking Buildbucket for the build status
[21:24:48.743] Build 8853113704821824784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:24:48.744] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018543766797653552:30:0) after 1m0s
[21:25:48.786] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018543766797653552:30:0)
[21:25:48.786] Timer tick, asking Buildbucket for the build status
[21:25:48.940] Build 8853113704821824784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:25:48.940] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018543766797653552:31:0) after 1m0s
[21:26:48.993] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018543766797653552:31:0)
[21:26:48.993] Timer tick, asking Buildbucket for the build status
[21:26:49.094] Build 8853113704821824784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:26:49.094] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018543766797653552:32:0) after 1m0s
[21:27:49.136] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018543766797653552:32:0)
[21:27:49.136] Timer tick, asking Buildbucket for the build status
[21:27:49.344] Build 8853113704821824784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:27:49.344] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018543766797653552:33:0) after 1m0s
[21:28:49.344] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018543766797653552:33:0)
[21:28:49.344] Timer tick, asking Buildbucket for the build status
[21:28:49.458] Build 8853113704821824784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:28:49.458] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018543766797653552:34:0) after 1m0s
[21:29:49.424] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018543766797653552:34:0)
[21:29:49.424] Timer tick, asking Buildbucket for the build status
[21:29:49.611] Build 8853113704821824784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:29:49.611] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018543766797653552:35:0) after 1m0s
[21:30:49.627] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018543766797653552:35:0)
[21:30:49.627] Timer tick, asking Buildbucket for the build status
[21:30:49.695] Build 8853113704821824784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:30:49.695] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018543766797653552:36:0) after 1m0s
[21:31:49.836] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018543766797653552:36:0)
[21:31:49.836] Timer tick, asking Buildbucket for the build status
[21:31:49.908] Build 8853113704821824784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:31:49.908] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018543766797653552:37:0) after 1m0s
[21:32:49.964] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018543766797653552:37:0)
[21:32:49.964] Timer tick, asking Buildbucket for the build status
[21:32:50.047] Build 8853113704821824784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:32:50.047] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018543766797653552:38:0) after 1m0s
[21:33:50.132] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018543766797653552:38:0)
[21:33:50.133] Timer tick, asking Buildbucket for the build status
[21:33:50.192] Build 8853113704821824784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:33:50.192] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018543766797653552:39:0) after 1m0s
[21:34:50.218] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018543766797653552:39:0)
[21:34:50.218] Timer tick, asking Buildbucket for the build status
[21:34:50.358] Build 8853113704821824784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:34:50.358] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018543766797653552:40:0) after 1m0s
[21:35:50.394] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018543766797653552:40:0)
[21:35:50.394] Timer tick, asking Buildbucket for the build status
[21:35:50.568] Build 8853113704821824784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:35:50.568] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018543766797653552:41:0) after 1m0s
[21:36:50.609] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018543766797653552:41:0)
[21:36:50.609] Timer tick, asking Buildbucket for the build status
[21:36:50.683] Build 8853113704821824784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:36:50.683] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018543766797653552:42:0) after 1m0s
[21:37:50.804] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018543766797653552:42:0)
[21:37:50.804] Timer tick, asking Buildbucket for the build status
[21:37:50.993] Build 8853113704821824784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:37:50.993] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018543766797653552:43:0) after 1m0s
[21:38:51.007] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018543766797653552:43:0)
[21:38:51.007] Timer tick, asking Buildbucket for the build status
[21:38:51.094] Build 8853113704821824784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:38:51.094] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018543766797653552:44:0) after 1m0s
[21:39:51.153] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018543766797653552:44:0)
[21:39:51.153] Timer tick, asking Buildbucket for the build status
[21:39:51.222] Build 8853113704821824784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:39:51.222] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018543766797653552:45:0) after 1m0s
[21:40:51.329] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018543766797653552:45:0)
[21:40:51.329] Timer tick, asking Buildbucket for the build status
[21:40:55.727] Build 8853113704821824784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:40:55.727] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018543766797653552:46:0) after 1m0s
[21:41:55.778] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018543766797653552:46:0)
[21:41:55.778] Timer tick, asking Buildbucket for the build status
[21:41:56.058] Build 8853113704821824784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:41:56.058] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018543766797653552:47:0) after 1m0s
[21:42:56.102] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018543766797653552:47:0)
[21:42:56.102] Timer tick, asking Buildbucket for the build status
[21:42:56.226] Build 8853113704821824784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:42:56.226] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018543766797653552:48:0) after 1m0s
[21:43:56.348] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018543766797653552:48:0)
[21:43:56.348] Timer tick, asking Buildbucket for the build status
[21:43:56.732] Build 8853113704821824784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:43:56.732] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018543766797653552:49:0) after 1m0s
[21:44:56.794] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018543766797653552:49:0)
[21:44:56.794] Timer tick, asking Buildbucket for the build status
[21:44:56.876] Build 8853113704821824784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:44:56.876] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018543766797653552:50:0) after 1m0s
[21:45:56.883] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018543766797653552:50:0)
[21:45:56.883] Timer tick, asking Buildbucket for the build status
[21:45:56.965] Build 8853113704821824784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:45:56.965] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018543766797653552:51:0) after 1m0s
[21:46:57.011] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018543766797653552:51:0)
[21:46:57.011] Timer tick, asking Buildbucket for the build status
[21:46:57.108] Build 8853113704821824784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:46:57.108] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018543766797653552:52:0) after 1m0s
[21:47:57.126] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018543766797653552:52:0)
[21:47:57.126] Timer tick, asking Buildbucket for the build status
[21:47:57.213] Build 8853113704821824784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:47:57.213] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018543766797653552:53:0) after 1m0s
[21:48:57.248] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018543766797653552:53:0)
[21:48:57.248] Timer tick, asking Buildbucket for the build status
[21:48:57.331] Build 8853113704821824784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:48:57.331] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018543766797653552:54:0) after 1m0s
[21:49:57.463] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018543766797653552:54:0)
[21:49:57.463] Timer tick, asking Buildbucket for the build status
[21:49:57.566] Build 8853113704821824784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:49:57.566] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018543766797653552:55:0) after 1m0s
[21:50:57.623] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018543766797653552:55:0)
[21:50:57.623] Timer tick, asking Buildbucket for the build status
[21:50:57.718] Build 8853113704821824784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:50:57.718] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018543766797653552:56:0) after 1m0s
[21:51:58.037] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018543766797653552:56:0)
[21:51:58.037] Timer tick, asking Buildbucket for the build status
[21:51:58.327] Build 8853113704821824784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:51:58.327] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018543766797653552:57:0) after 1m0s
[21:52:58.307] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018543766797653552:57:0)
[21:52:58.307] Timer tick, asking Buildbucket for the build status
[21:52:58.415] Build 8853113704821824784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:52:58.415] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018543766797653552:58:0) after 1m0s
[21:53:58.412] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018543766797653552:58:0)
[21:53:58.412] Timer tick, asking Buildbucket for the build status
[21:53:58.839] Build 8853113704821824784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:53:58.839] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018543766797653552:59:0) after 1m0s
[21:54:58.884] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018543766797653552:59:0)
[21:54:58.884] Timer tick, asking Buildbucket for the build status
[21:54:59.058] Build 8853113704821824784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:54:59.058] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018543766797653552:60:0) after 1m0s
[21:55:59.095] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018543766797653552:60:0)
[21:55:59.095] Timer tick, asking Buildbucket for the build status
[21:55:59.192] Build 8853113704821824784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:55:59.192] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018543766797653552:61:0) after 1m0s
[21:56:59.203] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018543766797653552:61:0)
[21:56:59.203] Timer tick, asking Buildbucket for the build status
[21:56:59.291] Build 8853113704821824784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:56:59.291] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018543766797653552:62:0) after 1m0s
[21:57:59.339] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018543766797653552:62:0)
[21:57:59.339] Timer tick, asking Buildbucket for the build status
[21:57:59.496] Build 8853113704821824784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:57:59.496] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018543766797653552:63:0) after 1m0s
[21:58:59.463] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018543766797653552:63:0)
[21:58:59.463] Timer tick, asking Buildbucket for the build status
[21:58:59.538] Build 8853113704821824784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:58:59.538] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018543766797653552:64:0) after 1m0s
[21:59:59.647] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018543766797653552:64:0)
[21:59:59.647] Timer tick, asking Buildbucket for the build status
[21:59:59.719] Build 8853113704821824784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:59:59.719] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018543766797653552:65:0) after 1m0s
[22:00:01.927] Received PubSub notification, asking Buildbucket for the build status
[22:00:02.024] Build 8853113704821824784: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[22:00:02.024] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1615413601006020",
"created_by": "project:chromium",
"created_ts": "1615409861695438",
"id": "8853113704821824784",
"parameters_json": "{\"builder_name\": \"linux-chromeos-rel\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"a2927e33d04c24872f2ce8f5ff2297196e0ab83b\"}}",
"project": "chromium",
"result": "SUCCESS",
"result_details_json": "{\"properties\": {\"$build/goma\": {\"enable_ats\": true, \"rpc_extra_params\": \"?prod\", \"server_host\": \"goma.chromium.org\", \"use_luci_auth\": true}, \"$recipe_engine/isolated\": {\"server\": \"https://isolateserver.appspot.com\"}, \"$recipe_engine/milo/blamelist_pins\": [{\"host\": \"chromium.googlesource.com\", \"id\": \"a2927e33d04c24872f2ce8f5ff2297196e0ab83b\", \"project\": \"chromium/src\"}], \"$recipe_engine/path\": {\"cache_dir\": \"/b/s/w/ir/cache\", \"temp_dir\": \"/b/s/w/ir/tmp/rt\"}, \"$recipe_engine/runtime\": {\"is_experimental\": false, \"is_luci\": true}, \"bot_id\": \"luci-chromium-ci-xenial-us-central1-b-8-138-5n7s\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.chromiumos\", \"buildername\": \"linux-chromeos-rel\", \"buildnumber\": 46059, \"got_angle_revision\": \"b2f547f4f423f492c4483d901d1b3ad5f3ad8798\", \"got_dawn_revision\": \"6d4617a2d28d8d3d4aa946abdbabb368d025b6b7\", \"got_nacl_revision\": \"abf3277f295c6c87f0b103f291ed5e3e73933b76\", \"got_revision\": \"a2927e33d04c24872f2ce8f5ff2297196e0ab83b\", \"got_revision_cp\": \"refs/heads/master@{#861642}\", \"got_swarming_client_revision\": \"a32a1607f6093d338f756c7e7c7b4333b0c50c9c\", \"got_swiftshader_revision\": \"023914a27b634063766fee96f2e6763513f5b059\", \"got_v8_revision\": \"de5df026428a7e343abb139064e99eac24cd2404\", \"got_v8_revision_cp\": \"refs/heads/9.1.90@{#1}\", \"got_webrtc_revision\": \"92d12707e00837a978485f731d72ef30cf19d2a2\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#33402}\", \"is_cached\": true, \"isolate_server\": \"https://isolateserver.appspot.com\", \"mirrored_builders\": [\"tryserver.chromium.chromiumos:linux-chromeos-inverse-fieldtrials-fyi-rel\", \"tryserver.chromium.chromiumos:linux-chromeos-rel\"], \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"a2927e33d04c24872f2ce8f5ff2297196e0ab83b\", \"swarm_hashes_refs/heads/master(at){#861642}_without_patch\": {\"absl_hardening_tests\": \"86590b4886ccb02d03c4c676f01c24912d6b73d3\", \"accessibility_unittests\": \"eb93740cdeddd381a68d49b89cc75f48ecd79317\", \"angle_unittests\": \"15735b639022eb4a6e3f0b6b2762aaa6e0fd3ef5\", \"app_list_unittests\": \"d664df58a7b03faffabdbf678b4f492d4b6d03f8\", \"app_shell_unittests\": \"0397d1c6557526e411c3b4af5da490ddd9b655c1\", \"ash_unittests\": \"f59a7feee00f055f8b48e4543f9933e537802a69\", \"aura_unittests\": \"46c736b606b4212604877a16180459db049d7863\", \"base_unittests\": \"f3b992c75be44ab2badbc0a2e6c3c6e2cdb555c9\", \"base_util_unittests\": \"a449369db290d35adffd89d3310398123361c67b\", \"blink_common_unittests\": \"d0ea9f08bfe1c50618c0023b5b137d4eb40597f7\", \"blink_fuzzer_unittests\": \"44fd0bb7c7579eb47c5384cbc85c3360675a2534\", \"blink_heap_unittests\": \"43b6c5b81b04de41fd58aeaff055dc40c07099ca\", \"blink_platform_unittests\": \"0c6e2cdee863d3de3591a7027213d420c90d8475\", \"blink_unittests\": \"ce693b8f806be84e376078c4d11f7ad59f0150e1\", \"boringssl_crypto_tests\": \"d3022473a63251cd52d1ed2750270452834901ae\", \"boringssl_ssl_tests\": \"0586d3807a505e920757309629bb975786bbb559\", \"browser_tests\": \"b3e0b5fc22b752cc1497c8f9b8c85f5a76a6ea20\", \"capture_unittests\": \"88cb15bd68483999fb9db4455a7721764e4fe3a5\", \"cast_unittests\": \"7cc3f65be219d4dc86eca814f67ab0cb091b256d\", \"cc_unittests\": \"26b8af6e795de175068f4f5d574116e56bc9fbdd\", \"chrome_app_unittests\": \"9e2d31242912a89e51b4f70d944bdea5189ca149\", \"chromedriver_unittests\": \"8bae762bff5a6208635f5437cb438f352024b9a7\", \"chromeos_components_unittests\": \"86d09aeb9d926e7d23f2a61ba9c11d8e43ee282c\", \"chromeos_unittests\": \"72f8d459cb33f53e437b09184cfcbf462e044c88\", \"color_unittests\": \"93b8d8f7de06018e44b7b953a6a201f62163978c\", \"components_browsertests\": \"e53ff96dc68c0fada8d1426e2e5bc3baa474c074\", \"components_unittests\": \"24d17c9b107dead0d2012593cb5b520e3fd62a75\", \"compositor_unittests\": \"bafd2d31ce9090a586688667f0908f926ac6c2f6\", \"content_browsertests\": \"1e2b2ec3f5d9f762f935d04721f99dab76df5952\", \"content_unittests\": \"effe4a73c9186266b00a284184c1045dc4ea8fca\", \"crashpad_tests\": \"199e7ae8460972718b66ca4bdda3925da1e45116\", \"crypto_unittests\": \"8e74f33dc48c4ebe7ea72ae4a609d5324f52b4b2\", \"dbus_unittests\": \"dd03602603ac26fd0d7813ea87f2967d6476e68b\", \"device_unittests\": \"a557e82664d3bbb6c7174089220404a2c4cd08c6\", \"display_unittests\": \"4788c36139504e399a97aac2a8796093eb14e3aa\", \"events_unittests\": \"cd2cfa1ea128172754fef24d8e948e1ac9405489\", \"exo_unittests\": \"e151fd95d732a49486613c014305552bba816ab6\", \"extensions_browsertests\": \"99c288285b5cf128e58e1667fb9aafbdbe7e4ebc\", \"extensions_unittests\": \"910cbd5bae2dc0ffcbe65b63d659d070ea2868ff\", \"filesystem_service_unittests\": \"84176f8c35bc4c7dc236ea0cfd43cb57c00f9602\", \"gcm_unit_tests\": \"75a390dcbfc0478188a276b2f7836a1a2bd23cc4\", \"gfx_unittests\": \"73f19be339decc3e66863ccfb8f3b444bb2a4cf8\", \"gin_unittests\": \"ed27c65b7e0dbee327b4c570436c0653a27dcad9\", \"gl_unittests_ozone\": \"be5581e4f751322f8915455b9e997248f54871a0\", \"google_apis_unittests\": \"07a6cc89ac2ba5dc54a6f1025055a08b3dab6b4b\", \"gpu_unittests\": \"804da51e971e76e69114bc7967343770109f3ae9\", \"gwp_asan_unittests\": \"123748ba4515472c4bfcf81a9258cb306e7eeaaf\", \"interactive_ui_tests\": \"246163e81827396d55382c2f6cc6c2135de919a1\", \"ipc_tests\": \"3aa686df10fcec9b5a235f18048ef52e57808578\", \"jingle_unittests\": \"3d8f5ab2ce176e2b0ab2a00c6eb786b06db1f1c8\", \"keyboard_unittests\": \"38bb31c908529f88ad40d7c6d31a2cb656c1f647\", \"latency_unittests\": \"67db2c4281bb90d89e1d4824a52fcee8db920dd0\", \"libjingle_xmpp_unittests\": \"4e42692f1bcfdc0ac64970cc9b3d22f30832833b\", \"liburlpattern_unittests\": \"99703259746d3f63800d2d2faffd1be098547e6e\", \"media_blink_unittests\": \"4bae6d80200385c2ad735a9517f6bf92f03963bb\", \"media_unittests\": \"6d548596616f8930b2b5fdf4c023bfe05f308c21\", \"message_center_unittests\": \"a27841fe75f2e0229700ce64f3a77eb36f317f20\", \"midi_unittests\": \"38f404d5a5395953728491bc6c5b9a9f4e01f885\", \"mojo_core_unittests\": \"bb5897b4aba79f714df345613cc715ac6c0ebffd\", \"mojo_unittests\": \"da5af5c4ed0b43bc105215c4d44efd638cebd537\", \"nacl_helper_nonsfi_unittests\": \"5b7a2aac6dff16ffb0ee730f33dd69a636c9a733\", \"nacl_loader_unittests\": \"d5af16f58701ff7509e1f641984f993b4b21beb2\", \"native_theme_unittests\": \"9fc6a2571a6ce130002c33705e8c3a5ddc635159\", \"net_unittests\": \"9f30f71a1aa2d8a90b62e7c4b382ac549d619465\", \"ozone_gl_unittests\": \"14eb0826234c9bed74b1529649cdbbade6235a1a\", \"ozone_unittests\": \"6f44457270de7dea6119249157313903962b7791\", \"ozone_x11_unittests\": \"1ccd539ec4da7a81c671aa9a5e503b674bc7ce72\", \"pdf_unittests\": \"332b70bcc165b1180694dc9a541222a2684a223f\", \"perfetto_unittests\": \"1bd87b17277d8941d32fcc3f123f72c59626ffe4\", \"ppapi_unittests\": \"b489aa715a776cc8e95b84f6e58c7d59d415efb2\", \"printing_unittests\": \"64525456906369f76e5afd8aa53a1b4d100ed0b1\", \"remoting_unittests\": \"6a6e6ef9cfd8600c3e4c80c65ed6f5a7c8449d3b\", \"sandbox_linux_unittests\": \"7ff3aa441bd45fbf02b536fcfcc2f4c6cb4ff01c\", \"service_manager_unittests\": \"7abd9026360b987f5734e138c949b57b20059fcc\", \"services_unittests\": \"0bd02268e7e27538a3f7826fd8b76331b0720b0a\", \"shell_dialogs_unittests\": \"7c363531617d6a0d135cb0399a2c1ce17e1b64c3\", \"shell_encryption_unittests\": \"1891fdace2eaf09a010b3993cfcf9065f282c920\", \"skia_unittests\": \"d8f8d8cf6c3877fa2c84285d0215632956e2bba9\", \"snapshot_unittests\": \"dfef2a45ca6a4264f70c934420a7e14f01ebd1ad\", \"sql_unittests\": \"9c4b372f74a942640e89b27f64849e222a037723\", \"storage_unittests\": \"3a22dd89b51f7d8100a460bf7ab5a969ca389270\", \"sync_integration_tests\": \"4d38b82bf2350e11fdec8165cf8c0e02fab8ebef\", \"traffic_annotation_auditor_unittests\": \"484d6e10842eba7b1ab4ae899d73d98e37b92004\", \"ui_base_unittests\": \"cc2a40903d6b302494f4c753c0ec984caca2638e\", \"ui_chromeos_unittests\": \"882ee30043f339b41b2733cd41f36a75756cf0fb\", \"ui_touch_selection_unittests\": \"02f58cf0195702c67d43bb1828d0c35f460c7f42\", \"unit_tests\": \"a91604026dc2d1be0b05c87ad9b1bcd372b37333\", \"url_unittests\": \"7270efa02892bfcecdc8f270778f886ec3a6c0b4\", \"usage_time_limit_unittests\": \"1f389020191efa6d718647ada59fd1e096978bc4\", \"views_unittests\": \"1c6ec081d71db536f85eca5461e8964ef91f62a5\", \"viz_unittests\": \"771594a479efc28f20891c85acbcc830b7f530e3\", \"wayland_client_perftests\": \"8005893b26d960e70aa81735d70baf0d2c656c54\", \"wayland_client_tests\": \"e7ad0ec85ddb43cac7063177a570c79292c22da7\", \"wm_unittests\": \"d10e5024257350b681ce8304cf209140bc3c1258\", \"wtf_unittests\": \"9760015468fa630ad3640932b1a16af8ad07e98d\", \"zlib_unittests\": \"75c21e43ee4d90b046e87657851915b7d54094be\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_2b25d58305a6755482534765a65f2521477c19af0731994631a8cf25b9f3b571_v2\", \"builder_62c898de6588ca5d707c8045ecb6f8a7746948ea4311f8836fa952d6f41dbc73_v2\", \"builder_94fa3119a28f4651cdd4fc5b981a64c69b26c151212072333439362290628993_v2\", \"builder_9d891a598cf8ebf0ae5ddfdbe2fc0861535c9a49467e7412fefe4675a15b7f18_v2\", \"git\", \"goma_v2\", \"vpython\"], \"cores\": [\"8\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Haswell_GCE\", \"x86-64-avx2\"], \"gce\": [\"1\"], \"gcp\": [\"google.com:chromecompute\"], \"gpu\": [\"none\"], \"id\": [\"luci-chromium-ci-xenial-us-central1-b-8-138-5n7s\"], \"image\": [\"chrome-xenial-21011100-9488e34e558\"], \"inside_docker\": [\"0\"], \"kvm\": [\"1\"], \"locale\": [\"en_US.UTF-8\"], \"machine_type\": [\"e2-standard-8\"], \"os\": [\"Linux\", \"Ubuntu\", \"Ubuntu-16\", \"Ubuntu-16.04\", \"Ubuntu-16.04.6\"], \"pool\": [\"luci.chromium.ci\"], \"python\": [\"2.7.12\"], \"server_version\": [\"5746-91ff3bd\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1615409868502516",
"status": "COMPLETED",
"status_changed_ts": "1615413601284561",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-rel/46059",
"builder:linux-chromeos-rel",
"buildset:commit/git/a2927e33d04c24872f2ce8f5ff2297196e0ab83b",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/a2927e33d04c24872f2ce8f5ff2297196e0ab83b",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9018543766797653552",
"scheduler_job_id:chromium/linux-chromeos-rel",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8853113704821824784/+/annotations",
"swarming_tag:luci_project:chromium",
"swarming_tag:os:Linux",
"swarming_tag:recipe_name:chromium",
"swarming_tag:recipe_package:infra/recipe_bundles/chromium.googlesource.com/chromium/tools/build",
"swarming_task_id:5236bfdfd7b69110",
"user_agent:luci-scheduler"
],
"updated_ts": "1615413601289158",
"url": "https://ci.chromium.org/b/8853113704821824784",
"utcnow_ts": "1615413602011555"
}
}
[22:00:02.024] Invocation finished in 1h2m21.597140599s with status SUCCEEDED