[21:15:24.944] New invocation is queued and will start shortly
[21:15:28.347] Starting the invocation (attempt 1)
[21:15:28.385] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/d533cbdafeb73ee366c7207b2bf3c9a0ab659868"
[21:15:28.385] Popped gitiles commit info from properties and tags
[21:15:28.385] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[21:15:28.385] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[21:15:28.385] Buildbucket request:
{
"requestId": "8968623722099463472",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "Win 10 Fast Ring"
},
"properties": {
},
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "d533cbdafeb73ee366c7207b2bf3c9a0ab659868",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8968623722099463472"
},
{
"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"
}
}
[21:15:29.071] Scheduled build:
{
"id": "8803193657762713889",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "Win 10 Fast Ring"
},
"number": 11833,
"createdBy": "project:chromium",
"createTime": "2022-09-12T21:15:28.449360500Z",
"updateTime": "2022-09-12T21:15:28.449360500Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "d533cbdafeb73ee366c7207b2bf3c9a0ab659868",
"ref": "refs/heads/main"
}
}
}
[21:15:29.071] Task URL: https://cr-buildbucket.appspot.com/build/8803193657762713889
[21:15:29.071] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8968623722099463472:2:0) after 2m47s
[21:18:16.278] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8968623722099463472:2:0)
[21:18:16.304] Build status: SCHEDULED
[21:18:16.304] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8968623722099463472:3:0) after 7m36s
[21:23:48.582] Received PubSub notification, asking Buildbucket for the build status
[21:23:48.607] Build status: STARTED
[21:25:52.341] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8968623722099463472:3:0)
[21:25:52.366] Build status: STARTED
[21:25:52.366] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8968623722099463472:5:0) after 6m7s
[21:31:59.398] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8968623722099463472:5:0)
[21:31:59.423] Build status: STARTED
[21:31:59.423] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8968623722099463472:6:0) after 8m13s
[21:40:12.720] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8968623722099463472:6:0)
[21:40:12.748] Build status: STARTED
[21:40:12.749] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8968623722099463472:7:0) after 6m9s
[21:46:21.767] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8968623722099463472:7:0)
[21:46:21.791] Build status: STARTED
[21:46:21.791] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8968623722099463472:8:0) after 5m38s
[21:51:59.994] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8968623722099463472:8:0)
[21:52:00.028] Build status: STARTED
[21:52:00.028] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8968623722099463472:9:0) after 4m42s
[21:56:42.249] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8968623722099463472:9:0)
[21:56:42.335] Build status: STARTED
[21:56:42.335] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8968623722099463472:10:0) after 9m39s
[22:06:21.690] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8968623722099463472:10:0)
[22:06:21.715] Build status: STARTED
[22:06:21.715] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8968623722099463472:11:0) after 5m52s
[22:12:14.318] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8968623722099463472:11:0)
[22:12:14.344] Build status: STARTED
[22:12:14.344] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8968623722099463472:12:0) after 6m32s
[22:18:46.370] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8968623722099463472:12:0)
[22:18:46.394] Build status: STARTED
[22:18:46.395] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8968623722099463472:13:0) after 9m49s
[22:28:35.422] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8968623722099463472:13:0)
[22:28:35.444] Build status: STARTED
[22:28:35.444] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8968623722099463472:14:0) after 6m26s
[22:35:01.490] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8968623722099463472:14:0)
[22:35:01.521] Build status: STARTED
[22:35:01.521] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8968623722099463472:15:0) after 7m8s
[22:42:09.698] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8968623722099463472:15:0)
[22:42:09.724] Build status: STARTED
[22:42:09.724] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8968623722099463472:16:0) after 9m55s
[22:52:04.851] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8968623722099463472:16:0)
[22:52:04.894] Build status: STARTED
[22:52:04.894] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8968623722099463472:17:0) after 6m35s
[22:58:39.955] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8968623722099463472:17:0)
[22:58:39.983] Build status: STARTED
[22:58:39.983] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8968623722099463472:18:0) after 2m16s
[23:00:56.012] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8968623722099463472:18:0)
[23:00:56.035] Build status: STARTED
[23:00:56.035] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8968623722099463472:19:0) after 8m27s
[23:09:23.136] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8968623722099463472:19:0)
[23:09:23.165] Build status: STARTED
[23:09:23.165] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8968623722099463472:20:0) after 7m2s
[23:16:25.191] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8968623722099463472:20:0)
[23:16:25.215] Build status: STARTED
[23:16:25.215] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8968623722099463472:21:0) after 2m26s
[23:18:51.247] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8968623722099463472:21:0)
[23:18:51.276] Build status: STARTED
[23:18:51.276] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8968623722099463472:22:0) after 8m25s
[23:27:16.315] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8968623722099463472:22:0)
[23:27:16.344] Build status: STARTED
[23:27:16.344] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8968623722099463472:23:0) after 2m23s
[23:29:39.372] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8968623722099463472:23:0)
[23:29:39.433] Build status: STARTED
[23:29:39.433] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8968623722099463472:24:0) after 2m15s
[23:31:54.669] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8968623722099463472:24:0)
[23:31:54.738] Build status: STARTED
[23:31:54.738] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8968623722099463472:25:0) after 5m43s
[23:37:37.856] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8968623722099463472:25:0)
[23:37:37.885] Build status: STARTED
[23:37:37.885] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8968623722099463472:26:0) after 5m11s
[23:42:48.964] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8968623722099463472:26:0)
[23:42:48.985] Build status: STARTED
[23:42:48.985] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8968623722099463472:27:0) after 8m59s
[23:51:48.026] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8968623722099463472:27:0)
[23:51:48.051] Build status: STARTED
[23:51:48.051] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8968623722099463472:28:0) after 2m23s
[23:54:11.080] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8968623722099463472:28:0)
[23:54:11.111] Build status: STARTED
[23:54:11.111] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8968623722099463472:29:0) after 1m56s
[23:56:07.132] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8968623722099463472:29:0)
[23:56:07.165] Build status: STARTED
[23:56:07.165] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8968623722099463472:30:0) after 4m54s
[00:01:01.204] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8968623722099463472:30:0)
[00:01:01.228] Build status: STARTED
[00:01:01.229] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8968623722099463472:31:0) after 9m49s
[00:10:50.266] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8968623722099463472:31:0)
[00:10:50.290] Build status: STARTED
[00:10:50.290] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8968623722099463472:32:0) after 7m50s
[00:18:40.428] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8968623722099463472:32:0)
[00:18:40.462] Build status: STARTED
[00:18:40.462] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8968623722099463472:33:0) after 1m4s
[00:19:44.484] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8968623722099463472:33:0)
[00:19:44.523] Build status: STARTED
[00:19:44.523] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8968623722099463472:34:0) after 9m16s
[00:29:00.717] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8968623722099463472:34:0)
[00:29:00.765] Build status: STARTED
[00:29:00.765] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8968623722099463472:35:0) after 1m14s
[00:30:14.991] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8968623722099463472:35:0)
[00:30:15.019] Build status: STARTED
[00:30:15.019] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8968623722099463472:36:0) after 8m32s
[00:38:47.180] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8968623722099463472:36:0)
[00:38:47.208] Build status: STARTED
[00:38:47.208] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8968623722099463472:37:0) after 3m39s
[00:42:26.237] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8968623722099463472:37:0)
[00:42:26.272] Build status: STARTED
[00:42:26.272] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8968623722099463472:38:0) after 4m8s
[00:46:34.520] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8968623722099463472:38:0)
[00:46:34.544] Build status: STARTED
[00:46:34.544] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8968623722099463472:39:0) after 7m30s
[00:54:04.572] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8968623722099463472:39:0)
[00:54:04.603] Build status: STARTED
[00:54:04.603] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8968623722099463472:40:0) after 1m14s
[00:55:18.625] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8968623722099463472:40:0)
[00:55:18.653] Build status: STARTED
[00:55:18.653] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8968623722099463472:41:0) after 7m10s
[01:02:28.694] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8968623722099463472:41:0)
[01:02:28.720] Build status: STARTED
[01:02:28.720] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8968623722099463472:42:0) after 8m21s
[01:10:49.771] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8968623722099463472:42:0)
[01:10:49.794] Build status: STARTED
[01:10:49.794] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8968623722099463472:43:0) after 7m3s
[01:17:53.071] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8968623722099463472:43:0)
[01:17:53.097] Build status: STARTED
[01:17:53.097] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8968623722099463472:44:0) after 4m43s
[01:22:36.186] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8968623722099463472:44:0)
[01:22:36.293] Build status: STARTED
[01:22:36.293] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8968623722099463472:45:0) after 7m7s
[01:29:43.543] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8968623722099463472:45:0)
[01:29:43.607] Build status: STARTED
[01:29:43.608] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8968623722099463472:46:0) after 1m27s
[01:31:10.636] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8968623722099463472:46:0)
[01:31:10.673] Build status: STARTED
[01:31:10.673] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8968623722099463472:47:0) after 4m19s
[01:35:29.724] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8968623722099463472:47:0)
[01:35:29.754] Build status: STARTED
[01:35:29.754] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8968623722099463472:48:0) after 5m53s
[01:41:23.084] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8968623722099463472:48:0)
[01:41:23.112] Build status: STARTED
[01:41:23.112] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8968623722099463472:49:0) after 5m18s
[01:46:41.133] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8968623722099463472:49:0)
[01:46:41.208] Build status: STARTED
[01:46:41.208] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8968623722099463472:50:0) after 1m56s
[01:48:37.194] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8968623722099463472:50:0)
[01:48:37.218] Build status: STARTED
[01:48:37.218] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8968623722099463472:51:0) after 7m6s
[01:55:43.567] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8968623722099463472:51:0)
[01:55:43.649] Build status: STARTED
[01:55:43.649] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8968623722099463472:52:0) after 6m17s
[02:02:01.489] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8968623722099463472:52:0)
[02:02:01.521] Build status: STARTED
[02:02:01.521] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8968623722099463472:53:0) after 2m52s
[02:04:53.549] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8968623722099463472:53:0)
[02:04:53.572] Build status: STARTED
[02:04:53.572] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8968623722099463472:54:0) after 1m5s
[02:05:58.597] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8968623722099463472:54:0)
[02:05:58.624] Build status: STARTED
[02:05:58.624] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8968623722099463472:55:0) after 2m10s
[02:08:08.867] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8968623722099463472:55:0)
[02:08:08.897] Build status: STARTED
[02:08:08.897] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8968623722099463472:56:0) after 4m52s
[02:13:00.938] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8968623722099463472:56:0)
[02:13:01.086] Build status: STARTED
[02:13:01.086] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8968623722099463472:57:0) after 9m21s
[02:22:22.115] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8968623722099463472:57:0)
[02:22:22.140] Build status: STARTED
[02:22:22.140] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8968623722099463472:58:0) after 8m6s
[02:30:28.502] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8968623722099463472:58:0)
[02:30:28.548] Build status: STARTED
[02:30:28.548] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8968623722099463472:59:0) after 6m8s
[02:36:36.753] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8968623722099463472:59:0)
[02:36:36.781] Build status: STARTED
[02:36:36.781] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8968623722099463472:60:0) after 3m12s
[02:39:49.117] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8968623722099463472:60:0)
[02:39:49.144] Build status: STARTED
[02:39:49.144] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8968623722099463472:61:0) after 2m38s
[02:42:27.183] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8968623722099463472:61:0)
[02:42:27.218] Build status: STARTED
[02:42:27.218] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8968623722099463472:62:0) after 1m11s
[02:43:38.226] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8968623722099463472:62:0)
[02:43:38.253] Build status: STARTED
[02:43:38.253] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8968623722099463472:63:0) after 8m18s
[02:51:56.286] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8968623722099463472:63:0)
[02:51:56.313] Build status: STARTED
[02:51:56.313] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8968623722099463472:64:0) after 4m39s
[02:56:35.552] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8968623722099463472:64:0)
[02:56:35.581] Build status: STARTED
[02:56:35.581] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8968623722099463472:65:0) after 3m14s
[02:59:49.610] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8968623722099463472:65:0)
[02:59:49.640] Build status: STARTED
[02:59:49.640] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8968623722099463472:66:0) after 6m6s
[03:05:55.677] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8968623722099463472:66:0)
[03:05:55.708] Build status: STARTED
[03:05:55.708] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8968623722099463472:67:0) after 9m46s
[03:15:41.878] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8968623722099463472:67:0)
[03:15:41.914] Build status: STARTED
[03:15:41.914] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8968623722099463472:68:0) after 1m23s
[03:17:05.088] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8968623722099463472:68:0)
[03:17:05.166] Build status: STARTED
[03:17:05.166] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8968623722099463472:69:0) after 8m2s
[03:25:07.222] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8968623722099463472:69:0)
[03:25:07.286] Build status: STARTED
[03:25:07.286] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8968623722099463472:70:0) after 7m29s
[03:32:36.413] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8968623722099463472:70:0)
[03:32:36.449] Build status: STARTED
[03:32:36.449] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8968623722099463472:71:0) after 9m53s
[03:42:29.892] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8968623722099463472:71:0)
[03:42:29.920] Build status: STARTED
[03:42:29.920] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8968623722099463472:72:0) after 6m0s
[03:48:29.958] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8968623722099463472:72:0)
[03:48:29.985] Build status: STARTED
[03:48:29.985] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8968623722099463472:73:0) after 2m28s
[03:50:57.965] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8968623722099463472:73:0)
[03:50:58.004] Build status: STARTED
[03:50:58.004] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8968623722099463472:74:0) after 6m23s
[03:57:21.197] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8968623722099463472:74:0)
[03:57:21.240] Build status: STARTED
[03:57:21.240] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8968623722099463472:75:0) after 8m49s
[04:06:10.342] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8968623722099463472:75:0)
[04:06:10.375] Build status: STARTED
[04:06:10.375] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8968623722099463472:76:0) after 8m44s
[04:14:54.419] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8968623722099463472:76:0)
[04:14:54.445] Build status: STARTED
[04:14:54.445] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8968623722099463472:77:0) after 5m18s
[04:20:12.472] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8968623722099463472:77:0)
[04:20:12.505] Build status: STARTED
[04:20:12.505] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8968623722099463472:78:0) after 4m36s
[04:24:48.567] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8968623722099463472:78:0)
[04:24:48.602] Build status: STARTED
[04:24:48.602] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8968623722099463472:79:0) after 4m51s
[04:29:39.679] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8968623722099463472:79:0)
[04:29:39.715] Build status: STARTED
[04:29:39.715] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8968623722099463472:80:0) after 8m0s
[04:37:39.752] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8968623722099463472:80:0)
[04:37:39.783] Build status: STARTED
[04:37:39.783] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8968623722099463472:81:0) after 9m30s
[04:47:09.858] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8968623722099463472:81:0)
[04:47:09.888] Build status: STARTED
[04:47:09.888] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8968623722099463472:82:0) after 9m52s
[04:57:02.043] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8968623722099463472:82:0)
[04:57:02.065] Build status: STARTED
[04:57:02.065] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8968623722099463472:83:0) after 8m21s
[05:05:23.363] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8968623722099463472:83:0)
[05:05:23.384] Build status: STARTED
[05:05:23.384] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8968623722099463472:84:0) after 5m47s
[05:11:10.648] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8968623722099463472:84:0)
[05:11:10.692] Build status: STARTED
[05:11:10.692] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8968623722099463472:85:0) after 1m8s
[05:12:18.726] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8968623722099463472:85:0)
[05:12:18.752] Build status: STARTED
[05:12:18.752] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8968623722099463472:86:0) after 9m38s
[05:21:56.787] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8968623722099463472:86:0)
[05:21:56.826] Build status: STARTED
[05:21:56.826] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8968623722099463472:87:0) after 5m24s
[05:27:20.950] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8968623722099463472:87:0)
[05:27:20.974] Build status: STARTED
[05:27:20.975] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8968623722099463472:88:0) after 7m47s
[05:35:08.019] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8968623722099463472:88:0)
[05:35:08.044] Build status: STARTED
[05:35:08.044] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8968623722099463472:89:0) after 9m51s
[05:44:59.178] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8968623722099463472:89:0)
[05:44:59.204] Build status: STARTED
[05:44:59.204] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8968623722099463472:90:0) after 8m52s
[05:53:51.385] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8968623722099463472:90:0)
[05:53:51.408] Build status: STARTED
[05:53:51.408] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8968623722099463472:91:0) after 5m51s
[05:59:42.436] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8968623722099463472:91:0)
[05:59:42.471] Build status: STARTED
[05:59:42.471] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8968623722099463472:92:0) after 4m2s
[06:03:44.604] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8968623722099463472:92:0)
[06:03:44.632] Build status: STARTED
[06:03:44.632] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8968623722099463472:93:0) after 3m30s
[06:07:14.805] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8968623722099463472:93:0)
[06:07:14.840] Build status: STARTED
[06:07:14.840] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8968623722099463472:94:0) after 1m14s
[06:08:29.058] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8968623722099463472:94:0)
[06:08:29.083] Build status: STARTED
[06:08:29.083] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8968623722099463472:95:0) after 2m30s
[06:10:59.389] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8968623722099463472:95:0)
[06:10:59.414] Build status: STARTED
[06:10:59.414] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8968623722099463472:96:0) after 3m35s
[06:14:34.525] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8968623722099463472:96:0)
[06:14:34.568] Build status: STARTED
[06:14:34.568] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8968623722099463472:97:0) after 8m28s
[06:23:02.613] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8968623722099463472:97:0)
[06:23:02.643] Build status: STARTED
[06:23:02.643] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8968623722099463472:98:0) after 8m30s
[06:31:32.683] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8968623722099463472:98:0)
[06:31:32.710] Build status: STARTED
[06:31:32.710] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8968623722099463472:99:0) after 1m16s
[06:32:48.850] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8968623722099463472:99:0)
[06:32:48.875] Build status: STARTED
[06:32:48.875] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8968623722099463472:100:0) after 3m19s
[06:36:08.000] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8968623722099463472:100:0)
[06:36:08.032] Build status: STARTED
[06:36:08.033] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8968623722099463472:101:0) after 2m13s
[06:38:21.194] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8968623722099463472:101:0)
[06:38:21.220] Build status: STARTED
[06:38:21.220] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8968623722099463472:102:0) after 8m23s
[06:46:44.247] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8968623722099463472:102:0)
[06:46:44.271] Build status: STARTED
[06:46:44.271] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8968623722099463472:103:0) after 7m22s
[06:54:06.407] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8968623722099463472:103:0)
[06:54:06.430] Build status: STARTED
[06:54:06.430] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8968623722099463472:104:0) after 9m18s
[07:03:24.542] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8968623722099463472:104:0)
[07:03:24.686] Build status: STARTED
[07:03:24.686] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8968623722099463472:105:0) after 1m20s
[07:04:44.712] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8968623722099463472:105:0)
[07:04:44.733] Build status: STARTED
[07:04:44.733] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8968623722099463472:106:0) after 6m7s
[07:10:51.760] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8968623722099463472:106:0)
[07:10:51.819] Build status: STARTED
[07:10:51.819] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8968623722099463472:107:0) after 5m0s
[07:15:52.034] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8968623722099463472:107:0)
[07:15:52.063] Build status: STARTED
[07:15:52.063] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8968623722099463472:108:0) after 6m2s
[07:21:54.093] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8968623722099463472:108:0)
[07:21:54.117] Build status: STARTED
[07:21:54.117] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8968623722099463472:109:0) after 2m55s
[07:24:07.039] Received PubSub notification, asking Buildbucket for the build status
[07:24:07.063] Build:
{
"id": "8803193657762713889",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "Win 10 Fast Ring"
},
"number": 11833,
"createdBy": "project:chromium",
"createTime": "2022-09-12T21:15:28.449360500Z",
"startTime": "2022-09-12T21:23:47.999362Z",
"endTime": "2022-09-13T07:24:06.634418485Z",
"updateTime": "2022-09-13T07:24:06.634418485Z",
"status": "CANCELED",
"statusDetails": {
"timeout": {
}
},
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "d533cbdafeb73ee366c7207b2bf3c9a0ab659868",
"ref": "refs/heads/main"
}
}
}
[07:24:07.063] Invocation finished in 10h8m42.134492251s with status ABORTED