[04:48:01.162] New invocation is queued and will start shortly
[04:48:02.922] Starting the invocation (attempt 1)
[04:48:02.978] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[04:48:02.978] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[04:48:02.978] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9026849096136152944",
"parameters_json": "{\"builder_name\":\"win-asan\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"71592540b7700f5e2b0a70059630d168a263dc27\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:win-asan",
"scheduler_invocation_id:9026849096136152944",
"scheduler_job_id:chromium/win-asan",
"user_agent:luci-scheduler",
"buildset:commit/git/71592540b7700f5e2b0a70059630d168a263dc27",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/71592540b7700f5e2b0a70059630d168a263dc27",
"gitiles_ref:refs/heads/master"
]
}
[04:48:04.187] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1607489283417535",
"id": "8861419033109836432",
"parameters_json": "{\"builder_name\": \"win-asan\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"71592540b7700f5e2b0a70059630d168a263dc27\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1607489283941715",
"tags": [
"build_address:luci.chromium.ci/win-asan/16112",
"builder:win-asan",
"buildset:commit/git/71592540b7700f5e2b0a70059630d168a263dc27",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/71592540b7700f5e2b0a70059630d168a263dc27",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9026849096136152944",
"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/8861419033109836432/+/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": "1607489283941884",
"url": "https://ci.chromium.org/b/8861419033109836432",
"utcnow_ts": "1607489284178501"
}
}
[04:48:04.187] Task URL: https://ci.chromium.org/b/8861419033109836432
[04:48:04.187] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026849096136152944:2:0) after 1m0s
[04:48:07.152] Received PubSub notification, asking Buildbucket for the build status
[04:48:07.336] Build 8861419033109836432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:49:04.282] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026849096136152944:2:0)
[04:49:04.282] Timer tick, asking Buildbucket for the build status
[04:49:04.465] Build 8861419033109836432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:49:04.465] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026849096136152944:4:0) after 1m0s
[04:50:04.524] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026849096136152944:4:0)
[04:50:04.524] Timer tick, asking Buildbucket for the build status
[04:50:04.852] Build 8861419033109836432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:50:04.852] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026849096136152944:5:0) after 1m0s
[04:51:04.955] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026849096136152944:5:0)
[04:51:04.955] Timer tick, asking Buildbucket for the build status
[04:51:05.071] Build 8861419033109836432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:51:05.071] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026849096136152944:6:0) after 1m0s
[04:52:05.155] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026849096136152944:6:0)
[04:52:05.155] Timer tick, asking Buildbucket for the build status
[04:52:05.278] Build 8861419033109836432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:52:05.278] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026849096136152944:7:0) after 1m0s
[04:53:05.296] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026849096136152944:7:0)
[04:53:05.296] Timer tick, asking Buildbucket for the build status
[04:53:05.407] Build 8861419033109836432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:53:05.407] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026849096136152944:8:0) after 1m0s
[04:54:05.431] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026849096136152944:8:0)
[04:54:05.431] Timer tick, asking Buildbucket for the build status
[04:54:05.515] Build 8861419033109836432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:54:05.515] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026849096136152944:9:0) after 1m0s
[04:55:05.563] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026849096136152944:9:0)
[04:55:05.563] Timer tick, asking Buildbucket for the build status
[04:55:05.622] Build 8861419033109836432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:55:05.622] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026849096136152944:10:0) after 1m0s
[04:56:05.646] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026849096136152944:10:0)
[04:56:05.646] Timer tick, asking Buildbucket for the build status
[04:56:06.291] Build 8861419033109836432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:56:06.291] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026849096136152944:11:0) after 1m0s
[04:57:06.427] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026849096136152944:11:0)
[04:57:06.427] Timer tick, asking Buildbucket for the build status
[04:57:06.485] Build 8861419033109836432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:57:06.485] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026849096136152944:12:0) after 1m0s
[04:58:06.612] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026849096136152944:12:0)
[04:58:06.612] Timer tick, asking Buildbucket for the build status
[04:58:07.063] Build 8861419033109836432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:58:07.063] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026849096136152944:13:0) after 1m0s
[04:59:07.088] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026849096136152944:13:0)
[04:59:07.088] Timer tick, asking Buildbucket for the build status
[04:59:07.200] Build 8861419033109836432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:59:07.200] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026849096136152944:14:0) after 1m0s
[05:00:07.271] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026849096136152944:14:0)
[05:00:07.271] Timer tick, asking Buildbucket for the build status
[05:00:07.352] Build 8861419033109836432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:00:07.352] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026849096136152944:15:0) after 1m0s
[05:01:07.855] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026849096136152944:15:0)
[05:01:07.856] Timer tick, asking Buildbucket for the build status
[05:01:07.941] Build 8861419033109836432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:01:07.941] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026849096136152944:16:0) after 1m0s
[05:02:08.116] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026849096136152944:16:0)
[05:02:08.116] Timer tick, asking Buildbucket for the build status
[05:02:08.194] Build 8861419033109836432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:02:08.194] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026849096136152944:17:0) after 1m0s
[05:03:08.281] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026849096136152944:17:0)
[05:03:08.281] Timer tick, asking Buildbucket for the build status
[05:03:08.785] Build 8861419033109836432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:03:08.785] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026849096136152944:18:0) after 1m0s
[05:04:08.947] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026849096136152944:18:0)
[05:04:08.947] Timer tick, asking Buildbucket for the build status
[05:04:09.060] Build 8861419033109836432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:04:09.060] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026849096136152944:19:0) after 1m0s
[05:05:09.128] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026849096136152944:19:0)
[05:05:09.128] Timer tick, asking Buildbucket for the build status
[05:05:09.234] Build 8861419033109836432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:05:09.234] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026849096136152944:20:0) after 1m0s
[05:06:09.339] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026849096136152944:20:0)
[05:06:09.339] Timer tick, asking Buildbucket for the build status
[05:06:09.450] Build 8861419033109836432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:06:09.450] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026849096136152944:21:0) after 1m0s
[05:07:09.445] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026849096136152944:21:0)
[05:07:09.445] Timer tick, asking Buildbucket for the build status
[05:07:09.543] Build 8861419033109836432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:07:09.543] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026849096136152944:22:0) after 1m0s
[05:08:09.572] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026849096136152944:22:0)
[05:08:09.572] Timer tick, asking Buildbucket for the build status
[05:08:09.750] Build 8861419033109836432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:08:09.750] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026849096136152944:23:0) after 1m0s
[05:09:09.736] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026849096136152944:23:0)
[05:09:09.736] Timer tick, asking Buildbucket for the build status
[05:09:09.862] Build 8861419033109836432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:09:09.862] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026849096136152944:24:0) after 1m0s
[05:10:09.918] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026849096136152944:24:0)
[05:10:09.918] Timer tick, asking Buildbucket for the build status
[05:10:10.041] Build 8861419033109836432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:10:10.041] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026849096136152944:25:0) after 1m0s
[05:11:10.144] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026849096136152944:25:0)
[05:11:10.144] Timer tick, asking Buildbucket for the build status
[05:11:10.263] Build 8861419033109836432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:11:10.264] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026849096136152944:26:0) after 1m0s
[05:12:10.316] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026849096136152944:26:0)
[05:12:10.317] Timer tick, asking Buildbucket for the build status
[05:12:11.034] Build 8861419033109836432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:12:11.034] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026849096136152944:27:0) after 1m0s
[05:13:11.130] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026849096136152944:27:0)
[05:13:11.130] Timer tick, asking Buildbucket for the build status
[05:13:11.266] Build 8861419033109836432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:13:11.266] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026849096136152944:28:0) after 1m0s
[05:14:11.377] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026849096136152944:28:0)
[05:14:11.377] Timer tick, asking Buildbucket for the build status
[05:14:11.962] Build 8861419033109836432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:14:11.962] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026849096136152944:29:0) after 1m0s
[05:15:11.958] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026849096136152944:29:0)
[05:15:11.958] Timer tick, asking Buildbucket for the build status
[05:15:12.096] Build 8861419033109836432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:15:12.096] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026849096136152944:30:0) after 1m0s
[05:16:12.117] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026849096136152944:30:0)
[05:16:12.117] Timer tick, asking Buildbucket for the build status
[05:16:12.248] Build 8861419033109836432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:16:12.248] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026849096136152944:31:0) after 1m0s
[05:17:12.324] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026849096136152944:31:0)
[05:17:12.324] Timer tick, asking Buildbucket for the build status
[05:17:12.449] Build 8861419033109836432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:17:12.449] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026849096136152944:32:0) after 1m0s
[05:18:12.524] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026849096136152944:32:0)
[05:18:12.524] Timer tick, asking Buildbucket for the build status
[05:18:12.705] Build 8861419033109836432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:18:12.705] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026849096136152944:33:0) after 1m0s
[05:19:12.748] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026849096136152944:33:0)
[05:19:12.748] Timer tick, asking Buildbucket for the build status
[05:19:12.904] Build 8861419033109836432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:19:12.904] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026849096136152944:34:0) after 1m0s
[05:20:13.009] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026849096136152944:34:0)
[05:20:13.009] Timer tick, asking Buildbucket for the build status
[05:20:13.165] Build 8861419033109836432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:20:13.165] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026849096136152944:35:0) after 1m0s
[05:21:13.187] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026849096136152944:35:0)
[05:21:13.187] Timer tick, asking Buildbucket for the build status
[05:21:13.330] Build 8861419033109836432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:21:13.330] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026849096136152944:36:0) after 1m0s
[05:22:13.456] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026849096136152944:36:0)
[05:22:13.456] Timer tick, asking Buildbucket for the build status
[05:22:13.558] Build 8861419033109836432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:22:13.558] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026849096136152944:37:0) after 1m0s
[05:23:13.612] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026849096136152944:37:0)
[05:23:13.612] Timer tick, asking Buildbucket for the build status
[05:23:13.892] Build 8861419033109836432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:23:13.892] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026849096136152944:38:0) after 1m0s
[05:24:14.019] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026849096136152944:38:0)
[05:24:14.019] Timer tick, asking Buildbucket for the build status
[05:24:14.089] Build 8861419033109836432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:24:14.089] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026849096136152944:39:0) after 1m0s
[05:25:14.159] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026849096136152944:39:0)
[05:25:14.159] Timer tick, asking Buildbucket for the build status
[05:25:14.470] Build 8861419033109836432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:25:14.470] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026849096136152944:40:0) after 1m0s
[05:26:14.482] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026849096136152944:40:0)
[05:26:14.482] Timer tick, asking Buildbucket for the build status
[05:26:14.600] Build 8861419033109836432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:26:14.600] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026849096136152944:41:0) after 1m0s
[05:27:14.636] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026849096136152944:41:0)
[05:27:14.636] Timer tick, asking Buildbucket for the build status
[05:27:15.092] Build 8861419033109836432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:27:15.092] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026849096136152944:42:0) after 1m0s
[05:28:15.119] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026849096136152944:42:0)
[05:28:15.119] Timer tick, asking Buildbucket for the build status
[05:28:15.253] Build 8861419033109836432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:28:15.253] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026849096136152944:43:0) after 1m0s
[05:29:15.257] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026849096136152944:43:0)
[05:29:15.257] Timer tick, asking Buildbucket for the build status
[05:29:15.409] Build 8861419033109836432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:29:15.409] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026849096136152944:44:0) after 1m0s
[05:30:15.453] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026849096136152944:44:0)
[05:30:15.453] Timer tick, asking Buildbucket for the build status
[05:30:15.912] Build 8861419033109836432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:30:15.912] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026849096136152944:45:0) after 1m0s
[05:31:16.030] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026849096136152944:45:0)
[05:31:16.030] Timer tick, asking Buildbucket for the build status
[05:31:16.363] Build 8861419033109836432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:31:16.363] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026849096136152944:46:0) after 1m0s
[05:32:16.409] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026849096136152944:46:0)
[05:32:16.409] Timer tick, asking Buildbucket for the build status
[05:32:16.532] Build 8861419033109836432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:32:16.532] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026849096136152944:47:0) after 1m0s
[05:33:16.592] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026849096136152944:47:0)
[05:33:16.592] Timer tick, asking Buildbucket for the build status
[05:33:16.695] Build 8861419033109836432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:33:16.695] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026849096136152944:48:0) after 1m0s
[05:34:17.389] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026849096136152944:48:0)
[05:34:17.389] Timer tick, asking Buildbucket for the build status
[05:34:17.506] Build 8861419033109836432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:34:17.506] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026849096136152944:49:0) after 1m0s
[05:35:17.504] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026849096136152944:49:0)
[05:35:17.504] Timer tick, asking Buildbucket for the build status
[05:35:18.202] Build 8861419033109836432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:35:18.202] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026849096136152944:50:0) after 1m0s
[05:36:18.222] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026849096136152944:50:0)
[05:36:18.222] Timer tick, asking Buildbucket for the build status
[05:36:18.319] Build 8861419033109836432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:36:18.319] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026849096136152944:51:0) after 1m0s
[05:37:18.362] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026849096136152944:51:0)
[05:37:18.362] Timer tick, asking Buildbucket for the build status
[05:37:18.501] Build 8861419033109836432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:37:18.501] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026849096136152944:52:0) after 1m0s
[05:38:18.520] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026849096136152944:52:0)
[05:38:18.520] Timer tick, asking Buildbucket for the build status
[05:38:18.710] Build 8861419033109836432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:38:18.710] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026849096136152944:53:0) after 1m0s
[05:39:18.800] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026849096136152944:53:0)
[05:39:18.800] Timer tick, asking Buildbucket for the build status
[05:39:18.883] Build 8861419033109836432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:39:18.883] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026849096136152944:54:0) after 1m0s
[05:40:18.972] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026849096136152944:54:0)
[05:40:18.972] Timer tick, asking Buildbucket for the build status
[05:40:19.045] Build 8861419033109836432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:40:19.045] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026849096136152944:55:0) after 1m0s
[05:41:19.128] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026849096136152944:55:0)
[05:41:19.128] Timer tick, asking Buildbucket for the build status
[05:41:19.187] Build 8861419033109836432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:41:19.187] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026849096136152944:56:0) after 1m0s
[05:42:19.260] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026849096136152944:56:0)
[05:42:19.260] Timer tick, asking Buildbucket for the build status
[05:42:19.344] Build 8861419033109836432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:42:19.344] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026849096136152944:57:0) after 1m0s
[05:43:19.367] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026849096136152944:57:0)
[05:43:19.367] Timer tick, asking Buildbucket for the build status
[05:43:19.497] Build 8861419033109836432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:43:19.497] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026849096136152944:58:0) after 1m0s
[05:44:19.520] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026849096136152944:58:0)
[05:44:19.520] Timer tick, asking Buildbucket for the build status
[05:44:19.602] Build 8861419033109836432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:44:19.602] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026849096136152944:59:0) after 1m0s
[05:45:19.654] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026849096136152944:59:0)
[05:45:19.654] Timer tick, asking Buildbucket for the build status
[05:45:19.745] Build 8861419033109836432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:45:19.745] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026849096136152944:60:0) after 1m0s
[05:46:19.798] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026849096136152944:60:0)
[05:46:19.798] Timer tick, asking Buildbucket for the build status
[05:46:19.894] Build 8861419033109836432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:46:19.894] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026849096136152944:61:0) after 1m0s
[05:47:19.935] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026849096136152944:61:0)
[05:47:19.935] Timer tick, asking Buildbucket for the build status
[05:47:20.139] Build 8861419033109836432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:47:20.139] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026849096136152944:62:0) after 1m0s
[05:47:39.951] Received PubSub notification, asking Buildbucket for the build status
[05:47:40.021] Build 8861419033109836432: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[05:47:40.021] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1607492857851020",
"created_by": "project:chromium",
"created_ts": "1607489283417535",
"id": "8861419033109836432",
"parameters_json": "{\"builder_name\": \"win-asan\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"71592540b7700f5e2b0a70059630d168a263dc27\"}}",
"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}, \"$kitchen/crbug_1150511_keys_with_int_value\": [\"$build/goma.jobs\", \"$recipe_engine/buildbucket.build.infra.swarming.priority\", \"$recipe_engine/buildbucket.build.number\", \"buildnumber\"], \"$recipe_engine/isolated\": {\"server\": \"https://isolateserver.appspot.com\"}, \"$recipe_engine/milo/blamelist_pins\": [{\"host\": \"chromium.googlesource.com\", \"id\": \"71592540b7700f5e2b0a70059630d168a263dc27\", \"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-z6mr\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.memory\", \"buildername\": \"win-asan\", \"buildnumber\": 16112, \"clang_revision\": \"llvmorg-12-init-12923-g6ee22ca6-1\", \"got_angle_revision\": \"f691b3b5096a3a0a80b100b5231fb65042937757\", \"got_dawn_revision\": \"30805557e65102253a77aadb93ea02fd62dde142\", \"got_nacl_revision\": \"3ac0b060c794b64531b47dfded8ff8d951a5c648\", \"got_revision\": \"71592540b7700f5e2b0a70059630d168a263dc27\", \"got_revision_cp\": \"refs/heads/master@{#835062}\", \"got_swarming_client_revision\": \"1a072711d4388c62e02480fabc26c68c24494be9\", \"got_swiftshader_revision\": \"84b9bb6621c7eae8da034d31aceab780d8b1abdc\", \"got_v8_revision\": \"42f37e5cc39bdb88b236c8d48a0d1477526fa02f\", \"got_v8_revision_cp\": \"refs/heads/8.9.124@{#1}\", \"got_webrtc_revision\": \"bb1a28de3cf17476142e9de8ee12fe6c567d06c1\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#32789}\", \"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\": \"71592540b7700f5e2b0a70059630d168a263dc27\", \"swarm_hashes_refs/heads/master(at){#835062}_without_patch\": {\"absl_hardening_tests\": \"a4356bd5929d5bb5b6fc3c7df5e6f4370b40a618\", \"accessibility_unittests\": \"9c1fb4fefbe96959889ed866ba2e628b7b3ea254\", \"angle_unittests\": \"51a1a7d25ad206f6ca3b0156e5298b4c06ccdf25\", \"app_shell_unittests\": \"4ccdea3674d752b272e2f785e3d3bec1b53a638e\", \"aura_unittests\": \"df2155c74bc62a52ebadb6106ed10567c3629a71\", \"base_unittests\": \"e708e917f66e3e7455ee738156f133501e7359ac\", \"base_util_unittests\": \"0dd6f2614f935aacd097388bbafe7f0b0d375b7e\", \"blink_common_unittests\": \"6fd520e2727c9437b0b06ff51141076114f8d3df\", \"blink_fuzzer_unittests\": \"e46555409971e46a581025716b04a6362cfd12b9\", \"blink_heap_unittests\": \"a2cb6901f00d457493658caa847e8c50a7c5944d\", \"blink_platform_unittests\": \"71e7ec4bf4aaa219cf016f7e606d7799e9eec51d\", \"blink_unittests\": \"56c89d9fcb66b94c8a455150d616bcfe6bd1e14a\", \"boringssl_crypto_tests\": \"3294d6091bd27f2a400db1a1de2e936d718cc721\", \"boringssl_ssl_tests\": \"aa95126a7ee258aab0117c7ec1f5312076ea9c38\", \"browser_switcher_bho_unittests\": \"951d3060cfee8f04d91b64e037b2d3cae5ea56ae\", \"browser_tests\": \"138f754657aba287816b2e57ed9b8d493dec7bdd\", \"capture_unittests\": \"dead407106c4f582d331d5abff7e071012f0cdd4\", \"cast_unittests\": \"51da4d526f4e1babbc9c98882b7592a23718cfe8\", \"cc_unittests\": \"7a6551c755f7f62017ee3a5ae398b0a2e589b5dd\", \"chrome_app_unittests\": \"3ac2a25a1655a3d875e75e08277cd8d2c7325242\", \"chrome_cleaner_unittests\": \"0d112d7f8f512af73d4702c425408a68b7829616\", \"chrome_elf_unittests\": \"cc9792adb3532f00859fe4d027bb31b0b0f42cf3\", \"chromedriver_unittests\": \"6f46fcd283434b0b7e075c60c06f8a029cb60cab\", \"components_browsertests\": \"0a4bb291b6d6c34cb80524ad1c71331ad2d278ed\", \"components_unittests\": \"b3bdc33b9bd19d50ce7355d5517412178720b6ae\", \"compositor_unittests\": \"e528f2d15c62f7229fb57f95d6f1d9b9817076df\", \"content_browsertests\": \"385a5cdc8b1e1f4a0721aeb3aa16e7eed8bef762\", \"content_unittests\": \"725cfcf28d76119a3e12d9c6551257de2749a936\", \"courgette_unittests\": \"029170b66e34a12b08e288dd018825e59ec4ae80\", \"crashpad_tests\": \"2d4273154841fed75d3400a2a8beed9914901ef0\", \"cronet_tests\": \"9c81aab9ce4810da76ac6abde71f17b290a6fa64\", \"cronet_unittests\": \"2b23bcc119da875d9464ee6178f163f763d92b84\", \"crypto_unittests\": \"0625558bd64f7be93276886a0721bd23506469e5\", \"delayloads_unittests\": \"5829de25a126ba2ea826c2e7bf9736e2c365b59b\", \"device_unittests\": \"0f38eb6d51c4d551d06e046021fa04e586bc1b22\", \"display_unittests\": \"ba5c6520a96e789040aa0e6b38a55603855e93d0\", \"elevation_service_unittests\": \"f51b064813a5369cc58442d15af9080934bdcef0\", \"events_unittests\": \"12c397241d2a94d814ee38b6ef28c669f4d2953e\", \"extensions_browsertests\": \"ad5e594da7042af9438ed225d5fba977f4312f56\", \"extensions_unittests\": \"fcfb66f6bdee4fdc9babd0d9396ab024fcf9bfd9\", \"filesystem_service_unittests\": \"801dd8fc2e1b0742b2a584b8395a6df971e26634\", \"gcm_unit_tests\": \"ebe7949eebb0407d386537eefd5c28be3089fceb\", \"gcp_unittests\": \"5b4d35d731a7a773ab848072e2742404ce6c2c23\", \"gfx_unittests\": \"5027bcc2541ecb4b8d255c09c48a4fe257db2f29\", \"gin_unittests\": \"e6149494b1f09f9a727b180a1eb7c714827faa42\", \"google_apis_unittests\": \"48e29dd6206f83eda8195915fba16d0d448da8eb\", \"gpu_unittests\": \"a14bdaf65e13eb65f38a5fab0154ba0a87ce9f4a\", \"gwp_asan_unittests\": \"6a4f281a2d044371107417c1bc544bbe57469b68\", \"headless_browsertests\": \"91e877f0aee9d57b4767e4df01c5c0fead679823\", \"headless_unittests\": \"390bad0f9e8a98c992f18bb8a9b057b9e84aa05c\", \"install_static_unittests\": \"59c8afe7437de25932ea97b79494712049cab515\", \"installer_util_unittests\": \"5533fb67ee5e7a37312f883ced6fb5b9f6fc53ae\", \"interactive_ui_tests\": \"331c34e95adfbc83205f3dcf3f6b7557018e34ff\", \"ipc_tests\": \"a7f31cbe4a93d3ae5d2f798987d893086abccfea\", \"jingle_unittests\": \"27e717eaabcdc82908668968ddfd2799ee89401a\", \"latency_unittests\": \"df4cda3d01fce916a1c488bc887c804628fabafb\", \"libjingle_xmpp_unittests\": \"df5d2d64d22194714d6b1850d8a187c1003db122\", \"liburlpattern_unittests\": \"eed5c0c14a117c896bf30d3da15b566b5dae1b7b\", \"media_blink_unittests\": \"37fbb0b077d7ece4755468bd4c64a8ec90dacf67\", \"media_unittests\": \"3bd75e3a625d5eeff13af42b2732b99fa0d21431\", \"message_center_unittests\": \"0d92b9b6f3bba47883b97b0a2993d67740a92dcf\", \"midi_unittests\": \"9865d5f4c6dfaf8b287b59aa564b360ad67e30dd\", \"mojo_core_unittests\": \"ca1226db6699b59d269bfc4b9bbc20d235e381b0\", \"mojo_unittests\": \"09942044a1324ab46cbd7e2d5ee19784f98205ca\", \"nacl_loader_unittests\": \"00a6df91dfe0d95b6d48202acc85cb92a86775f2\", \"native_theme_unittests\": \"b11acea52f4e58cecfdab7ff81d9e43b8a5a5b75\", \"net_unittests\": \"cf070eea65326ce0994c4ca2a6ee5a5bc847b253\", \"notification_helper_unittests\": \"b467c780d94a80f79d82b6bb4a1e3c88f0885006\", \"pdf_unittests\": \"95cbd710bd4fb217126d1094cb955affb6239687\", \"perfetto_unittests\": \"addf28c02fec54ffd6d29c172f12b4153160febf\", \"ppapi_unittests\": \"05595b1f779d28ac7c1adbb8b38770d666d4d81b\", \"printing_unittests\": \"b407be257ac0ce1da4d79200418763b49f85da2f\", \"remoting_unittests\": \"56c9c0d58d4ad492205b039690f6b644b931f591\", \"sbox_integration_tests\": \"393acc8b769463b84f1ba210a74d6c25a71ed5e1\", \"sbox_unittests\": \"4401997a2b78d44e8fdc0b9eeae35018d565bebb\", \"sbox_validation_tests\": \"6c8f32dfd011fee669de4101099a3e837b25a502\", \"service_manager_unittests\": \"d4e781eb7e183420543533e05b31a750b479d934\", \"services_unittests\": \"989b74f3de6e5b40a81495c11f989448b01ef3c4\", \"setup_unittests\": \"7848558446e973d2e5385ccab62e15e3e177e340\", \"shell_dialogs_unittests\": \"5d843ea8591bcc5bec58c10f1b5bd6469b3013bf\", \"skia_unittests\": \"038d775e95b8b22702464e991bff180e7ee210b4\", \"snapshot_unittests\": \"ae87abe63c49fd8ea26e19de2885ad21d56a9af2\", \"sql_unittests\": \"245d4636ef632a724aa72cbbac05140a7c342fda\", \"storage_unittests\": \"b02a321ace0669c62a3c5b732bbe303500286901\", \"sync_integration_tests\": \"c52a4efaea74ca5f2d9a15e4003582ca620b8209\", \"traffic_annotation_auditor_unittests\": \"e2fc6c8bc95f8d3a35d498584c9519f5e5575f86\", \"ui_base_unittests\": \"4e7b91b9231f511b2bc92afcadfca35c457922a2\", \"ui_touch_selection_unittests\": \"18328176e4a7c843da74da3349ed2b90a5a1b88d\", \"unit_tests\": \"a6cc61420dbe98a526f675390f11f878c045e80f\", \"updater_tests\": \"37304fb1ccc1220c8890ffac8b15c8d135493b2d\", \"url_unittests\": \"b663f14b5d4e13effa342e93a64c9e9000ef2398\", \"views_unittests\": \"20ff5bacce89afec06c87bc6b8def5741b936d76\", \"viz_unittests\": \"773a37a65ef246c61e83180cd9db08f30f166efd\", \"vr_common_unittests\": \"706965d59d844d38f239b6773a94bf29763f5a00\", \"vr_pixeltests\": \"e4146c23b8ed782eff93f925ce08e7b23c1494a9\", \"weblayer_browsertests\": \"310f48c4fdb70e85bcb7af611c7859318a882a45\", \"weblayer_unittests\": \"94a1d669e9384aefb746b37e85db15abb66dc87b\", \"wm_unittests\": \"1b6585ab182e249c16a4b88f716cc7c019d59a24\", \"wtf_unittests\": \"e8b29c7e8664d0ea73ff641139c31d0374c91eb7\", \"zlib_unittests\": \"3a0936ddca59f47fee7cfa2cdf269d5c5c561c04\", \"zucchini_unittests\": \"bc52b6544f8fd80e666445871f6ef30dcc53acfa\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_c244a7c1904bb59c4b6cd021ade0aa3730bbe3d07abc076b32cf6cdc63527337_v2\", \"builder_f77c1c08af9d0a4522ad60c9181aa925a8ae87fd7ec8443f284fb40f3b6bc27b_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-z6mr\"], \"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\": [\"5640-d0eb544\"], \"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": "1607489285823094",
"status": "COMPLETED",
"status_changed_ts": "1607492858314442",
"tags": [
"build_address:luci.chromium.ci/win-asan/16112",
"builder:win-asan",
"buildset:commit/git/71592540b7700f5e2b0a70059630d168a263dc27",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/71592540b7700f5e2b0a70059630d168a263dc27",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9026849096136152944",
"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/8861419033109836432/+/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:505ea570bc40df10",
"user_agent:luci-scheduler"
],
"updated_ts": "1607492858463625",
"url": "https://ci.chromium.org/b/8861419033109836432",
"utcnow_ts": "1607492860012305"
}
}
[05:47:40.021] Invocation finished in 59m38.873926606s with status SUCCEEDED