[00:24:07.006] New invocation is queued and will start shortly
[00:24:08.197] Starting the invocation (attempt 1)
[00:24:08.225] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/36d47f9e86fb78ebccab5c67e139697064740224"
[00:24:08.225] Popped gitiles commit info from properties and tags
[00:24:08.226] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[00:24:08.226] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[00:24:08.226] Buildbucket request:
{
"requestId": "8962360659389623472",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "Win 10 Fast Ring"
},
"properties": {
},
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "36d47f9e86fb78ebccab5c67e139697064740224",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8962360659389623472"
},
{
"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"
}
}
[00:24:08.747] Scheduled build:
{
"id": "8796930597365442049",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "Win 10 Fast Ring"
},
"number": 11998,
"createdBy": "project:chromium",
"createTime": "2022-11-21T00:24:08.292288380Z",
"updateTime": "2022-11-21T00:24:08.292288380Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "36d47f9e86fb78ebccab5c67e139697064740224",
"ref": "refs/heads/main"
}
}
}
[00:24:08.747] Task URL: https://cr-buildbucket.appspot.com/build/8796930597365442049
[00:24:08.747] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8962360659389623472:2:0) after 2m5s
[00:26:13.766] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8962360659389623472:2:0)
[00:26:13.789] Build status: SCHEDULED
[00:26:13.789] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8962360659389623472:3:0) after 5m10s
[00:29:16.735] Received PubSub notification, asking Buildbucket for the build status
[00:29:16.755] Build status: STARTED
[00:31:23.854] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8962360659389623472:3:0)
[00:31:23.877] Build status: STARTED
[00:31:23.877] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8962360659389623472:5:0) after 3m0s
[00:34:23.894] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8962360659389623472:5:0)
[00:34:23.913] Build status: STARTED
[00:34:23.913] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8962360659389623472:6:0) after 6m48s
[00:41:12.108] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8962360659389623472:6:0)
[00:41:12.138] Build status: STARTED
[00:41:12.138] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8962360659389623472:7:0) after 1m16s
[00:42:28.397] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8962360659389623472:7:0)
[00:42:28.419] Build status: STARTED
[00:42:28.419] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8962360659389623472:8:0) after 9m1s
[00:51:29.444] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8962360659389623472:8:0)
[00:51:29.470] Build status: STARTED
[00:51:29.470] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8962360659389623472:9:0) after 3m54s
[00:55:23.676] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8962360659389623472:9:0)
[00:55:23.737] Build status: STARTED
[00:55:23.737] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8962360659389623472:10:0) after 6m24s
[01:01:47.760] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8962360659389623472:10:0)
[01:01:47.803] Build status: STARTED
[01:01:47.803] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8962360659389623472:11:0) after 1m28s
[01:03:15.829] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8962360659389623472:11:0)
[01:03:15.851] Build status: STARTED
[01:03:15.851] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8962360659389623472:12:0) after 4m37s
[01:07:52.868] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8962360659389623472:12:0)
[01:07:52.889] Build status: STARTED
[01:07:52.889] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8962360659389623472:13:0) after 9m13s
[01:17:06.044] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8962360659389623472:13:0)
[01:17:06.082] Build status: STARTED
[01:17:06.082] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8962360659389623472:14:0) after 7m42s
[01:24:48.377] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8962360659389623472:14:0)
[01:24:48.414] Build status: STARTED
[01:24:48.414] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8962360659389623472:15:0) after 4m52s
[01:29:40.646] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8962360659389623472:15:0)
[01:29:40.696] Build status: STARTED
[01:29:40.696] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8962360659389623472:16:0) after 1m1s
[01:30:41.724] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8962360659389623472:16:0)
[01:30:41.744] Build status: STARTED
[01:30:41.744] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8962360659389623472:17:0) after 8m54s
[01:39:35.763] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8962360659389623472:17:0)
[01:39:35.790] Build status: STARTED
[01:39:35.790] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8962360659389623472:18:0) after 2m45s
[01:42:20.827] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8962360659389623472:18:0)
[01:42:20.850] Build status: STARTED
[01:42:20.850] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8962360659389623472:19:0) after 5m51s
[01:48:11.979] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8962360659389623472:19:0)
[01:48:11.998] Build status: STARTED
[01:48:11.998] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8962360659389623472:20:0) after 5m52s
[01:54:04.015] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8962360659389623472:20:0)
[01:54:04.034] Build status: STARTED
[01:54:04.034] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8962360659389623472:21:0) after 5m40s
[01:59:44.158] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8962360659389623472:21:0)
[01:59:44.180] Build status: STARTED
[01:59:44.180] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8962360659389623472:22:0) after 2m23s
[02:02:07.156] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8962360659389623472:22:0)
[02:02:07.179] Build status: STARTED
[02:02:07.179] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8962360659389623472:23:0) after 2m7s
[02:04:14.304] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8962360659389623472:23:0)
[02:04:14.330] Build status: STARTED
[02:04:14.330] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8962360659389623472:24:0) after 7m1s
[02:11:15.416] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8962360659389623472:24:0)
[02:11:15.440] Build status: STARTED
[02:11:15.440] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8962360659389623472:25:0) after 4m47s
[02:16:02.524] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8962360659389623472:25:0)
[02:16:02.546] Build status: STARTED
[02:16:02.546] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8962360659389623472:26:0) after 3m51s
[02:19:53.536] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8962360659389623472:26:0)
[02:19:53.558] Build status: STARTED
[02:19:53.558] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8962360659389623472:27:0) after 8m14s
[02:28:07.576] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8962360659389623472:27:0)
[02:28:07.602] Build status: STARTED
[02:28:07.602] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8962360659389623472:28:0) after 7m56s
[02:36:03.645] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8962360659389623472:28:0)
[02:36:03.749] Build status: STARTED
[02:36:03.749] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8962360659389623472:29:0) after 1m11s
[02:37:14.846] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8962360659389623472:29:0)
[02:37:14.870] Build status: STARTED
[02:37:14.870] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8962360659389623472:30:0) after 8m36s
[02:45:50.864] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8962360659389623472:30:0)
[02:45:50.886] Build status: STARTED
[02:45:50.886] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8962360659389623472:31:0) after 2m37s
[02:48:27.904] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8962360659389623472:31:0)
[02:48:27.928] Build status: STARTED
[02:48:27.928] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8962360659389623472:32:0) after 4m59s
[02:53:26.952] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8962360659389623472:32:0)
[02:53:26.975] Build status: STARTED
[02:53:26.975] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8962360659389623472:33:0) after 4m16s
[02:57:43.017] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8962360659389623472:33:0)
[02:57:43.054] Build status: STARTED
[02:57:43.054] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8962360659389623472:34:0) after 6m8s
[03:03:51.077] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8962360659389623472:34:0)
[03:03:51.099] Build status: STARTED
[03:03:51.099] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8962360659389623472:35:0) after 4m33s
[03:08:24.436] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8962360659389623472:35:0)
[03:08:24.457] Build status: STARTED
[03:08:24.457] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8962360659389623472:36:0) after 2m22s
[03:10:46.484] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8962360659389623472:36:0)
[03:10:46.510] Build status: STARTED
[03:10:46.510] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8962360659389623472:37:0) after 6m52s
[03:17:38.488] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8962360659389623472:37:0)
[03:17:38.515] Build status: STARTED
[03:17:38.515] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8962360659389623472:38:0) after 9m35s
[03:27:13.744] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8962360659389623472:38:0)
[03:27:13.767] Build status: STARTED
[03:27:13.767] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8962360659389623472:39:0) after 2m57s
[03:30:10.890] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8962360659389623472:39:0)
[03:30:10.914] Build status: STARTED
[03:30:10.914] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8962360659389623472:40:0) after 7m32s
[03:37:42.933] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8962360659389623472:40:0)
[03:37:42.954] Build status: STARTED
[03:37:42.954] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8962360659389623472:41:0) after 8m10s
[03:45:53.056] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8962360659389623472:41:0)
[03:45:53.085] Build status: STARTED
[03:45:53.085] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8962360659389623472:42:0) after 5m42s
[03:51:35.170] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8962360659389623472:42:0)
[03:51:35.227] Build status: STARTED
[03:51:35.227] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8962360659389623472:43:0) after 6m54s
[03:58:29.246] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8962360659389623472:43:0)
[03:58:29.268] Build status: STARTED
[03:58:29.268] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8962360659389623472:44:0) after 2m58s
[04:01:27.306] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8962360659389623472:44:0)
[04:01:27.326] Build status: STARTED
[04:01:27.326] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8962360659389623472:45:0) after 8m4s
[04:09:31.352] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8962360659389623472:45:0)
[04:09:31.377] Build status: STARTED
[04:09:31.377] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8962360659389623472:46:0) after 1m1s
[04:10:32.499] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8962360659389623472:46:0)
[04:10:32.531] Build status: STARTED
[04:10:32.532] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8962360659389623472:47:0) after 3m25s
[04:13:57.527] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8962360659389623472:47:0)
[04:13:57.556] Build status: STARTED
[04:13:57.556] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8962360659389623472:48:0) after 4m53s
[04:18:50.596] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8962360659389623472:48:0)
[04:18:50.623] Build status: STARTED
[04:18:50.623] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8962360659389623472:49:0) after 7m28s
[04:26:18.716] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8962360659389623472:49:0)
[04:26:18.740] Build status: STARTED
[04:26:18.740] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8962360659389623472:50:0) after 9m41s
[04:35:59.775] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8962360659389623472:50:0)
[04:36:00.078] Build status: STARTED
[04:36:00.078] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8962360659389623472:51:0) after 2m48s
[04:38:48.230] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8962360659389623472:51:0)
[04:38:48.252] Build status: STARTED
[04:38:48.252] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8962360659389623472:52:0) after 9m28s
[04:48:16.234] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8962360659389623472:52:0)
[04:48:16.255] Build status: STARTED
[04:48:16.255] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8962360659389623472:53:0) after 1m22s
[04:49:38.275] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8962360659389623472:53:0)
[04:49:38.296] Build status: STARTED
[04:49:38.296] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8962360659389623472:54:0) after 6m18s
[04:55:56.447] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8962360659389623472:54:0)
[04:55:56.516] Build status: STARTED
[04:55:56.516] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8962360659389623472:55:0) after 3m32s
[04:59:28.535] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8962360659389623472:55:0)
[04:59:28.556] Build status: STARTED
[04:59:28.556] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8962360659389623472:56:0) after 8m14s
[05:07:42.877] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8962360659389623472:56:0)
[05:07:42.899] Build status: STARTED
[05:07:42.899] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8962360659389623472:57:0) after 8m59s
[05:16:41.932] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8962360659389623472:57:0)
[05:16:41.960] Build status: STARTED
[05:16:41.960] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8962360659389623472:58:0) after 6m21s
[05:23:02.980] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8962360659389623472:58:0)
[05:23:03.071] Build status: STARTED
[05:23:03.071] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8962360659389623472:59:0) after 7m54s
[05:30:57.095] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8962360659389623472:59:0)
[05:30:57.122] Build status: STARTED
[05:30:57.122] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8962360659389623472:60:0) after 5m33s
[05:36:30.254] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8962360659389623472:60:0)
[05:36:30.277] Build status: STARTED
[05:36:30.277] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8962360659389623472:61:0) after 8m48s
[05:45:18.536] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8962360659389623472:61:0)
[05:45:18.556] Build status: STARTED
[05:45:18.556] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8962360659389623472:62:0) after 7m8s
[05:52:26.678] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8962360659389623472:62:0)
[05:52:26.704] Build status: STARTED
[05:52:26.704] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8962360659389623472:63:0) after 7m53s
[06:00:19.840] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8962360659389623472:63:0)
[06:00:19.867] Build status: STARTED
[06:00:19.867] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8962360659389623472:64:0) after 2m10s
[06:02:29.978] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8962360659389623472:64:0)
[06:02:30.051] Build status: STARTED
[06:02:30.051] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8962360659389623472:65:0) after 9m46s
[06:12:16.089] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8962360659389623472:65:0)
[06:12:16.111] Build status: STARTED
[06:12:16.111] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8962360659389623472:66:0) after 4m23s
[06:16:39.132] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8962360659389623472:66:0)
[06:16:39.157] Build status: STARTED
[06:16:39.157] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8962360659389623472:67:0) after 5m16s
[06:21:55.271] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8962360659389623472:67:0)
[06:21:55.298] Build status: STARTED
[06:21:55.298] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8962360659389623472:68:0) after 3m1s
[06:24:56.367] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8962360659389623472:68:0)
[06:24:56.399] Build status: STARTED
[06:24:56.399] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8962360659389623472:69:0) after 2m17s
[06:27:13.416] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8962360659389623472:69:0)
[06:27:13.435] Build status: STARTED
[06:27:13.435] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8962360659389623472:70:0) after 9m39s
[06:36:52.459] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8962360659389623472:70:0)
[06:36:52.497] Build status: STARTED
[06:36:52.497] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8962360659389623472:71:0) after 9m24s
[06:46:16.604] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8962360659389623472:71:0)
[06:46:16.630] Build status: STARTED
[06:46:16.630] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8962360659389623472:72:0) after 3m20s
[06:49:36.714] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8962360659389623472:72:0)
[06:49:36.736] Build status: STARTED
[06:49:36.736] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8962360659389623472:73:0) after 3m5s
[06:52:41.757] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8962360659389623472:73:0)
[06:52:41.862] Build status: STARTED
[06:52:41.862] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8962360659389623472:74:0) after 4m32s
[06:57:13.880] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8962360659389623472:74:0)
[06:57:13.901] Build status: STARTED
[06:57:13.901] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8962360659389623472:75:0) after 9m59s
[07:07:12.924] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8962360659389623472:75:0)
[07:07:12.947] Build status: STARTED
[07:07:12.947] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8962360659389623472:76:0) after 8m46s
[07:15:59.186] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8962360659389623472:76:0)
[07:15:59.219] Build status: STARTED
[07:15:59.219] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8962360659389623472:77:0) after 7m41s
[07:23:40.241] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8962360659389623472:77:0)
[07:23:40.263] Build status: STARTED
[07:23:40.263] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8962360659389623472:78:0) after 3m42s
[07:27:22.298] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8962360659389623472:78:0)
[07:27:22.347] Build status: STARTED
[07:27:22.347] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8962360659389623472:79:0) after 2m8s
[07:29:30.478] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8962360659389623472:79:0)
[07:29:30.500] Build status: STARTED
[07:29:30.500] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8962360659389623472:80:0) after 9m26s
[07:38:56.724] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8962360659389623472:80:0)
[07:38:56.749] Build status: STARTED
[07:38:56.749] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8962360659389623472:81:0) after 1m50s
[07:40:46.847] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8962360659389623472:81:0)
[07:40:46.869] Build status: STARTED
[07:40:46.869] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8962360659389623472:82:0) after 8m17s
[07:49:03.901] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8962360659389623472:82:0)
[07:49:03.924] Build status: STARTED
[07:49:03.924] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8962360659389623472:83:0) after 2m18s
[07:51:22.049] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8962360659389623472:83:0)
[07:51:22.072] Build status: STARTED
[07:51:22.072] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8962360659389623472:84:0) after 3m5s
[07:54:27.092] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8962360659389623472:84:0)
[07:54:27.119] Build status: STARTED
[07:54:27.119] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8962360659389623472:85:0) after 8m25s
[08:02:52.157] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8962360659389623472:85:0)
[08:02:52.192] Build status: STARTED
[08:02:52.192] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8962360659389623472:86:0) after 1m46s
[08:04:38.395] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8962360659389623472:86:0)
[08:04:38.417] Build status: STARTED
[08:04:38.417] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8962360659389623472:87:0) after 6m54s
[08:11:32.438] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8962360659389623472:87:0)
[08:11:32.526] Build status: STARTED
[08:11:32.526] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8962360659389623472:88:0) after 5m4s
[08:16:36.737] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8962360659389623472:88:0)
[08:16:36.767] Build status: STARTED
[08:16:36.767] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8962360659389623472:89:0) after 7m15s
[08:23:51.737] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8962360659389623472:89:0)
[08:23:51.757] Build status: STARTED
[08:23:51.757] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8962360659389623472:90:0) after 2m3s
[08:25:54.777] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8962360659389623472:90:0)
[08:25:54.825] Build status: STARTED
[08:25:54.825] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8962360659389623472:91:0) after 5m27s
[08:31:21.854] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8962360659389623472:91:0)
[08:31:21.882] Build status: STARTED
[08:31:21.882] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8962360659389623472:92:0) after 5m54s
[08:37:15.916] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8962360659389623472:92:0)
[08:37:15.940] Build status: STARTED
[08:37:15.940] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8962360659389623472:93:0) after 6m0s
[08:43:16.062] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8962360659389623472:93:0)
[08:43:16.138] Build status: STARTED
[08:43:16.138] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8962360659389623472:94:0) after 1m28s
[08:44:44.362] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8962360659389623472:94:0)
[08:44:44.387] Build status: STARTED
[08:44:44.387] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8962360659389623472:95:0) after 2m20s
[08:47:04.509] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8962360659389623472:95:0)
[08:47:04.529] Build status: STARTED
[08:47:04.529] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8962360659389623472:96:0) after 7m24s
[08:54:28.551] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8962360659389623472:96:0)
[08:54:28.571] Build status: STARTED
[08:54:28.571] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8962360659389623472:97:0) after 1m58s
[08:56:26.665] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8962360659389623472:97:0)
[08:56:26.699] Build status: STARTED
[08:56:26.699] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8962360659389623472:98:0) after 6m18s
[09:02:44.729] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8962360659389623472:98:0)
[09:02:44.758] Build status: STARTED
[09:02:44.758] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8962360659389623472:99:0) after 7m44s
[09:10:28.891] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8962360659389623472:99:0)
[09:10:28.912] Build status: STARTED
[09:10:28.912] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8962360659389623472:100:0) after 5m55s
[09:16:23.933] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8962360659389623472:100:0)
[09:16:24.107] Build status: STARTED
[09:16:24.107] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8962360659389623472:101:0) after 8m51s
[09:25:15.137] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8962360659389623472:101:0)
[09:25:15.157] Build status: STARTED
[09:25:15.157] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8962360659389623472:102:0) after 8m37s
[09:33:52.149] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8962360659389623472:102:0)
[09:33:52.177] Build status: STARTED
[09:33:52.177] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8962360659389623472:103:0) after 1m52s
[09:35:44.196] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8962360659389623472:103:0)
[09:35:44.223] Build status: STARTED
[09:35:44.223] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8962360659389623472:104:0) after 8m16s
[09:44:00.354] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8962360659389623472:104:0)
[09:44:00.383] Build status: STARTED
[09:44:00.383] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8962360659389623472:105:0) after 4m42s
[09:48:42.486] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8962360659389623472:105:0)
[09:48:42.510] Build status: STARTED
[09:48:42.510] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8962360659389623472:106:0) after 8m9s
[09:56:51.553] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8962360659389623472:106:0)
[09:56:51.586] Build status: STARTED
[09:56:51.586] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8962360659389623472:107:0) after 3m47s
[10:00:38.682] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8962360659389623472:107:0)
[10:00:38.714] Build status: STARTED
[10:00:38.714] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8962360659389623472:108:0) after 9m10s
[10:09:48.738] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8962360659389623472:108:0)
[10:09:48.763] Build status: STARTED
[10:09:48.763] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8962360659389623472:109:0) after 7m49s
[10:17:37.899] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8962360659389623472:109:0)
[10:17:37.928] Build status: STARTED
[10:17:37.928] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8962360659389623472:110:0) after 9m21s
[10:26:59.075] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8962360659389623472:110:0)
[10:26:59.102] Build status: STARTED
[10:26:59.102] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8962360659389623472:111:0) after 5m12s
[10:29:48.957] Received PubSub notification, asking Buildbucket for the build status
[10:29:48.977] Build:
{
"id": "8796930597365442049",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "Win 10 Fast Ring"
},
"number": 11998,
"createdBy": "project:chromium",
"createTime": "2022-11-21T00:24:08.292288380Z",
"startTime": "2022-11-21T00:29:16.257314Z",
"endTime": "2022-11-21T10:29:48.719831675Z",
"updateTime": "2022-11-21T10:29:48.719831675Z",
"status": "CANCELED",
"statusDetails": {
"timeout": {
}
},
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "36d47f9e86fb78ebccab5c67e139697064740224",
"ref": "refs/heads/main"
}
}
}
[10:29:48.977] Invocation finished in 10h5m41.999401237s with status ABORTED