[19:10:11.289] New invocation is queued and will start shortly
[19:10:12.417] Starting the invocation (attempt 1)
[19:10:12.465] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/c73b778f44bb06906ddf8308c031dfaf6c525f67"
[19:10:12.465] Popped gitiles commit info from properties and tags
[19:10:12.465] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[19:10:12.465] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[19:10:12.465] Buildbucket request:
{
"requestId": "8963014588821759424",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "Win 10 Fast Ring"
},
"properties": {
},
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "c73b778f44bb06906ddf8308c031dfaf6c525f67",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8963014588821759424"
},
{
"key": "scheduler_job_id",
"value": "chromium/Win 10 Fast Ring"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[19:10:12.979] Scheduled build:
{
"id": "8797584526799468385",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "Win 10 Fast Ring"
},
"number": 11981,
"createdBy": "project:chromium",
"createTime": "2022-11-13T19:10:12.586108232Z",
"updateTime": "2022-11-13T19:10:12.586108232Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "c73b778f44bb06906ddf8308c031dfaf6c525f67",
"ref": "refs/heads/main"
}
}
}
[19:10:12.979] Task URL: https://cr-buildbucket.appspot.com/build/8797584526799468385
[19:10:12.979] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8963014588821759424:2:0) after 3m52s
[19:14:05.200] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8963014588821759424:2:0)
[19:14:05.233] Build status: SCHEDULED
[19:14:05.233] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8963014588821759424:3:0) after 8m35s
[19:20:20.656] Received PubSub notification, asking Buildbucket for the build status
[19:20:20.679] Build status: STARTED
[19:22:40.556] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8963014588821759424:3:0)
[19:22:40.601] Build status: STARTED
[19:22:40.601] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8963014588821759424:5:0) after 6m19s
[19:28:59.771] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8963014588821759424:5:0)
[19:28:59.800] Build status: STARTED
[19:28:59.800] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8963014588821759424:6:0) after 7m31s
[19:36:30.926] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8963014588821759424:6:0)
[19:36:30.958] Build status: STARTED
[19:36:30.958] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8963014588821759424:7:0) after 2m33s
[19:39:03.953] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8963014588821759424:7:0)
[19:39:03.974] Build status: STARTED
[19:39:03.974] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8963014588821759424:8:0) after 6m35s
[19:45:39.081] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8963014588821759424:8:0)
[19:45:39.114] Build status: STARTED
[19:45:39.114] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8963014588821759424:9:0) after 7m20s
[19:52:59.252] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8963014588821759424:9:0)
[19:52:59.277] Build status: STARTED
[19:52:59.277] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8963014588821759424:10:0) after 5m53s
[19:58:52.298] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8963014588821759424:10:0)
[19:58:52.321] Build status: STARTED
[19:58:52.321] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8963014588821759424:11:0) after 7m54s
[20:06:46.347] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8963014588821759424:11:0)
[20:06:46.372] Build status: STARTED
[20:06:46.373] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8963014588821759424:12:0) after 7m0s
[20:13:46.403] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8963014588821759424:12:0)
[20:13:46.425] Build status: STARTED
[20:13:46.425] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8963014588821759424:13:0) after 2m8s
[20:15:54.451] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8963014588821759424:13:0)
[20:15:54.472] Build status: STARTED
[20:15:54.472] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8963014588821759424:14:0) after 2m2s
[20:17:56.536] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8963014588821759424:14:0)
[20:17:56.560] Build status: STARTED
[20:17:56.560] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8963014588821759424:15:0) after 5m15s
[20:23:11.721] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8963014588821759424:15:0)
[20:23:11.747] Build status: STARTED
[20:23:11.747] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8963014588821759424:16:0) after 8m23s
[20:31:34.825] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8963014588821759424:16:0)
[20:31:34.848] Build status: STARTED
[20:31:34.848] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8963014588821759424:17:0) after 5m27s
[20:37:01.886] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8963014588821759424:17:0)
[20:37:01.911] Build status: STARTED
[20:37:01.911] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8963014588821759424:18:0) after 9m18s
[20:46:19.938] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8963014588821759424:18:0)
[20:46:19.960] Build status: STARTED
[20:46:19.960] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8963014588821759424:19:0) after 8m29s
[20:54:48.949] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8963014588821759424:19:0)
[20:54:48.989] Build status: STARTED
[20:54:48.989] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8963014588821759424:20:0) after 4m26s
[20:59:15.016] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8963014588821759424:20:0)
[20:59:15.038] Build status: STARTED
[20:59:15.038] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8963014588821759424:21:0) after 3m12s
[21:02:27.144] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8963014588821759424:21:0)
[21:02:27.168] Build status: STARTED
[21:02:27.168] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8963014588821759424:22:0) after 8m35s
[21:11:02.330] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8963014588821759424:22:0)
[21:11:02.359] Build status: STARTED
[21:11:02.359] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8963014588821759424:23:0) after 5m55s
[21:16:57.401] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8963014588821759424:23:0)
[21:16:57.427] Build status: STARTED
[21:16:57.427] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8963014588821759424:24:0) after 3m12s
[21:20:09.460] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8963014588821759424:24:0)
[21:20:09.486] Build status: STARTED
[21:20:09.486] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8963014588821759424:25:0) after 6m3s
[21:26:12.602] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8963014588821759424:25:0)
[21:26:12.624] Build status: STARTED
[21:26:12.624] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8963014588821759424:26:0) after 5m25s
[21:31:37.606] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8963014588821759424:26:0)
[21:31:37.630] Build status: STARTED
[21:31:37.630] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8963014588821759424:27:0) after 5m18s
[21:36:55.686] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8963014588821759424:27:0)
[21:36:55.712] Build status: STARTED
[21:36:55.712] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8963014588821759424:28:0) after 4m19s
[21:41:14.946] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8963014588821759424:28:0)
[21:41:15.165] Build status: STARTED
[21:41:15.165] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8963014588821759424:29:0) after 6m54s
[21:48:09.374] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8963014588821759424:29:0)
[21:48:09.404] Build status: STARTED
[21:48:09.404] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8963014588821759424:30:0) after 1m34s
[21:49:43.429] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8963014588821759424:30:0)
[21:49:43.457] Build status: STARTED
[21:49:43.457] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8963014588821759424:31:0) after 5m43s
[21:55:26.501] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8963014588821759424:31:0)
[21:55:26.539] Build status: STARTED
[21:55:26.539] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8963014588821759424:32:0) after 3m29s
[21:58:55.570] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8963014588821759424:32:0)
[21:58:55.674] Build status: STARTED
[21:58:55.674] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8963014588821759424:33:0) after 5m44s
[22:04:39.787] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8963014588821759424:33:0)
[22:04:39.812] Build status: STARTED
[22:04:39.812] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8963014588821759424:34:0) after 8m26s
[22:13:05.898] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8963014588821759424:34:0)
[22:13:05.924] Build status: STARTED
[22:13:05.924] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8963014588821759424:35:0) after 4m26s
[22:17:31.957] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8963014588821759424:35:0)
[22:17:31.981] Build status: STARTED
[22:17:31.981] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8963014588821759424:36:0) after 8m50s
[22:26:22.005] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8963014588821759424:36:0)
[22:26:22.027] Build status: STARTED
[22:26:22.027] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8963014588821759424:37:0) after 8m9s
[22:34:31.055] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8963014588821759424:37:0)
[22:34:31.083] Build status: STARTED
[22:34:31.083] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8963014588821759424:38:0) after 2m56s
[22:37:27.260] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8963014588821759424:38:0)
[22:37:27.284] Build status: STARTED
[22:37:27.284] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8963014588821759424:39:0) after 1m31s
[22:38:58.323] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8963014588821759424:39:0)
[22:38:58.348] Build status: STARTED
[22:38:58.348] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8963014588821759424:40:0) after 9m16s
[22:48:14.585] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8963014588821759424:40:0)
[22:48:14.614] Build status: STARTED
[22:48:14.614] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8963014588821759424:41:0) after 5m6s
[22:53:20.929] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8963014588821759424:41:0)
[22:53:20.956] Build status: STARTED
[22:53:20.956] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8963014588821759424:42:0) after 2m48s
[22:56:09.087] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8963014588821759424:42:0)
[22:56:09.118] Build status: STARTED
[22:56:09.118] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8963014588821759424:43:0) after 8m38s
[23:04:47.145] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8963014588821759424:43:0)
[23:04:47.172] Build status: STARTED
[23:04:47.172] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8963014588821759424:44:0) after 3m54s
[23:08:41.198] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8963014588821759424:44:0)
[23:08:41.220] Build status: STARTED
[23:08:41.220] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8963014588821759424:45:0) after 6m56s
[23:15:37.266] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8963014588821759424:45:0)
[23:15:37.289] Build status: STARTED
[23:15:37.289] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8963014588821759424:46:0) after 5m0s
[23:20:37.319] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8963014588821759424:46:0)
[23:20:37.340] Build status: STARTED
[23:20:37.340] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8963014588821759424:47:0) after 8m28s
[23:29:05.365] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8963014588821759424:47:0)
[23:29:05.388] Build status: STARTED
[23:29:05.388] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8963014588821759424:48:0) after 3m29s
[23:32:34.507] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8963014588821759424:48:0)
[23:32:34.530] Build status: STARTED
[23:32:34.530] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8963014588821759424:49:0) after 4m21s
[23:36:55.564] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8963014588821759424:49:0)
[23:36:55.590] Build status: STARTED
[23:36:55.590] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8963014588821759424:50:0) after 1m17s
[23:38:12.615] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8963014588821759424:50:0)
[23:38:12.639] Build status: STARTED
[23:38:12.639] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8963014588821759424:51:0) after 3m0s
[23:41:12.638] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8963014588821759424:51:0)
[23:41:12.670] Build status: STARTED
[23:41:12.670] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8963014588821759424:52:0) after 5m6s
[23:46:18.692] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8963014588821759424:52:0)
[23:46:18.717] Build status: STARTED
[23:46:18.717] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8963014588821759424:53:0) after 9m12s
[23:55:30.741] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8963014588821759424:53:0)
[23:55:30.764] Build status: STARTED
[23:55:30.764] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8963014588821759424:54:0) after 9m56s
[00:05:26.844] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8963014588821759424:54:0)
[00:05:26.926] Build status: STARTED
[00:05:26.927] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8963014588821759424:55:0) after 5m1s
[00:10:27.954] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8963014588821759424:55:0)
[00:10:28.040] Build status: STARTED
[00:10:28.040] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8963014588821759424:56:0) after 6m29s
[00:16:57.069] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8963014588821759424:56:0)
[00:16:57.092] Build status: STARTED
[00:16:57.092] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8963014588821759424:57:0) after 4m47s
[00:21:44.122] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8963014588821759424:57:0)
[00:21:44.158] Build status: STARTED
[00:21:44.158] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8963014588821759424:58:0) after 4m44s
[00:26:28.303] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8963014588821759424:58:0)
[00:26:28.327] Build status: STARTED
[00:26:28.327] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8963014588821759424:59:0) after 5m45s
[00:32:13.413] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8963014588821759424:59:0)
[00:32:13.436] Build status: STARTED
[00:32:13.436] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8963014588821759424:60:0) after 5m18s
[00:37:31.565] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8963014588821759424:60:0)
[00:37:31.593] Build status: STARTED
[00:37:31.593] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8963014588821759424:61:0) after 3m29s
[00:41:00.642] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8963014588821759424:61:0)
[00:41:00.693] Build status: STARTED
[00:41:00.693] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8963014588821759424:62:0) after 2m12s
[00:43:12.773] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8963014588821759424:62:0)
[00:43:12.806] Build status: STARTED
[00:43:12.806] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8963014588821759424:63:0) after 1m19s
[00:44:32.087] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8963014588821759424:63:0)
[00:44:32.117] Build status: STARTED
[00:44:32.117] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8963014588821759424:64:0) after 9m14s
[00:53:46.397] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8963014588821759424:64:0)
[00:53:46.452] Build status: STARTED
[00:53:46.452] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8963014588821759424:65:0) after 3m35s
[00:57:21.479] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8963014588821759424:65:0)
[00:57:21.508] Build status: STARTED
[00:57:21.508] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8963014588821759424:66:0) after 5m21s
[01:02:42.632] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8963014588821759424:66:0)
[01:02:42.656] Build status: STARTED
[01:02:42.656] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8963014588821759424:67:0) after 1m11s
[01:03:53.677] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8963014588821759424:67:0)
[01:03:53.701] Build status: STARTED
[01:03:53.701] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8963014588821759424:68:0) after 8m57s
[01:12:50.763] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8963014588821759424:68:0)
[01:12:50.792] Build status: STARTED
[01:12:50.792] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8963014588821759424:69:0) after 8m5s
[01:20:55.893] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8963014588821759424:69:0)
[01:20:55.916] Build status: STARTED
[01:20:55.916] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8963014588821759424:70:0) after 6m33s
[01:27:29.029] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8963014588821759424:70:0)
[01:27:29.052] Build status: STARTED
[01:27:29.052] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8963014588821759424:71:0) after 9m39s
[01:37:08.113] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8963014588821759424:71:0)
[01:37:08.149] Build status: STARTED
[01:37:08.149] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8963014588821759424:72:0) after 8m34s
[01:45:42.181] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8963014588821759424:72:0)
[01:45:42.203] Build status: STARTED
[01:45:42.203] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8963014588821759424:73:0) after 6m2s
[01:51:44.376] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8963014588821759424:73:0)
[01:51:44.404] Build status: STARTED
[01:51:44.404] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8963014588821759424:74:0) after 6m29s
[01:58:13.515] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8963014588821759424:74:0)
[01:58:13.538] Build status: STARTED
[01:58:13.538] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8963014588821759424:75:0) after 4m58s
[02:03:11.561] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8963014588821759424:75:0)
[02:03:11.584] Build status: STARTED
[02:03:11.584] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8963014588821759424:76:0) after 5m0s
[02:08:11.600] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8963014588821759424:76:0)
[02:08:11.641] Build status: STARTED
[02:08:11.641] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8963014588821759424:77:0) after 1m28s
[02:09:39.931] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8963014588821759424:77:0)
[02:09:39.961] Build status: STARTED
[02:09:39.961] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8963014588821759424:78:0) after 3m6s
[02:12:45.988] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8963014588821759424:78:0)
[02:12:46.026] Build status: STARTED
[02:12:46.026] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8963014588821759424:79:0) after 6m15s
[02:19:01.104] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8963014588821759424:79:0)
[02:19:01.145] Build status: STARTED
[02:19:01.145] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8963014588821759424:80:0) after 5m48s
[02:24:49.170] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8963014588821759424:80:0)
[02:24:49.189] Build status: STARTED
[02:24:49.189] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8963014588821759424:81:0) after 8m50s
[02:33:39.277] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8963014588821759424:81:0)
[02:33:39.302] Build status: STARTED
[02:33:39.302] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8963014588821759424:82:0) after 7m52s
[02:41:31.555] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8963014588821759424:82:0)
[02:41:31.596] Build status: STARTED
[02:41:31.596] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8963014588821759424:83:0) after 2m29s
[02:44:00.680] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8963014588821759424:83:0)
[02:44:00.709] Build status: STARTED
[02:44:00.709] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8963014588821759424:84:0) after 9m54s
[02:53:54.733] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8963014588821759424:84:0)
[02:53:54.757] Build status: STARTED
[02:53:54.757] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8963014588821759424:85:0) after 8m26s
[03:02:20.978] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8963014588821759424:85:0)
[03:02:21.002] Build status: STARTED
[03:02:21.002] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8963014588821759424:86:0) after 8m56s
[03:11:17.070] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8963014588821759424:86:0)
[03:11:17.096] Build status: STARTED
[03:11:17.096] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8963014588821759424:87:0) after 7m19s
[03:18:36.188] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8963014588821759424:87:0)
[03:18:36.224] Build status: STARTED
[03:18:36.224] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8963014588821759424:88:0) after 3m21s
[03:21:57.378] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8963014588821759424:88:0)
[03:21:57.405] Build status: STARTED
[03:21:57.405] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8963014588821759424:89:0) after 4m57s
[03:26:54.386] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8963014588821759424:89:0)
[03:26:54.546] Build status: STARTED
[03:26:54.546] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8963014588821759424:90:0) after 8m32s
[03:35:26.574] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8963014588821759424:90:0)
[03:35:26.644] Build status: STARTED
[03:35:26.644] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8963014588821759424:91:0) after 4m11s
[03:39:37.999] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8963014588821759424:91:0)
[03:39:38.064] Build status: STARTED
[03:39:38.064] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8963014588821759424:92:0) after 9m1s
[03:48:39.161] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8963014588821759424:92:0)
[03:48:39.185] Build status: STARTED
[03:48:39.185] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8963014588821759424:93:0) after 7m35s
[03:56:14.212] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8963014588821759424:93:0)
[03:56:14.237] Build status: STARTED
[03:56:14.237] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8963014588821759424:94:0) after 8m0s
[04:04:14.321] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8963014588821759424:94:0)
[04:04:14.354] Build status: STARTED
[04:04:14.354] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8963014588821759424:95:0) after 7m2s
[04:11:16.479] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8963014588821759424:95:0)
[04:11:16.499] Build status: STARTED
[04:11:16.499] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8963014588821759424:96:0) after 1m50s
[04:13:06.539] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8963014588821759424:96:0)
[04:13:06.575] Build status: STARTED
[04:13:06.575] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8963014588821759424:97:0) after 7m19s
[04:20:25.787] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8963014588821759424:97:0)
[04:20:25.813] Build status: STARTED
[04:20:25.813] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8963014588821759424:98:0) after 5m36s
[04:26:02.063] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8963014588821759424:98:0)
[04:26:02.092] Build status: STARTED
[04:26:02.092] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8963014588821759424:99:0) after 1m28s
[04:27:30.260] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8963014588821759424:99:0)
[04:27:30.389] Build status: STARTED
[04:27:30.389] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8963014588821759424:100:0) after 4m28s
[04:31:58.418] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8963014588821759424:100:0)
[04:31:58.440] Build status: STARTED
[04:31:58.441] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8963014588821759424:101:0) after 2m14s
[04:34:12.710] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8963014588821759424:101:0)
[04:34:12.803] Build status: STARTED
[04:34:12.803] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8963014588821759424:102:0) after 2m15s
[04:36:27.828] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8963014588821759424:102:0)
[04:36:27.860] Build status: STARTED
[04:36:27.860] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8963014588821759424:103:0) after 4m13s
[04:40:40.998] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8963014588821759424:103:0)
[04:40:41.019] Build status: STARTED
[04:40:41.019] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8963014588821759424:104:0) after 4m26s
[04:45:07.107] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8963014588821759424:104:0)
[04:45:07.133] Build status: STARTED
[04:45:07.133] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8963014588821759424:105:0) after 4m1s
[04:49:08.157] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8963014588821759424:105:0)
[04:49:08.207] Build status: STARTED
[04:49:08.207] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8963014588821759424:106:0) after 2m8s
[04:51:16.266] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8963014588821759424:106:0)
[04:51:16.302] Build status: STARTED
[04:51:16.302] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8963014588821759424:107:0) after 4m52s
[04:56:08.358] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8963014588821759424:107:0)
[04:56:08.383] Build status: STARTED
[04:56:08.383] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8963014588821759424:108:0) after 6m44s
[05:02:52.436] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8963014588821759424:108:0)
[05:02:52.466] Build status: STARTED
[05:02:52.466] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8963014588821759424:109:0) after 1m6s
[05:03:58.555] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8963014588821759424:109:0)
[05:03:58.580] Build status: STARTED
[05:03:58.580] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8963014588821759424:110:0) after 8m8s
[05:12:06.561] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8963014588821759424:110:0)
[05:12:06.587] Build status: STARTED
[05:12:06.587] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8963014588821759424:111:0) after 6m6s
[05:18:12.613] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8963014588821759424:111:0)
[05:18:12.642] Build status: STARTED
[05:18:12.643] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8963014588821759424:112:0) after 3m46s
[05:21:45.491] Received PubSub notification, asking Buildbucket for the build status
[05:21:45.596] Build:
{
"id": "8797584526799468385",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "Win 10 Fast Ring"
},
"number": 11981,
"createdBy": "project:chromium",
"createTime": "2022-11-13T19:10:12.586108232Z",
"startTime": "2022-11-13T19:20:20.142717Z",
"endTime": "2022-11-14T05:21:45.173462216Z",
"updateTime": "2022-11-14T05:21:45.173462216Z",
"status": "INFRA_FAILURE",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "c73b778f44bb06906ddf8308c031dfaf6c525f67",
"ref": "refs/heads/main"
}
}
}
[05:21:45.596] Invocation finished in 10h11m34.321974262s with status FAILED