[17:24:56.107] New invocation is queued and will start shortly
[17:24:57.168] Starting the invocation (attempt 1)
[17:24:57.201] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/f577ac44680483ab32303e9816d7481737d6a3ca"
[17:24:57.201] Popped gitiles commit info from properties and tags
[17:24:57.201] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[17:24:57.201] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[17:24:57.201] Buildbucket request:
{
"requestId": "8956317035253911584",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "Win 10 Fast Ring"
},
"properties": {
},
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "f577ac44680483ab32303e9816d7481737d6a3ca",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8956317035253911584"
},
{
"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"
}
}
[17:24:57.752] Scheduled build:
{
"id": "8790886973367834753",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "Win 10 Fast Ring"
},
"number": 13111,
"createdBy": "project:chromium",
"createTime": "2023-01-26T17:24:57.276808197Z",
"updateTime": "2023-01-26T17:24:57.276808197Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "f577ac44680483ab32303e9816d7481737d6a3ca",
"ref": "refs/heads/main"
}
}
}
[17:24:57.752] Task URL: https://cr-buildbucket.appspot.com/build/8790886973367834753
[17:24:57.752] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956317035253911584:2:0) after 4m2s
[17:28:59.926] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956317035253911584:2:0)
[17:28:59.949] Build status: SCHEDULED
[17:28:59.949] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956317035253911584:3:0) after 1m48s
[17:30:48.136] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956317035253911584:3:0)
[17:30:48.162] Build status: SCHEDULED
[17:30:48.162] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956317035253911584:4:0) after 6m55s
[17:34:17.167] Received PubSub notification, asking Buildbucket for the build status
[17:34:17.189] Build status: STARTED
[17:37:43.298] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956317035253911584:4:0)
[17:37:43.329] Build status: STARTED
[17:37:43.329] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956317035253911584:6:0) after 4m4s
[17:41:47.706] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956317035253911584:6:0)
[17:41:47.752] Build status: STARTED
[17:41:47.752] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956317035253911584:7:0) after 3m54s
[17:45:41.783] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956317035253911584:7:0)
[17:45:41.805] Build status: STARTED
[17:45:41.805] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956317035253911584:8:0) after 9m48s
[17:55:29.861] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956317035253911584:8:0)
[17:55:29.884] Build status: STARTED
[17:55:29.884] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956317035253911584:9:0) after 5m26s
[18:00:55.970] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956317035253911584:9:0)
[18:00:55.995] Build status: STARTED
[18:00:55.995] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956317035253911584:10:0) after 4m26s
[18:05:22.288] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956317035253911584:10:0)
[18:05:22.312] Build status: STARTED
[18:05:22.313] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956317035253911584:11:0) after 9m10s
[18:14:32.386] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956317035253911584:11:0)
[18:14:32.443] Build status: STARTED
[18:14:32.443] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956317035253911584:12:0) after 4m27s
[18:18:59.517] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956317035253911584:12:0)
[18:18:59.573] Build status: STARTED
[18:18:59.573] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956317035253911584:13:0) after 7m37s
[18:26:36.594] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956317035253911584:13:0)
[18:26:36.615] Build status: STARTED
[18:26:36.615] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956317035253911584:14:0) after 3m40s
[18:30:16.638] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956317035253911584:14:0)
[18:30:16.661] Build status: STARTED
[18:30:16.661] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956317035253911584:15:0) after 9m23s
[18:39:39.958] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956317035253911584:15:0)
[18:39:39.983] Build status: STARTED
[18:39:39.983] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956317035253911584:16:0) after 8m14s
[18:47:54.156] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956317035253911584:16:0)
[18:47:54.185] Build status: STARTED
[18:47:54.185] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956317035253911584:17:0) after 8m42s
[18:56:36.224] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956317035253911584:17:0)
[18:56:36.248] Build status: STARTED
[18:56:36.248] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956317035253911584:18:0) after 8m7s
[19:04:43.505] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956317035253911584:18:0)
[19:04:43.540] Build status: STARTED
[19:04:43.540] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956317035253911584:19:0) after 6m53s
[19:11:36.657] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956317035253911584:19:0)
[19:11:36.680] Build status: STARTED
[19:11:36.680] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956317035253911584:20:0) after 5m58s
[19:17:34.836] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956317035253911584:20:0)
[19:17:34.855] Build status: STARTED
[19:17:34.855] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956317035253911584:21:0) after 1m31s
[19:19:05.890] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956317035253911584:21:0)
[19:19:05.912] Build status: STARTED
[19:19:05.912] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956317035253911584:22:0) after 5m45s
[19:24:50.980] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956317035253911584:22:0)
[19:24:51.003] Build status: STARTED
[19:24:51.003] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956317035253911584:23:0) after 1m38s
[19:26:29.225] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956317035253911584:23:0)
[19:26:29.245] Build status: STARTED
[19:26:29.245] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956317035253911584:24:0) after 8m53s
[19:35:22.319] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956317035253911584:24:0)
[19:35:22.344] Build status: STARTED
[19:35:22.344] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956317035253911584:25:0) after 8m44s
[19:44:06.368] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956317035253911584:25:0)
[19:44:06.392] Build status: STARTED
[19:44:06.392] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956317035253911584:26:0) after 4m13s
[19:48:19.470] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956317035253911584:26:0)
[19:48:19.521] Build status: STARTED
[19:48:19.521] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956317035253911584:27:0) after 5m28s
[19:53:47.597] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956317035253911584:27:0)
[19:53:47.623] Build status: STARTED
[19:53:47.623] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956317035253911584:28:0) after 3m11s
[19:56:58.808] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956317035253911584:28:0)
[19:56:58.834] Build status: STARTED
[19:56:58.835] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956317035253911584:29:0) after 4m1s
[20:00:59.967] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956317035253911584:29:0)
[20:01:00.038] Build status: STARTED
[20:01:00.038] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956317035253911584:30:0) after 6m47s
[20:07:47.406] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956317035253911584:30:0)
[20:07:47.468] Build status: STARTED
[20:07:47.468] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956317035253911584:31:0) after 6m49s
[20:14:36.721] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956317035253911584:31:0)
[20:14:36.770] Build status: STARTED
[20:14:36.770] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956317035253911584:32:0) after 4m45s
[20:19:21.909] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956317035253911584:32:0)
[20:19:21.931] Build status: STARTED
[20:19:21.931] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956317035253911584:33:0) after 7m31s
[20:26:53.297] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956317035253911584:33:0)
[20:26:53.335] Build status: STARTED
[20:26:53.335] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956317035253911584:34:0) after 6m19s
[20:33:12.378] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956317035253911584:34:0)
[20:33:12.413] Build status: STARTED
[20:33:12.414] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956317035253911584:35:0) after 5m24s
[20:38:36.568] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956317035253911584:35:0)
[20:38:36.591] Build status: STARTED
[20:38:36.591] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956317035253911584:36:0) after 4m4s
[20:42:40.648] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956317035253911584:36:0)
[20:42:40.673] Build status: STARTED
[20:42:40.673] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956317035253911584:37:0) after 6m21s
[20:49:01.840] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956317035253911584:37:0)
[20:49:01.859] Build status: STARTED
[20:49:01.859] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956317035253911584:38:0) after 5m13s
[20:54:14.906] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956317035253911584:38:0)
[20:54:14.931] Build status: STARTED
[20:54:14.931] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956317035253911584:39:0) after 1m58s
[20:56:12.923] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956317035253911584:39:0)
[20:56:12.947] Build status: STARTED
[20:56:12.947] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956317035253911584:40:0) after 4m13s
[21:00:26.143] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956317035253911584:40:0)
[21:00:26.195] Build status: STARTED
[21:00:26.195] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956317035253911584:41:0) after 7m15s
[21:07:41.322] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956317035253911584:41:0)
[21:07:41.343] Build status: STARTED
[21:07:41.343] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956317035253911584:42:0) after 4m34s
[21:12:15.444] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956317035253911584:42:0)
[21:12:15.470] Build status: STARTED
[21:12:15.470] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956317035253911584:43:0) after 5m43s
[21:17:58.495] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956317035253911584:43:0)
[21:17:58.527] Build status: STARTED
[21:17:58.528] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956317035253911584:44:0) after 2m21s
[21:20:19.553] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956317035253911584:44:0)
[21:20:19.624] Build status: STARTED
[21:20:19.624] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956317035253911584:45:0) after 4m36s
[21:24:55.752] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956317035253911584:45:0)
[21:24:55.774] Build status: STARTED
[21:24:55.774] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956317035253911584:46:0) after 4m27s
[21:29:23.093] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956317035253911584:46:0)
[21:29:23.117] Build status: STARTED
[21:29:23.117] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956317035253911584:47:0) after 5m52s
[21:35:15.258] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956317035253911584:47:0)
[21:35:15.281] Build status: STARTED
[21:35:15.281] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956317035253911584:48:0) after 1m53s
[21:37:08.327] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956317035253911584:48:0)
[21:37:08.353] Build status: STARTED
[21:37:08.353] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956317035253911584:49:0) after 6m4s
[21:43:12.469] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956317035253911584:49:0)
[21:43:12.495] Build status: STARTED
[21:43:12.495] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956317035253911584:50:0) after 7m19s
[21:50:31.642] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956317035253911584:50:0)
[21:50:31.665] Build status: STARTED
[21:50:31.665] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956317035253911584:51:0) after 8m32s
[21:59:03.693] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956317035253911584:51:0)
[21:59:03.715] Build status: STARTED
[21:59:03.715] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956317035253911584:52:0) after 7m14s
[22:06:17.880] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956317035253911584:52:0)
[22:06:17.926] Build status: STARTED
[22:06:17.926] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956317035253911584:53:0) after 7m36s
[22:13:54.005] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956317035253911584:53:0)
[22:13:54.029] Build status: STARTED
[22:13:54.029] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956317035253911584:54:0) after 4m0s
[22:17:54.053] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956317035253911584:54:0)
[22:17:54.085] Build status: STARTED
[22:17:54.085] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956317035253911584:55:0) after 9m6s
[22:27:00.704] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956317035253911584:55:0)
[22:27:00.730] Build status: STARTED
[22:27:00.730] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956317035253911584:56:0) after 2m4s
[22:29:04.961] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956317035253911584:56:0)
[22:29:05.035] Build status: STARTED
[22:29:05.035] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956317035253911584:57:0) after 6m45s
[22:35:50.335] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956317035253911584:57:0)
[22:35:50.363] Build status: STARTED
[22:35:50.363] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956317035253911584:58:0) after 2m34s
[22:38:24.387] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956317035253911584:58:0)
[22:38:24.417] Build status: STARTED
[22:38:24.417] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956317035253911584:59:0) after 6m12s
[22:44:36.442] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956317035253911584:59:0)
[22:44:36.479] Build status: STARTED
[22:44:36.480] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956317035253911584:60:0) after 2m9s
[22:46:45.620] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956317035253911584:60:0)
[22:46:45.644] Build status: STARTED
[22:46:45.644] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956317035253911584:61:0) after 8m3s
[22:54:48.826] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956317035253911584:61:0)
[22:54:48.847] Build status: STARTED
[22:54:48.847] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956317035253911584:62:0) after 3m34s
[22:58:22.880] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956317035253911584:62:0)
[22:58:22.918] Build status: STARTED
[22:58:22.918] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956317035253911584:63:0) after 8m43s
[23:07:06.217] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956317035253911584:63:0)
[23:07:06.242] Build status: STARTED
[23:07:06.242] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956317035253911584:64:0) after 2m45s
[23:09:51.363] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956317035253911584:64:0)
[23:09:51.501] Build status: STARTED
[23:09:51.501] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956317035253911584:65:0) after 8m17s
[23:18:08.497] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956317035253911584:65:0)
[23:18:08.519] Build status: STARTED
[23:18:08.519] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956317035253911584:66:0) after 3m41s
[23:21:49.756] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956317035253911584:66:0)
[23:21:49.776] Build status: STARTED
[23:21:49.776] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956317035253911584:67:0) after 6m22s
[23:28:12.507] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956317035253911584:67:0)
[23:28:12.548] Build status: STARTED
[23:28:12.548] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956317035253911584:68:0) after 9m43s
[23:37:55.675] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956317035253911584:68:0)
[23:37:55.700] Build status: STARTED
[23:37:55.700] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956317035253911584:69:0) after 4m47s
[23:42:42.802] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956317035253911584:69:0)
[23:42:42.825] Build status: STARTED
[23:42:42.825] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956317035253911584:70:0) after 2m48s
[23:45:30.887] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956317035253911584:70:0)
[23:45:30.947] Build status: STARTED
[23:45:30.947] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956317035253911584:71:0) after 6m9s
[23:51:40.040] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956317035253911584:71:0)
[23:51:40.076] Build status: STARTED
[23:51:40.076] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956317035253911584:72:0) after 9m42s
[00:01:22.096] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956317035253911584:72:0)
[00:01:22.125] Build status: STARTED
[00:01:22.125] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956317035253911584:73:0) after 9m28s
[00:10:50.722] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956317035253911584:73:0)
[00:10:50.785] Build status: STARTED
[00:10:50.785] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956317035253911584:74:0) after 9m20s
[00:20:11.451] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956317035253911584:74:0)
[00:20:11.482] Build status: STARTED
[00:20:11.482] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956317035253911584:75:0) after 3m36s
[00:23:47.895] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956317035253911584:75:0)
[00:23:47.921] Build status: STARTED
[00:23:47.921] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956317035253911584:76:0) after 2m6s
[00:25:53.951] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956317035253911584:76:0)
[00:25:53.975] Build status: STARTED
[00:25:53.975] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956317035253911584:77:0) after 4m14s
[00:30:08.004] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956317035253911584:77:0)
[00:30:08.027] Build status: STARTED
[00:30:08.027] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956317035253911584:78:0) after 8m36s
[00:38:44.055] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956317035253911584:78:0)
[00:38:44.079] Build status: STARTED
[00:38:44.080] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956317035253911584:79:0) after 6m28s
[00:45:12.115] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956317035253911584:79:0)
[00:45:12.138] Build status: STARTED
[00:45:12.138] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956317035253911584:80:0) after 2m39s
[00:47:51.251] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956317035253911584:80:0)
[00:47:51.277] Build status: STARTED
[00:47:51.277] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956317035253911584:81:0) after 1m31s
[00:49:22.318] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956317035253911584:81:0)
[00:49:22.338] Build status: STARTED
[00:49:22.338] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956317035253911584:82:0) after 8m27s
[00:57:49.361] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956317035253911584:82:0)
[00:57:49.385] Build status: STARTED
[00:57:49.385] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956317035253911584:83:0) after 3m41s
[01:01:30.726] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956317035253911584:83:0)
[01:01:30.770] Build status: STARTED
[01:01:30.770] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956317035253911584:84:0) after 5m30s
[01:07:00.815] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956317035253911584:84:0)
[01:07:00.837] Build status: STARTED
[01:07:00.837] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956317035253911584:85:0) after 5m37s
[01:12:37.863] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956317035253911584:85:0)
[01:12:37.881] Build status: STARTED
[01:12:37.881] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956317035253911584:86:0) after 6m38s
[01:19:15.917] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956317035253911584:86:0)
[01:19:15.939] Build status: STARTED
[01:19:15.939] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956317035253911584:87:0) after 6m38s
[01:25:53.994] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956317035253911584:87:0)
[01:25:54.390] Build status: STARTED
[01:25:54.390] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956317035253911584:88:0) after 3m59s
[01:29:53.483] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956317035253911584:88:0)
[01:29:53.508] Build status: STARTED
[01:29:53.508] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956317035253911584:89:0) after 7m49s
[01:37:42.612] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956317035253911584:89:0)
[01:37:42.637] Build status: STARTED
[01:37:42.637] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956317035253911584:90:0) after 1m21s
[01:39:03.718] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956317035253911584:90:0)
[01:39:03.748] Build status: STARTED
[01:39:03.748] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956317035253911584:91:0) after 5m6s
[01:44:09.894] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956317035253911584:91:0)
[01:44:09.920] Build status: STARTED
[01:44:09.921] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956317035253911584:92:0) after 6m23s
[01:50:32.991] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956317035253911584:92:0)
[01:50:33.014] Build status: STARTED
[01:50:33.014] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956317035253911584:93:0) after 7m13s
[01:57:46.390] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956317035253911584:93:0)
[01:57:46.437] Build status: STARTED
[01:57:46.437] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956317035253911584:94:0) after 3m2s
[02:00:48.884] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956317035253911584:94:0)
[02:00:48.916] Build status: STARTED
[02:00:48.916] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956317035253911584:95:0) after 7m44s
[02:08:33.215] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956317035253911584:95:0)
[02:08:33.244] Build status: STARTED
[02:08:33.244] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956317035253911584:96:0) after 2m4s
[02:10:38.140] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956317035253911584:96:0)
[02:10:38.172] Build status: STARTED
[02:10:38.172] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956317035253911584:97:0) after 2m58s
[02:13:36.201] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956317035253911584:97:0)
[02:13:36.223] Build status: STARTED
[02:13:36.223] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956317035253911584:98:0) after 4m20s
[02:17:56.351] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956317035253911584:98:0)
[02:17:56.375] Build status: STARTED
[02:17:56.375] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956317035253911584:99:0) after 6m1s
[02:23:57.530] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956317035253911584:99:0)
[02:23:57.551] Build status: STARTED
[02:23:57.551] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956317035253911584:100:0) after 5m29s
[02:29:26.678] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956317035253911584:100:0)
[02:29:26.706] Build status: STARTED
[02:29:26.706] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956317035253911584:101:0) after 9m4s
[02:38:30.879] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956317035253911584:101:0)
[02:38:30.958] Build status: STARTED
[02:38:30.958] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956317035253911584:102:0) after 8m37s
[02:47:07.987] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956317035253911584:102:0)
[02:47:08.020] Build status: STARTED
[02:47:08.020] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956317035253911584:103:0) after 3m0s
[02:50:08.076] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956317035253911584:103:0)
[02:50:08.107] Build status: STARTED
[02:50:08.107] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956317035253911584:104:0) after 5m15s
[02:55:23.684] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956317035253911584:104:0)
[02:55:23.704] Build status: STARTED
[02:55:23.705] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956317035253911584:105:0) after 7m18s
[03:02:41.734] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956317035253911584:105:0)
[03:02:41.802] Build status: STARTED
[03:02:41.802] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956317035253911584:106:0) after 5m46s
[03:08:28.183] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956317035253911584:106:0)
[03:08:28.205] Build status: STARTED
[03:08:28.205] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956317035253911584:107:0) after 3m50s
[03:12:18.401] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956317035253911584:107:0)
[03:12:18.435] Build status: STARTED
[03:12:18.435] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956317035253911584:108:0) after 3m55s
[03:16:13.643] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956317035253911584:108:0)
[03:16:13.663] Build status: STARTED
[03:16:13.663] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956317035253911584:109:0) after 7m57s
[03:24:10.711] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956317035253911584:109:0)
[03:24:10.731] Build status: STARTED
[03:24:10.732] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956317035253911584:110:0) after 4m32s
[03:28:42.776] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956317035253911584:110:0)
[03:28:42.797] Build status: STARTED
[03:28:42.797] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956317035253911584:111:0) after 3m17s
[03:31:59.825] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956317035253911584:111:0)
[03:31:59.850] Build status: STARTED
[03:31:59.850] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956317035253911584:112:0) after 2m26s
[03:34:25.893] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956317035253911584:112:0)
[03:34:25.919] Build status: STARTED
[03:34:25.919] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956317035253911584:113:0) after 5m51s
[03:40:17.103] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956317035253911584:113:0)
[03:40:17.125] Build status: STARTED
[03:40:17.125] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956317035253911584:114:0) after 5m47s
[03:46:04.240] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956317035253911584:114:0)
[03:46:04.266] Build status: STARTED
[03:46:04.266] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8956317035253911584:115:0) after 9m48s
[03:52:21.397] Received PubSub notification, asking Buildbucket for the build status
[03:52:21.461] Build:
{
"id": "8790886973367834753",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "Win 10 Fast Ring"
},
"number": 13111,
"createdBy": "project:chromium",
"createTime": "2023-01-26T17:24:57.276808197Z",
"startTime": "2023-01-26T17:34:16.686216Z",
"endTime": "2023-01-27T03:52:20.703437Z",
"updateTime": "2023-01-27T03:52:20.703437Z",
"status": "INFRA_FAILURE",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "f577ac44680483ab32303e9816d7481737d6a3ca",
"ref": "refs/heads/main"
}
}
}
[03:52:21.461] Invocation finished in 10h27m25.366722872s with status FAILED