[15:37:28.305] New invocation is queued and will start shortly
[15:37:29.396] Starting the invocation (attempt 1)
[15:37:29.447] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/9ddfe9a47c8234bf96c749885668a44147934d7d"
[15:37:29.447] Popped gitiles commit info from properties and tags
[15:37:29.447] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[15:37:29.447] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[15:37:29.448] Buildbucket request:
{
"requestId": "8957048571989710608",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "Win 10 Fast Ring"
},
"properties": {
},
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "9ddfe9a47c8234bf96c749885668a44147934d7d",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8957048571989710608"
},
{
"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"
}
}
[15:37:29.878] Scheduled build:
{
"id": "8791618510056856769",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "Win 10 Fast Ring"
},
"number": 13092,
"createdBy": "project:chromium",
"createTime": "2023-01-18T15:37:29.524796678Z",
"updateTime": "2023-01-18T15:37:29.524796678Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "9ddfe9a47c8234bf96c749885668a44147934d7d",
"ref": "refs/heads/main"
}
}
}
[15:37:29.878] Task URL: https://cr-buildbucket.appspot.com/build/8791618510056856769
[15:37:29.878] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8957048571989710608:2:0) after 9m15s
[15:43:30.629] Received PubSub notification, asking Buildbucket for the build status
[15:43:30.662] Build status: STARTED
[15:46:44.968] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8957048571989710608:2:0)
[15:46:44.989] Build status: STARTED
[15:46:44.989] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8957048571989710608:4:0) after 3m15s
[15:50:00.073] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8957048571989710608:4:0)
[15:50:00.099] Build status: STARTED
[15:50:00.099] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8957048571989710608:5:0) after 6m40s
[15:56:40.332] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8957048571989710608:5:0)
[15:56:40.355] Build status: STARTED
[15:56:40.355] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8957048571989710608:6:0) after 7m59s
[16:04:39.608] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8957048571989710608:6:0)
[16:04:39.646] Build status: STARTED
[16:04:39.646] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8957048571989710608:7:0) after 5m25s
[16:10:04.771] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8957048571989710608:7:0)
[16:10:04.802] Build status: STARTED
[16:10:04.802] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8957048571989710608:8:0) after 3m33s
[16:13:37.837] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8957048571989710608:8:0)
[16:13:37.861] Build status: STARTED
[16:13:37.861] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8957048571989710608:9:0) after 8m45s
[16:22:22.936] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8957048571989710608:9:0)
[16:22:22.960] Build status: STARTED
[16:22:22.960] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8957048571989710608:10:0) after 7m33s
[16:29:55.997] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8957048571989710608:10:0)
[16:29:56.016] Build status: STARTED
[16:29:56.016] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8957048571989710608:11:0) after 9m40s
[16:39:36.222] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8957048571989710608:11:0)
[16:39:36.279] Build status: STARTED
[16:39:36.279] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8957048571989710608:12:0) after 1m38s
[16:41:14.650] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8957048571989710608:12:0)
[16:41:14.706] Build status: STARTED
[16:41:14.706] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8957048571989710608:13:0) after 2m36s
[16:43:50.734] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8957048571989710608:13:0)
[16:43:50.757] Build status: STARTED
[16:43:50.757] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8957048571989710608:14:0) after 7m17s
[16:51:07.982] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8957048571989710608:14:0)
[16:51:08.063] Build status: STARTED
[16:51:08.063] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8957048571989710608:15:0) after 2m53s
[16:54:01.623] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8957048571989710608:15:0)
[16:54:01.664] Build status: STARTED
[16:54:01.664] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8957048571989710608:16:0) after 8m37s
[17:02:38.734] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8957048571989710608:16:0)
[17:02:38.752] Build status: STARTED
[17:02:38.752] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8957048571989710608:17:0) after 2m42s
[17:05:20.916] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8957048571989710608:17:0)
[17:05:20.944] Build status: STARTED
[17:05:20.944] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8957048571989710608:18:0) after 8m14s
[17:13:35.585] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8957048571989710608:18:0)
[17:13:35.643] Build status: STARTED
[17:13:35.643] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8957048571989710608:19:0) after 9m35s
[17:23:10.921] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8957048571989710608:19:0)
[17:23:10.952] Build status: STARTED
[17:23:10.952] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8957048571989710608:20:0) after 5m1s
[17:28:12.138] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8957048571989710608:20:0)
[17:28:12.163] Build status: STARTED
[17:28:12.163] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8957048571989710608:21:0) after 7m29s
[17:35:41.304] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8957048571989710608:21:0)
[17:35:41.425] Build status: STARTED
[17:35:41.425] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8957048571989710608:22:0) after 5m8s
[17:40:49.450] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8957048571989710608:22:0)
[17:40:49.472] Build status: STARTED
[17:40:49.472] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8957048571989710608:23:0) after 8m54s
[17:49:43.565] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8957048571989710608:23:0)
[17:49:43.592] Build status: STARTED
[17:49:43.592] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8957048571989710608:24:0) after 6m8s
[17:55:51.626] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8957048571989710608:24:0)
[17:55:51.649] Build status: STARTED
[17:55:51.649] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8957048571989710608:25:0) after 4m41s
[18:00:32.937] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8957048571989710608:25:0)
[18:00:33.235] Build status: STARTED
[18:00:33.235] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8957048571989710608:26:0) after 6m50s
[18:07:23.564] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8957048571989710608:26:0)
[18:07:23.585] Build status: STARTED
[18:07:23.585] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8957048571989710608:27:0) after 8m55s
[18:16:18.613] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8957048571989710608:27:0)
[18:16:18.633] Build status: STARTED
[18:16:18.633] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8957048571989710608:28:0) after 8m26s
[18:24:44.918] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8957048571989710608:28:0)
[18:24:44.942] Build status: STARTED
[18:24:44.943] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8957048571989710608:29:0) after 1m25s
[18:26:10.413] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8957048571989710608:29:0)
[18:26:10.438] Build status: STARTED
[18:26:10.438] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8957048571989710608:30:0) after 4m41s
[18:30:51.513] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8957048571989710608:30:0)
[18:30:51.536] Build status: STARTED
[18:30:51.536] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8957048571989710608:31:0) after 2m9s
[18:33:00.561] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8957048571989710608:31:0)
[18:33:00.592] Build status: STARTED
[18:33:00.592] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8957048571989710608:32:0) after 8m31s
[18:41:31.620] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8957048571989710608:32:0)
[18:41:31.762] Build status: STARTED
[18:41:31.762] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8957048571989710608:33:0) after 9m4s
[18:50:36.330] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8957048571989710608:33:0)
[18:50:36.370] Build status: STARTED
[18:50:36.370] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8957048571989710608:34:0) after 9m3s
[18:59:39.404] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8957048571989710608:34:0)
[18:59:39.434] Build status: STARTED
[18:59:39.434] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8957048571989710608:35:0) after 3m37s
[19:03:16.808] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8957048571989710608:35:0)
[19:03:16.859] Build status: STARTED
[19:03:16.859] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8957048571989710608:36:0) after 2m8s
[19:05:25.062] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8957048571989710608:36:0)
[19:05:25.106] Build status: STARTED
[19:05:25.106] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8957048571989710608:37:0) after 6m8s
[19:11:33.144] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8957048571989710608:37:0)
[19:11:33.183] Build status: STARTED
[19:11:33.183] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8957048571989710608:38:0) after 9m44s
[19:21:17.235] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8957048571989710608:38:0)
[19:21:17.328] Build status: STARTED
[19:21:17.329] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8957048571989710608:39:0) after 5m5s
[19:26:22.509] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8957048571989710608:39:0)
[19:26:22.538] Build status: STARTED
[19:26:22.538] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8957048571989710608:40:0) after 5m0s
[19:31:22.710] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8957048571989710608:40:0)
[19:31:22.745] Build status: STARTED
[19:31:22.745] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8957048571989710608:41:0) after 9m21s
[19:40:43.776] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8957048571989710608:41:0)
[19:40:43.798] Build status: STARTED
[19:40:43.798] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8957048571989710608:42:0) after 7m48s
[19:48:31.786] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8957048571989710608:42:0)
[19:48:31.808] Build status: STARTED
[19:48:31.808] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8957048571989710608:43:0) after 9m6s
[19:57:38.495] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8957048571989710608:43:0)
[19:57:38.521] Build status: STARTED
[19:57:38.521] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8957048571989710608:44:0) after 4m48s
[20:02:26.839] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8957048571989710608:44:0)
[20:02:26.866] Build status: STARTED
[20:02:26.866] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8957048571989710608:45:0) after 8m22s
[20:10:48.978] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8957048571989710608:45:0)
[20:10:49.005] Build status: STARTED
[20:10:49.005] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8957048571989710608:46:0) after 2m41s
[20:13:30.394] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8957048571989710608:46:0)
[20:13:30.419] Build status: STARTED
[20:13:30.419] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8957048571989710608:47:0) after 4m25s
[20:17:55.550] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8957048571989710608:47:0)
[20:17:55.584] Build status: STARTED
[20:17:55.584] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8957048571989710608:48:0) after 1m51s
[20:19:46.752] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8957048571989710608:48:0)
[20:19:46.772] Build status: STARTED
[20:19:46.772] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8957048571989710608:49:0) after 8m34s
[20:28:20.792] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8957048571989710608:49:0)
[20:28:20.822] Build status: STARTED
[20:28:20.822] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8957048571989710608:50:0) after 2m29s
[20:30:49.851] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8957048571989710608:50:0)
[20:30:49.914] Build status: STARTED
[20:30:49.914] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8957048571989710608:51:0) after 1m39s
[20:32:29.718] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8957048571989710608:51:0)
[20:32:29.780] Build status: STARTED
[20:32:29.780] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8957048571989710608:52:0) after 8m0s
[20:40:29.820] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8957048571989710608:52:0)
[20:40:29.841] Build status: STARTED
[20:40:29.841] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8957048571989710608:53:0) after 6m57s
[20:47:27.154] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8957048571989710608:53:0)
[20:47:27.183] Build status: STARTED
[20:47:27.183] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8957048571989710608:54:0) after 3m44s
[20:51:11.524] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8957048571989710608:54:0)
[20:51:11.554] Build status: STARTED
[20:51:11.554] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8957048571989710608:55:0) after 4m3s
[20:55:14.578] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8957048571989710608:55:0)
[20:55:14.600] Build status: STARTED
[20:55:14.600] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8957048571989710608:56:0) after 8m23s
[21:03:37.972] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8957048571989710608:56:0)
[21:03:37.999] Build status: STARTED
[21:03:38.000] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8957048571989710608:57:0) after 6m28s
[21:10:06.067] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8957048571989710608:57:0)
[21:10:06.106] Build status: STARTED
[21:10:06.106] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8957048571989710608:58:0) after 7m20s
[21:17:26.398] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8957048571989710608:58:0)
[21:17:26.421] Build status: STARTED
[21:17:26.421] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8957048571989710608:59:0) after 6m48s
[21:24:14.689] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8957048571989710608:59:0)
[21:24:14.715] Build status: STARTED
[21:24:14.716] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8957048571989710608:60:0) after 4m47s
[21:29:01.780] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8957048571989710608:60:0)
[21:29:01.805] Build status: STARTED
[21:29:01.805] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8957048571989710608:61:0) after 9m22s
[21:38:23.844] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8957048571989710608:61:0)
[21:38:23.869] Build status: STARTED
[21:38:23.869] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8957048571989710608:62:0) after 6m36s
[21:44:59.995] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8957048571989710608:62:0)
[21:45:00.044] Build status: STARTED
[21:45:00.044] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8957048571989710608:63:0) after 2m25s
[21:47:25.553] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8957048571989710608:63:0)
[21:47:25.574] Build status: STARTED
[21:47:25.574] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8957048571989710608:64:0) after 3m8s
[21:50:33.597] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8957048571989710608:64:0)
[21:50:33.614] Build status: STARTED
[21:50:33.614] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8957048571989710608:65:0) after 3m50s
[21:54:23.633] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8957048571989710608:65:0)
[21:54:23.660] Build status: STARTED
[21:54:23.660] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8957048571989710608:66:0) after 9m21s
[22:03:45.083] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8957048571989710608:66:0)
[22:03:45.110] Build status: STARTED
[22:03:45.110] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8957048571989710608:67:0) after 1m48s
[22:05:33.134] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8957048571989710608:67:0)
[22:05:33.154] Build status: STARTED
[22:05:33.154] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8957048571989710608:68:0) after 5m3s
[22:10:36.215] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8957048571989710608:68:0)
[22:10:36.259] Build status: STARTED
[22:10:36.259] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8957048571989710608:69:0) after 6m30s
[22:17:06.621] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8957048571989710608:69:0)
[22:17:06.641] Build status: STARTED
[22:17:06.641] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8957048571989710608:70:0) after 4m28s
[22:21:34.682] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8957048571989710608:70:0)
[22:21:34.723] Build status: STARTED
[22:21:34.723] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8957048571989710608:71:0) after 3m17s
[22:24:51.975] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8957048571989710608:71:0)
[22:24:52.004] Build status: STARTED
[22:24:52.004] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8957048571989710608:72:0) after 5m55s
[22:30:47.306] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8957048571989710608:72:0)
[22:30:47.332] Build status: STARTED
[22:30:47.332] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8957048571989710608:73:0) after 8m40s
[22:39:27.687] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8957048571989710608:73:0)
[22:39:27.711] Build status: STARTED
[22:39:27.711] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8957048571989710608:74:0) after 8m11s
[22:47:39.406] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8957048571989710608:74:0)
[22:47:39.432] Build status: STARTED
[22:47:39.432] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8957048571989710608:75:0) after 2m24s
[22:50:03.682] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8957048571989710608:75:0)
[22:50:03.720] Build status: STARTED
[22:50:03.720] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8957048571989710608:76:0) after 6m12s
[22:56:15.811] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8957048571989710608:76:0)
[22:56:15.838] Build status: STARTED
[22:56:15.838] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8957048571989710608:77:0) after 5m4s
[23:01:19.958] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8957048571989710608:77:0)
[23:01:19.984] Build status: STARTED
[23:01:19.984] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8957048571989710608:78:0) after 7m5s
[23:08:25.009] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8957048571989710608:78:0)
[23:08:25.037] Build status: STARTED
[23:08:25.037] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8957048571989710608:79:0) after 2m26s
[23:10:51.349] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8957048571989710608:79:0)
[23:10:51.371] Build status: STARTED
[23:10:51.371] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8957048571989710608:80:0) after 4m5s
[23:14:56.517] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8957048571989710608:80:0)
[23:14:56.540] Build status: STARTED
[23:14:56.540] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8957048571989710608:81:0) after 3m27s
[23:18:23.712] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8957048571989710608:81:0)
[23:18:23.733] Build status: STARTED
[23:18:23.733] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8957048571989710608:82:0) after 3m16s
[23:21:39.959] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8957048571989710608:82:0)
[23:21:39.981] Build status: STARTED
[23:21:39.981] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8957048571989710608:83:0) after 6m7s
[23:27:47.011] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8957048571989710608:83:0)
[23:27:47.029] Build status: STARTED
[23:27:47.029] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8957048571989710608:84:0) after 3m2s
[23:30:49.331] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8957048571989710608:84:0)
[23:30:49.362] Build status: STARTED
[23:30:49.362] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8957048571989710608:85:0) after 7m19s
[23:38:08.800] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8957048571989710608:85:0)
[23:38:08.821] Build status: STARTED
[23:38:08.821] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8957048571989710608:86:0) after 6m49s
[23:44:57.849] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8957048571989710608:86:0)
[23:44:57.871] Build status: STARTED
[23:44:57.871] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8957048571989710608:87:0) after 7m29s
[23:52:26.925] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8957048571989710608:87:0)
[23:52:26.948] Build status: STARTED
[23:52:26.948] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8957048571989710608:88:0) after 5m40s
[23:58:07.541] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8957048571989710608:88:0)
[23:58:07.569] Build status: STARTED
[23:58:07.569] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8957048571989710608:89:0) after 2m46s
[00:00:53.659] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8957048571989710608:89:0)
[00:00:53.679] Build status: STARTED
[00:00:53.679] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8957048571989710608:90:0) after 6m52s
[00:07:45.778] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8957048571989710608:90:0)
[00:07:45.805] Build status: STARTED
[00:07:45.805] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8957048571989710608:91:0) after 4m55s
[00:12:40.809] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8957048571989710608:91:0)
[00:12:40.845] Build status: STARTED
[00:12:40.845] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8957048571989710608:92:0) after 7m2s
[00:19:43.086] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8957048571989710608:92:0)
[00:19:43.107] Build status: STARTED
[00:19:43.107] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8957048571989710608:93:0) after 3m4s
[00:22:47.208] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8957048571989710608:93:0)
[00:22:47.273] Build status: STARTED
[00:22:47.273] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8957048571989710608:94:0) after 1m55s
[00:24:42.565] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8957048571989710608:94:0)
[00:24:42.630] Build status: STARTED
[00:24:42.630] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8957048571989710608:95:0) after 5m22s
[00:30:04.650] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8957048571989710608:95:0)
[00:30:04.694] Build status: STARTED
[00:30:04.694] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8957048571989710608:96:0) after 6m22s
[00:36:27.004] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8957048571989710608:96:0)
[00:36:27.027] Build status: STARTED
[00:36:27.027] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8957048571989710608:97:0) after 5m55s
[00:42:22.015] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8957048571989710608:97:0)
[00:42:22.191] Build status: STARTED
[00:42:22.191] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8957048571989710608:98:0) after 8m27s
[00:50:49.761] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8957048571989710608:98:0)
[00:50:49.785] Build status: STARTED
[00:50:49.785] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8957048571989710608:99:0) after 3m33s
[00:54:22.880] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8957048571989710608:99:0)
[00:54:22.903] Build status: STARTED
[00:54:22.903] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8957048571989710608:100:0) after 3m14s
[00:57:37.125] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8957048571989710608:100:0)
[00:57:37.148] Build status: STARTED
[00:57:37.148] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8957048571989710608:101:0) after 5m41s
[01:03:18.170] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8957048571989710608:101:0)
[01:03:18.196] Build status: STARTED
[01:03:18.196] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8957048571989710608:102:0) after 5m41s
[01:08:59.324] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8957048571989710608:102:0)
[01:08:59.346] Build status: STARTED
[01:08:59.346] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8957048571989710608:103:0) after 2m37s
[01:11:36.377] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8957048571989710608:103:0)
[01:11:36.402] Build status: STARTED
[01:11:36.402] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8957048571989710608:104:0) after 9m46s
[01:21:22.424] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8957048571989710608:104:0)
[01:21:22.464] Build status: STARTED
[01:21:22.464] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8957048571989710608:105:0) after 4m28s
[01:25:50.747] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8957048571989710608:105:0)
[01:25:50.772] Build status: STARTED
[01:25:50.772] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8957048571989710608:106:0) after 3m28s
[01:29:18.902] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8957048571989710608:106:0)
[01:29:18.930] Build status: STARTED
[01:29:18.930] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8957048571989710608:107:0) after 2m6s
[01:31:25.136] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8957048571989710608:107:0)
[01:31:25.162] Build status: STARTED
[01:31:25.162] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8957048571989710608:108:0) after 6m26s
[01:37:51.440] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8957048571989710608:108:0)
[01:37:51.538] Build status: STARTED
[01:37:51.538] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8957048571989710608:109:0) after 6m37s
[01:44:28.985] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8957048571989710608:109:0)
[01:44:29.018] Build status: STARTED
[01:44:29.018] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8957048571989710608:110:0) after 3m9s
[01:47:38.707] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8957048571989710608:110:0)
[01:47:38.730] Build status: STARTED
[01:47:38.730] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8957048571989710608:111:0) after 4m8s
[01:51:46.967] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8957048571989710608:111:0)
[01:51:46.986] Build status: STARTED
[01:51:46.986] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8957048571989710608:112:0) after 5m39s
[01:57:26.183] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8957048571989710608:112:0)
[01:57:26.211] Build status: STARTED
[01:57:26.211] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8957048571989710608:113:0) after 5m24s
[02:02:50.543] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8957048571989710608:113:0)
[02:02:50.568] Build status: STARTED
[02:02:50.568] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8957048571989710608:114:0) after 5m20s
[02:02:52.656] Received PubSub notification, asking Buildbucket for the build status
[02:02:52.737] Build:
{
"id": "8791618510056856769",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "Win 10 Fast Ring"
},
"number": 13092,
"createdBy": "project:chromium",
"createTime": "2023-01-18T15:37:29.524796678Z",
"startTime": "2023-01-18T15:43:30.099051Z",
"endTime": "2023-01-19T02:02:52.121261Z",
"updateTime": "2023-01-19T02:02:52.121261Z",
"status": "INFRA_FAILURE",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "9ddfe9a47c8234bf96c749885668a44147934d7d",
"ref": "refs/heads/main"
}
}
}
[02:02:52.737] Invocation finished in 10h25m24.438889919s with status FAILED