[02:11:08.321] New invocation is queued and will start shortly
[02:11:09.459] Starting the invocation (attempt 1)
[02:11:09.493] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[02:11:09.493] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[02:11:09.494] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9025409414755627024",
"parameters_json": "{\"builder_name\":\"win-asan\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"274e68214d88195d286764177d424fed8a809cb5\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:win-asan",
"scheduler_invocation_id:9025409414755627024",
"scheduler_job_id:chromium/win-asan",
"user_agent:luci-scheduler",
"buildset:commit/git/274e68214d88195d286764177d424fed8a809cb5",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/274e68214d88195d286764177d424fed8a809cb5",
"gitiles_ref:refs/heads/master"
]
}
[02:11:11.504] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1608862269591622",
"id": "8859979352759943680",
"parameters_json": "{\"builder_name\": \"win-asan\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"274e68214d88195d286764177d424fed8a809cb5\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1608862270254220",
"tags": [
"build_address:luci.chromium.ci/win-asan/16434",
"builder:win-asan",
"buildset:commit/git/274e68214d88195d286764177d424fed8a809cb5",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/274e68214d88195d286764177d424fed8a809cb5",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9025409414755627024",
"scheduler_job_id:chromium/win-asan",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8859979352759943680/+/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": "1608862270254376",
"url": "https://ci.chromium.org/b/8859979352759943680",
"utcnow_ts": "1608862271493346"
}
}
[02:11:11.504] Task URL: https://ci.chromium.org/b/8859979352759943680
[02:11:11.504] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025409414755627024:2:0) after 1m0s
[02:11:13.401] Received PubSub notification, asking Buildbucket for the build status
[02:11:13.468] Build 8859979352759943680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:12:11.537] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025409414755627024:2:0)
[02:12:11.537] Timer tick, asking Buildbucket for the build status
[02:12:11.604] Build 8859979352759943680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:12:11.604] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025409414755627024:4:0) after 1m0s
[02:13:11.641] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025409414755627024:4:0)
[02:13:11.641] Timer tick, asking Buildbucket for the build status
[02:13:12.007] Build 8859979352759943680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:13:12.007] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025409414755627024:5:0) after 1m0s
[02:14:12.024] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025409414755627024:5:0)
[02:14:12.024] Timer tick, asking Buildbucket for the build status
[02:14:12.132] Build 8859979352759943680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:14:12.132] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025409414755627024:6:0) after 1m0s
[02:15:12.162] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025409414755627024:6:0)
[02:15:12.162] Timer tick, asking Buildbucket for the build status
[02:15:12.252] Build 8859979352759943680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:15:12.252] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025409414755627024:7:0) after 1m0s
[02:16:12.272] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025409414755627024:7:0)
[02:16:12.272] Timer tick, asking Buildbucket for the build status
[02:16:12.464] Build 8859979352759943680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:16:12.464] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025409414755627024:8:0) after 1m0s
[02:17:12.491] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025409414755627024:8:0)
[02:17:12.491] Timer tick, asking Buildbucket for the build status
[02:17:12.543] Build 8859979352759943680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:17:12.543] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025409414755627024:9:0) after 1m0s
[02:18:12.612] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025409414755627024:9:0)
[02:18:12.612] Timer tick, asking Buildbucket for the build status
[02:18:12.707] Build 8859979352759943680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:18:12.707] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025409414755627024:10:0) after 1m0s
[02:19:12.729] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025409414755627024:10:0)
[02:19:12.729] Timer tick, asking Buildbucket for the build status
[02:19:12.903] Build 8859979352759943680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:19:12.903] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025409414755627024:11:0) after 1m0s
[02:20:12.996] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025409414755627024:11:0)
[02:20:12.996] Timer tick, asking Buildbucket for the build status
[02:20:13.103] Build 8859979352759943680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:20:13.104] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025409414755627024:12:0) after 1m0s
[02:21:13.127] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025409414755627024:12:0)
[02:21:13.127] Timer tick, asking Buildbucket for the build status
[02:21:13.469] Build 8859979352759943680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:21:13.469] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025409414755627024:13:0) after 1m0s
[02:22:13.489] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025409414755627024:13:0)
[02:22:13.489] Timer tick, asking Buildbucket for the build status
[02:22:13.680] Build 8859979352759943680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:22:13.680] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025409414755627024:14:0) after 1m0s
[02:23:13.683] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025409414755627024:14:0)
[02:23:13.683] Timer tick, asking Buildbucket for the build status
[02:23:13.942] Build 8859979352759943680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:23:13.942] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025409414755627024:15:0) after 1m0s
[02:24:13.994] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025409414755627024:15:0)
[02:24:13.994] Timer tick, asking Buildbucket for the build status
[02:24:14.207] Build 8859979352759943680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:24:14.207] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025409414755627024:16:0) after 1m0s
[02:25:14.226] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025409414755627024:16:0)
[02:25:14.226] Timer tick, asking Buildbucket for the build status
[02:25:14.316] Build 8859979352759943680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:25:14.316] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025409414755627024:17:0) after 1m0s
[02:26:14.616] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025409414755627024:17:0)
[02:26:14.616] Timer tick, asking Buildbucket for the build status
[02:26:14.892] Build 8859979352759943680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:26:14.892] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025409414755627024:18:0) after 1m0s
[02:27:16.015] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025409414755627024:18:0)
[02:27:16.015] Timer tick, asking Buildbucket for the build status
[02:27:16.183] Build 8859979352759943680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:27:16.183] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025409414755627024:19:0) after 1m0s
[02:28:17.112] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025409414755627024:19:0)
[02:28:17.112] Timer tick, asking Buildbucket for the build status
[02:28:17.388] Build 8859979352759943680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:28:17.388] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025409414755627024:20:0) after 1m0s
[02:29:17.731] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025409414755627024:20:0)
[02:29:17.731] Timer tick, asking Buildbucket for the build status
[02:29:17.836] Build 8859979352759943680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:29:17.836] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025409414755627024:21:0) after 1m0s
[02:30:17.889] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025409414755627024:21:0)
[02:30:17.889] Timer tick, asking Buildbucket for the build status
[02:30:18.076] Build 8859979352759943680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:30:18.076] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025409414755627024:22:0) after 1m0s
[02:31:18.172] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025409414755627024:22:0)
[02:31:18.172] Timer tick, asking Buildbucket for the build status
[02:31:18.301] Build 8859979352759943680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:31:18.301] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025409414755627024:23:0) after 1m0s
[02:32:18.341] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025409414755627024:23:0)
[02:32:18.341] Timer tick, asking Buildbucket for the build status
[02:32:18.505] Build 8859979352759943680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:32:18.505] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025409414755627024:24:0) after 1m0s
[02:33:18.518] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025409414755627024:24:0)
[02:33:18.518] Timer tick, asking Buildbucket for the build status
[02:33:19.297] Build 8859979352759943680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:33:19.297] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025409414755627024:25:0) after 1m0s
[02:34:19.315] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025409414755627024:25:0)
[02:34:19.315] Timer tick, asking Buildbucket for the build status
[02:34:19.444] Build 8859979352759943680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:34:19.444] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025409414755627024:26:0) after 1m0s
[02:35:19.539] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025409414755627024:26:0)
[02:35:19.539] Timer tick, asking Buildbucket for the build status
[02:35:19.881] Build 8859979352759943680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:35:19.881] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025409414755627024:27:0) after 1m0s
[02:36:19.949] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025409414755627024:27:0)
[02:36:19.949] Timer tick, asking Buildbucket for the build status
[02:36:20.053] Build 8859979352759943680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:36:20.053] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025409414755627024:28:0) after 1m0s
[02:37:20.091] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025409414755627024:28:0)
[02:37:20.091] Timer tick, asking Buildbucket for the build status
[02:37:20.324] Build 8859979352759943680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:37:20.324] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025409414755627024:29:0) after 1m0s
[02:38:20.369] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025409414755627024:29:0)
[02:38:20.369] Timer tick, asking Buildbucket for the build status
[02:38:20.440] Build 8859979352759943680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:38:20.440] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025409414755627024:30:0) after 1m0s
[02:39:20.532] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025409414755627024:30:0)
[02:39:20.532] Timer tick, asking Buildbucket for the build status
[02:39:20.804] Build 8859979352759943680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:39:20.805] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025409414755627024:31:0) after 1m0s
[02:40:20.876] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025409414755627024:31:0)
[02:40:20.876] Timer tick, asking Buildbucket for the build status
[02:40:20.956] Build 8859979352759943680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:40:20.956] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025409414755627024:32:0) after 1m0s
[02:41:20.974] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025409414755627024:32:0)
[02:41:20.974] Timer tick, asking Buildbucket for the build status
[02:41:21.096] Build 8859979352759943680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:41:21.096] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025409414755627024:33:0) after 1m0s
[02:42:21.352] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025409414755627024:33:0)
[02:42:21.352] Timer tick, asking Buildbucket for the build status
[02:42:21.543] Build 8859979352759943680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:42:21.543] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025409414755627024:34:0) after 1m0s
[02:43:21.608] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025409414755627024:34:0)
[02:43:21.608] Timer tick, asking Buildbucket for the build status
[02:43:21.702] Build 8859979352759943680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:43:21.702] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025409414755627024:35:0) after 1m0s
[02:44:21.881] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025409414755627024:35:0)
[02:44:21.881] Timer tick, asking Buildbucket for the build status
[02:44:21.945] Build 8859979352759943680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:44:21.945] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025409414755627024:36:0) after 1m0s
[02:45:22.022] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025409414755627024:36:0)
[02:45:22.022] Timer tick, asking Buildbucket for the build status
[02:45:22.103] Build 8859979352759943680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:45:22.103] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025409414755627024:37:0) after 1m0s
[02:46:22.113] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025409414755627024:37:0)
[02:46:22.113] Timer tick, asking Buildbucket for the build status
[02:46:22.210] Build 8859979352759943680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:46:22.210] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025409414755627024:38:0) after 1m0s
[02:47:22.300] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025409414755627024:38:0)
[02:47:22.300] Timer tick, asking Buildbucket for the build status
[02:47:22.369] Build 8859979352759943680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:47:22.369] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025409414755627024:39:0) after 1m0s
[02:48:22.428] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025409414755627024:39:0)
[02:48:22.428] Timer tick, asking Buildbucket for the build status
[02:48:22.708] Build 8859979352759943680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:48:22.708] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025409414755627024:40:0) after 1m0s
[02:49:22.812] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025409414755627024:40:0)
[02:49:22.812] Timer tick, asking Buildbucket for the build status
[02:49:22.997] Build 8859979352759943680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:49:22.997] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025409414755627024:41:0) after 1m0s
[02:50:23.035] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025409414755627024:41:0)
[02:50:23.035] Timer tick, asking Buildbucket for the build status
[02:50:23.576] Build 8859979352759943680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:50:23.576] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025409414755627024:42:0) after 1m0s
[02:51:23.685] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025409414755627024:42:0)
[02:51:23.685] Timer tick, asking Buildbucket for the build status
[02:51:23.821] Build 8859979352759943680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:51:23.821] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025409414755627024:43:0) after 1m0s
[02:52:23.947] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025409414755627024:43:0)
[02:52:23.947] Timer tick, asking Buildbucket for the build status
[02:52:24.007] Build 8859979352759943680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:52:24.007] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025409414755627024:44:0) after 1m0s
[02:53:24.121] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025409414755627024:44:0)
[02:53:24.121] Timer tick, asking Buildbucket for the build status
[02:53:24.235] Build 8859979352759943680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:53:24.235] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025409414755627024:45:0) after 1m0s
[02:54:24.290] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025409414755627024:45:0)
[02:54:24.290] Timer tick, asking Buildbucket for the build status
[02:54:24.526] Build 8859979352759943680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:54:24.526] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025409414755627024:46:0) after 1m0s
[02:55:24.600] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025409414755627024:46:0)
[02:55:24.600] Timer tick, asking Buildbucket for the build status
[02:55:24.726] Build 8859979352759943680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:55:24.726] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025409414755627024:47:0) after 1m0s
[02:56:24.808] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025409414755627024:47:0)
[02:56:24.808] Timer tick, asking Buildbucket for the build status
[02:56:24.918] Build 8859979352759943680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:56:24.918] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025409414755627024:48:0) after 1m0s
[02:57:25.527] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025409414755627024:48:0)
[02:57:25.527] Timer tick, asking Buildbucket for the build status
[02:57:25.593] Build 8859979352759943680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:57:25.593] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025409414755627024:49:0) after 1m0s
[02:58:25.701] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025409414755627024:49:0)
[02:58:25.701] Timer tick, asking Buildbucket for the build status
[02:58:26.025] Build 8859979352759943680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:58:26.025] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025409414755627024:50:0) after 1m0s
[02:59:26.192] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025409414755627024:50:0)
[02:59:26.192] Timer tick, asking Buildbucket for the build status
[02:59:26.254] Build 8859979352759943680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:59:26.254] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025409414755627024:51:0) after 1m0s
[03:00:26.469] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025409414755627024:51:0)
[03:00:26.469] Timer tick, asking Buildbucket for the build status
[03:00:26.574] Build 8859979352759943680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:00:26.574] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025409414755627024:52:0) after 1m0s
[03:01:26.594] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025409414755627024:52:0)
[03:01:26.594] Timer tick, asking Buildbucket for the build status
[03:01:26.833] Build 8859979352759943680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:01:26.833] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025409414755627024:53:0) after 1m0s
[03:02:11.757] Received PubSub notification, asking Buildbucket for the build status
[03:02:12.024] Build 8859979352759943680: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[03:02:12.024] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1608865330459272",
"created_by": "project:chromium",
"created_ts": "1608862269591622",
"id": "8859979352759943680",
"parameters_json": "{\"builder_name\": \"win-asan\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"274e68214d88195d286764177d424fed8a809cb5\"}}",
"project": "chromium",
"result": "SUCCESS",
"result_details_json": "{\"properties\": {\"$build/goma\": {\"enable_ats\": true, \"jobs\": 500.0, \"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\": \"274e68214d88195d286764177d424fed8a809cb5\", \"project\": \"chromium/src\"}], \"$recipe_engine/path\": {\"cache_dir\": \"C:\\\\b\\\\s\\\\w\\\\ir\\\\cache\", \"temp_dir\": \"C:\\\\b\\\\s\\\\w\\\\ir\\\\tmp\\\\rt\"}, \"$recipe_engine/runtime\": {\"is_experimental\": false, \"is_luci\": true}, \"bot_id\": \"luci-chromium-ci-win10-us-central1-b-32-1-2sgf\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.memory\", \"buildername\": \"win-asan\", \"buildnumber\": 16434, \"clang_revision\": \"llvmorg-12-init-12923-g6ee22ca6-1\", \"got_angle_revision\": \"9f0748eaa125501ec4cd2ab7be67430f39656888\", \"got_dawn_revision\": \"c8d5277e86ee8c51b1dd7892b41e83eb26ac2ede\", \"got_nacl_revision\": \"299d4780ec86121ff2a5368ed9435ade0e356e5e\", \"got_revision\": \"274e68214d88195d286764177d424fed8a809cb5\", \"got_revision_cp\": \"refs/heads/master@{#839295}\", \"got_swarming_client_revision\": \"1a072711d4388c62e02480fabc26c68c24494be9\", \"got_swiftshader_revision\": \"1cc5b3357d2ff3c81ef7ec0b07a6660796bde5cd\", \"got_v8_revision\": \"59e5b444468beb62060b5d0b2e65837b279528f1\", \"got_v8_revision_cp\": \"refs/heads/8.9.190@{#1}\", \"got_webrtc_revision\": \"a45df0b3491ea72cfcf40e21106eb046c8594223\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#32879}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"mirrored_builders\": [\"tryserver.chromium.win:win-asan\"], \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"274e68214d88195d286764177d424fed8a809cb5\", \"swarm_hashes_refs/heads/master(at){#839295}_without_patch\": {\"absl_hardening_tests\": \"ce1f0f9b9b25e3cdf6a07a0e0b76af9716afb48f\", \"accessibility_unittests\": \"8193eaf644fb91f29f020e8dc86be224bbb80f92\", \"angle_unittests\": \"f99eba9aabf20a5f5f70d3f47a1e82bd6a9b32d6\", \"app_shell_unittests\": \"d3cf44988f179ea76491f6abdfd6a6617773d421\", \"aura_unittests\": \"d66410b24ce4c8e79298e6de043f28e4075e266c\", \"base_unittests\": \"beed3742c37f005bf3a7a447976e605bb0950db6\", \"base_util_unittests\": \"5c845bf46e78057b517371484642806e1e521fd4\", \"blink_common_unittests\": \"dc92b984d90b160c4e0771f5d7fe0f0087d77565\", \"blink_fuzzer_unittests\": \"b2bdb53c295d226fd854605fe3cbafbd9e2fabe9\", \"blink_heap_unittests\": \"6f5e81cb8335675c497aa4d38299e302c9f59778\", \"blink_platform_unittests\": \"77d507fe117b1a1906cf6658231aa8b1d119d296\", \"blink_unittests\": \"a415d506c839bf5ae01b2c33894865667fef290a\", \"boringssl_crypto_tests\": \"2504f21ea2ffdfb788e76dcef30b9541551ef265\", \"boringssl_ssl_tests\": \"cedf376879c94d77766e67635c228f52690a5ae8\", \"browser_switcher_bho_unittests\": \"a778b9e8cd53b81c550f894474346318a7bfba9d\", \"browser_tests\": \"3fac879af9e50d35731fbe60afc07b3c1e078245\", \"capture_unittests\": \"5fab9e046bdbf54ccbfc3e5b9b2f7b12800074b8\", \"cast_unittests\": \"591dbd37932fb720de7daba55d624a40389b0bc0\", \"cc_unittests\": \"4935448604930cbd251eef9b45fbea1de8f2a0b1\", \"chrome_app_unittests\": \"ba350dcfaa2319099c709097e4a0f826f852e319\", \"chrome_cleaner_unittests\": \"691f158d43a9f7d9058ceefbe7df7098427cd734\", \"chrome_elf_unittests\": \"b32380c20394919593e56f6fc50957d32b612a92\", \"chromedriver_unittests\": \"078083ebc277f6f9769e5308037505a0fa46ebca\", \"components_browsertests\": \"43b4e3f1a6e556d7c0831b8ff84eda7dc365127a\", \"components_unittests\": \"415717cf74b07bf543730775d6b8b80313d85738\", \"compositor_unittests\": \"4a558eeb74c95c822238dc29bf3544ada9093296\", \"content_browsertests\": \"88bf10a8ba147627e5e3c7807b544fa7e2665c07\", \"content_unittests\": \"b722ad3195075bb1e65f85e1fbff88b6b5a2816b\", \"courgette_unittests\": \"9255ed270c746a4277c076afb8e4ecc0765a665e\", \"crashpad_tests\": \"505482293273a34ff74cf1fe369e89dbddb15977\", \"cronet_tests\": \"42306de6bc0a9e370d0af711b6144b02d405132a\", \"cronet_unittests\": \"baedfee418e3573dbbd2715ef8071caf00e0008d\", \"crypto_unittests\": \"c48cfbbd3fe8af209aefad43c9d29265df725895\", \"delayloads_unittests\": \"9ceeda4bea2d3f47b7d0adca1e454671ffcaa828\", \"device_unittests\": \"f764a64e904a749e6298494edd41101057487ea9\", \"display_unittests\": \"836435689115e888e8e754da3d30d1c3c45a973a\", \"elevation_service_unittests\": \"14a1090689ce977b267219777a4e42ced97a4e0b\", \"events_unittests\": \"e7dba45340fdb04409af41698d61d0f066af79a3\", \"extensions_browsertests\": \"8b0c1ae8892582037b7271ee564e2587bbc8f2bf\", \"extensions_unittests\": \"36ff428caca7d716a5223928e1a83b798df16bb4\", \"filesystem_service_unittests\": \"ad643e4ab3e0696cce39bd415a38d0fab5220f9d\", \"gcm_unit_tests\": \"b0deca97d69190e6aca43b3a5f492dd1079017f0\", \"gcp_unittests\": \"c0f0740df929dd8cec7b24b24b39b0811e359dca\", \"gfx_unittests\": \"91377adef8243d603c1a01e6fb855a0d8b7d62f5\", \"gin_unittests\": \"1cfd9e1b1f663e1701676a44d2e0912a771a5c2e\", \"google_apis_unittests\": \"2676e7ffd53d293cfc9e5d942fa164165ae02fe4\", \"gpu_unittests\": \"71fa49c29408992e94af1e79fedd32379436b73f\", \"gwp_asan_unittests\": \"4ee736f8e9eb3049d0288af289c5b9b8a75d030f\", \"headless_browsertests\": \"b2f18e8b9ef22198b2a921b5f62377a6339dcc18\", \"headless_unittests\": \"321e55c2c01edde53316d1dd4ab291f5e6a28ca5\", \"install_static_unittests\": \"dbe67ad51cbd2c5819bbb6f002b027aa1114b09d\", \"installer_util_unittests\": \"04ae1063232750cd0aec88debd34cf8450d23f8f\", \"interactive_ui_tests\": \"4ee13dd439ca1f792d027dfe095b5f0abb509044\", \"ipc_tests\": \"99e2c4ff9f7e7e28456f14bcdd517f543d012247\", \"jingle_unittests\": \"4e2ea3dc24fedde9df01f8afe5ca0c99832df9a0\", \"latency_unittests\": \"931d8fb034729e49788a8fd4ea456f1e47ecdc21\", \"libjingle_xmpp_unittests\": \"2ca994cb2da85c1c6fd970340d7618f54a90e9c3\", \"liburlpattern_unittests\": \"e83204cc574022d43bc66ff187ae4be4bfd1d3a0\", \"media_blink_unittests\": \"a9fb519d8e799ad9b2aa21224ef450287dde9689\", \"media_unittests\": \"51e78b2c2ab761709b8caa2016b7c1ab9cb59822\", \"message_center_unittests\": \"18104bb4fb008d74256bff265e20b4f8cccfe1a7\", \"midi_unittests\": \"135cf2ff92e76ecc53e8ac69eb28f006ba502668\", \"mojo_core_unittests\": \"19501930761909f9a2dc66e5f038640dca795c62\", \"mojo_unittests\": \"2a264b17d87c253de7dd71bce68db27c53782bb0\", \"nacl_loader_unittests\": \"f755a6d52544c72d8bee2bfa76eeb0d736e489c2\", \"native_theme_unittests\": \"2aeb22edce837c83d43973488130d8255cab189b\", \"net_unittests\": \"174af46ccf001969f8170a643cf29fcf07e28d7a\", \"notification_helper_unittests\": \"fefbcedbb539704a1b92833e0c465cf1cd6786dd\", \"pdf_unittests\": \"480a7134545d0d6a1fd354aca3cfb2209af301f0\", \"perfetto_unittests\": \"579be7f61edfec382e75f1d9d552160b7eec9df3\", \"ppapi_unittests\": \"da2b53a96d63077c4b638bdc47e8b203e8468830\", \"printing_unittests\": \"2d29a3ae4acf48729c6aeb234d0a76a9ff8f2eb0\", \"remoting_unittests\": \"ce7dcc994ce8b742dace0f704b4f6889d690326b\", \"sbox_integration_tests\": \"be56f3e66968a0273b92354c28e94f781ea5c76f\", \"sbox_unittests\": \"ebbdcfed84b280a25f8a8f05ce6b0571b4498c4e\", \"sbox_validation_tests\": \"5b1f6785a0e202c160a932a0d96b671710dc02e9\", \"service_manager_unittests\": \"4ef5ea12c61b5c292165517c91196e9bfe53bcc2\", \"services_unittests\": \"72aa186fdaa1ffb47628603983a9b89bb2eb1073\", \"setup_unittests\": \"77d1c3348b4cbbee46ef4e7362d06073810abe66\", \"shell_dialogs_unittests\": \"617947af5b43a6e9946806935be9433ab16df349\", \"skia_unittests\": \"b1f97f82a99f1d753607577cecc6241b8c8db941\", \"snapshot_unittests\": \"c92ea941640401317252b4e5846c678c94b8de4d\", \"sql_unittests\": \"b45de565cabf3f41cf03e4f4dcf579a0121ba3a4\", \"storage_unittests\": \"0e77eb93e335b9386772e50b5dbfee4dcd086d79\", \"sync_integration_tests\": \"d81c003a15c42b3e657ef635985c4aa51bc5d37c\", \"traffic_annotation_auditor_unittests\": \"d18c15fed65702bcac3dfa00eb8da5a812c3dd70\", \"ui_base_unittests\": \"b751e576c024adc92f7aaf100f923e9f7841240f\", \"ui_touch_selection_unittests\": \"e378d05a25129f87d344262223eddcba35e97b82\", \"unit_tests\": \"118aab0b5b5b2645c7ab6ec771c74f1e20db24ed\", \"updater_tests\": \"b0ca09239ca82195727c51d7a55e48a284011a6f\", \"url_unittests\": \"36ba39195cb043b45bc22d4352af6dfd9e6fb6a6\", \"views_unittests\": \"ec54adffe8ec38a59d9e83410ef0cb75f9219a2d\", \"viz_unittests\": \"987a6979e3d5869a9f773d19550287e42905faed\", \"vr_common_unittests\": \"5214360f51841ed1f37b8110eb306639a803c490\", \"vr_pixeltests\": \"f24f0dc56c0cf2e3a2d27d6793a9843cfc36f506\", \"weblayer_browsertests\": \"6f8bece7fe5565bca65755d76719f82b387f71bb\", \"weblayer_unittests\": \"cf4468efbaa414c2252c0b2f07bf668363843bf7\", \"wm_unittests\": \"dfd56482985997603bae6b997c3970f30c51c6a2\", \"wtf_unittests\": \"a87240826eb7420cb02f75cadebb58397207ccf1\", \"zlib_unittests\": \"e628db89766469d0cdb585c401b421df55196a2b\", \"zucchini_unittests\": \"cdb5b6a1297b26bd6c43ad609c532815f0456100\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_c244a7c1904bb59c4b6cd021ade0aa3730bbe3d07abc076b32cf6cdc63527337_v2\", \"git\", \"goma_v2\", \"vpython\"], \"cores\": [\"32\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Haswell_GCE\"], \"gce\": [\"1\"], \"gcp\": [\"google.com:chromecompute\"], \"gpu\": [\"none\"], \"id\": [\"luci-chromium-ci-win10-us-central1-b-32-1-2sgf\"], \"image\": [\"chrome-win10-1703-20092300-22ba5320847\"], \"integrity\": [\"high\"], \"locale\": [\"en_US.cp1252\"], \"machine_type\": [\"e2-standard-32\"], \"os\": [\"Windows\", \"Windows-10\", \"Windows-10-15063\"], \"pool\": [\"luci.chromium.ci\"], \"python\": [\"2.7.13\"], \"server_version\": [\"5657-0417a3f\"], \"ssd\": [\"0\"], \"windows_client_version\": [\"10\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1608862272892291",
"status": "COMPLETED",
"status_changed_ts": "1608865330863174",
"tags": [
"build_address:luci.chromium.ci/win-asan/16434",
"builder:win-asan",
"buildset:commit/git/274e68214d88195d286764177d424fed8a809cb5",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/274e68214d88195d286764177d424fed8a809cb5",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9025409414755627024",
"scheduler_job_id:chromium/win-asan",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8859979352759943680/+/annotations",
"swarming_tag:luci_project:chromium",
"swarming_tag:os:Windows",
"swarming_tag:recipe_name:chromium",
"swarming_tag:recipe_package:infra/recipe_bundles/chromium.googlesource.com/chromium/tools/build",
"swarming_task_id:50b07b8be7081410",
"user_agent:luci-scheduler"
],
"updated_ts": "1608865330867299",
"url": "https://ci.chromium.org/b/8859979352759943680",
"utcnow_ts": "1608865332009883"
}
}
[03:02:12.024] Invocation finished in 51m3.720243935s with status SUCCEEDED