[20:44:28.400] New invocation is queued and will start shortly
[20:44:29.548] Starting the invocation (attempt 1)
[20:44:29.581] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/05a4bcf9edd2d0222f574056cc853337b6d21108"
[20:44:29.581] Popped gitiles commit info from properties and tags
[20:44:29.581] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[20:44:29.581] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[20:44:29.581] Buildbucket request:
{
"requestId": "8945161054525316912",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "Win 10 Fast Ring"
},
"properties": {
},
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "05a4bcf9edd2d0222f574056cc853337b6d21108",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8945161054525316912"
},
{
"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"
}
}
[20:44:30.237] Scheduled build:
{
"id": "8779730992561671217",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "Win 10 Fast Ring"
},
"number": 13402,
"createdBy": "project:chromium",
"createTime": "2023-05-29T20:44:29.645852363Z",
"updateTime": "2023-05-29T20:44:29.645852363Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "05a4bcf9edd2d0222f574056cc853337b6d21108",
"ref": "refs/heads/main"
}
}
}
[20:44:30.237] Task URL: https://cr-buildbucket.appspot.com/build/8779730992561671217
[20:44:30.237] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8945161054525316912:2:0) after 2m46s
[20:47:16.455] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8945161054525316912:2:0)
[20:47:16.475] Build status: SCHEDULED
[20:47:16.475] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8945161054525316912:3:0) after 7m9s
[20:54:25.498] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8945161054525316912:3:0)
[20:54:25.562] Build status: SCHEDULED
[20:54:25.562] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8945161054525316912:4:0) after 4m8s
[20:58:33.599] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8945161054525316912:4:0)
[20:58:33.660] Build status: SCHEDULED
[20:58:33.660] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8945161054525316912:5:0) after 7m9s
[21:02:16.668] Received PubSub notification, asking Buildbucket for the build status
[21:02:16.696] Build status: STARTED
[21:05:42.830] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8945161054525316912:5:0)
[21:05:42.851] Build status: STARTED
[21:05:42.851] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8945161054525316912:7:0) after 3m42s
[21:09:24.848] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8945161054525316912:7:0)
[21:09:24.882] Build status: STARTED
[21:09:24.882] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8945161054525316912:8:0) after 8m56s
[21:18:20.899] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8945161054525316912:8:0)
[21:18:20.943] Build status: STARTED
[21:18:20.943] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8945161054525316912:9:0) after 6m47s
[21:25:07.945] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8945161054525316912:9:0)
[21:25:07.967] Build status: STARTED
[21:25:07.967] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8945161054525316912:10:0) after 1m37s
[21:26:44.992] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8945161054525316912:10:0)
[21:26:45.016] Build status: STARTED
[21:26:45.016] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8945161054525316912:11:0) after 3m27s
[21:30:12.437] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8945161054525316912:11:0)
[21:30:12.453] Build status: STARTED
[21:30:12.453] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8945161054525316912:12:0) after 4m8s
[21:34:20.489] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8945161054525316912:12:0)
[21:34:20.549] Build status: STARTED
[21:34:20.549] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8945161054525316912:13:0) after 8m42s
[21:43:02.606] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8945161054525316912:13:0)
[21:43:02.626] Build status: STARTED
[21:43:02.626] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8945161054525316912:14:0) after 5m8s
[21:48:10.644] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8945161054525316912:14:0)
[21:48:10.670] Build status: STARTED
[21:48:10.670] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8945161054525316912:15:0) after 2m37s
[21:50:47.697] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8945161054525316912:15:0)
[21:50:47.743] Build status: STARTED
[21:50:47.743] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8945161054525316912:16:0) after 2m32s
[21:53:19.771] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8945161054525316912:16:0)
[21:53:19.793] Build status: STARTED
[21:53:19.793] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8945161054525316912:17:0) after 5m39s
[21:58:58.879] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8945161054525316912:17:0)
[21:58:58.897] Build status: STARTED
[21:58:58.897] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8945161054525316912:18:0) after 1m54s
[22:00:53.014] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8945161054525316912:18:0)
[22:00:53.054] Build status: STARTED
[22:00:53.054] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8945161054525316912:19:0) after 7m58s
[22:08:51.297] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8945161054525316912:19:0)
[22:08:51.323] Build status: STARTED
[22:08:51.323] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8945161054525316912:20:0) after 7m22s
[22:16:13.327] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8945161054525316912:20:0)
[22:16:13.405] Build status: STARTED
[22:16:13.405] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8945161054525316912:21:0) after 7m53s
[22:24:06.499] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8945161054525316912:21:0)
[22:24:06.522] Build status: STARTED
[22:24:06.522] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8945161054525316912:22:0) after 2m8s
[22:26:14.601] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8945161054525316912:22:0)
[22:26:14.634] Build status: STARTED
[22:26:14.634] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8945161054525316912:23:0) after 8m30s
[22:34:44.650] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8945161054525316912:23:0)
[22:34:44.673] Build status: STARTED
[22:34:44.673] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8945161054525316912:24:0) after 3m59s
[22:38:43.782] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8945161054525316912:24:0)
[22:38:43.834] Build status: STARTED
[22:38:43.834] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8945161054525316912:25:0) after 9m6s
[22:47:49.860] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8945161054525316912:25:0)
[22:47:49.883] Build status: STARTED
[22:47:49.883] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8945161054525316912:26:0) after 2m14s
[22:50:04.120] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8945161054525316912:26:0)
[22:50:04.140] Build status: STARTED
[22:50:04.140] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8945161054525316912:27:0) after 4m10s
[22:54:14.347] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8945161054525316912:27:0)
[22:54:14.367] Build status: STARTED
[22:54:14.367] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8945161054525316912:28:0) after 2m54s
[22:57:08.472] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8945161054525316912:28:0)
[22:57:08.543] Build status: STARTED
[22:57:08.543] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8945161054525316912:29:0) after 3m3s
[23:00:11.707] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8945161054525316912:29:0)
[23:00:11.729] Build status: STARTED
[23:00:11.729] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8945161054525316912:30:0) after 6m15s
[23:07:20.642] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8945161054525316912:30:0)
[23:07:20.666] Build status: STARTED
[23:07:20.666] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8945161054525316912:31:0) after 4m56s
[23:12:16.720] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8945161054525316912:31:0)
[23:12:16.738] Build status: STARTED
[23:12:16.738] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8945161054525316912:32:0) after 4m31s
[23:16:47.779] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8945161054525316912:32:0)
[23:16:47.799] Build status: STARTED
[23:16:47.799] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8945161054525316912:33:0) after 3m50s
[23:20:37.825] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8945161054525316912:33:0)
[23:20:37.858] Build status: STARTED
[23:20:37.858] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8945161054525316912:34:0) after 2m1s
[23:22:38.875] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8945161054525316912:34:0)
[23:22:38.897] Build status: STARTED
[23:22:38.897] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8945161054525316912:35:0) after 4m29s
[23:27:07.958] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8945161054525316912:35:0)
[23:27:07.982] Build status: STARTED
[23:27:07.982] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8945161054525316912:36:0) after 3m4s
[23:30:12.081] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8945161054525316912:36:0)
[23:30:12.101] Build status: STARTED
[23:30:12.101] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8945161054525316912:37:0) after 5m30s
[23:35:42.131] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8945161054525316912:37:0)
[23:35:42.154] Build status: STARTED
[23:35:42.154] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8945161054525316912:38:0) after 9m28s
[23:45:10.275] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8945161054525316912:38:0)
[23:45:10.308] Build status: STARTED
[23:45:10.308] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8945161054525316912:39:0) after 7m49s
[23:52:59.395] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8945161054525316912:39:0)
[23:52:59.420] Build status: STARTED
[23:52:59.420] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8945161054525316912:40:0) after 6m31s
[23:59:30.466] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8945161054525316912:40:0)
[23:59:30.487] Build status: STARTED
[23:59:30.487] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8945161054525316912:41:0) after 2m31s
[00:02:01.537] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8945161054525316912:41:0)
[00:02:01.576] Build status: STARTED
[00:02:01.576] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8945161054525316912:42:0) after 5m17s
[00:07:18.850] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8945161054525316912:42:0)
[00:07:18.893] Build status: STARTED
[00:07:18.893] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8945161054525316912:43:0) after 8m47s
[00:16:05.995] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8945161054525316912:43:0)
[00:16:06.014] Build status: STARTED
[00:16:06.014] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8945161054525316912:44:0) after 2m34s
[00:18:40.240] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8945161054525316912:44:0)
[00:18:40.259] Build status: STARTED
[00:18:40.259] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8945161054525316912:45:0) after 1m10s
[00:19:50.296] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8945161054525316912:45:0)
[00:19:50.317] Build status: STARTED
[00:19:50.317] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8945161054525316912:46:0) after 9m11s
[00:29:01.343] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8945161054525316912:46:0)
[00:29:01.367] Build status: STARTED
[00:29:01.367] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8945161054525316912:47:0) after 8m18s
[00:37:19.412] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8945161054525316912:47:0)
[00:37:19.558] Build status: STARTED
[00:37:19.558] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8945161054525316912:48:0) after 5m50s
[00:43:09.642] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8945161054525316912:48:0)
[00:43:09.806] Build status: STARTED
[00:43:09.806] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8945161054525316912:49:0) after 8m50s
[00:51:59.924] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8945161054525316912:49:0)
[00:51:59.943] Build status: STARTED
[00:51:59.943] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8945161054525316912:50:0) after 5m30s
[00:57:30.058] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8945161054525316912:50:0)
[00:57:30.083] Build status: STARTED
[00:57:30.083] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8945161054525316912:51:0) after 7m7s
[01:04:37.283] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8945161054525316912:51:0)
[01:04:37.303] Build status: STARTED
[01:04:37.303] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8945161054525316912:52:0) after 2m36s
[01:07:13.341] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8945161054525316912:52:0)
[01:07:13.364] Build status: STARTED
[01:07:13.364] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8945161054525316912:53:0) after 8m9s
[01:15:22.673] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8945161054525316912:53:0)
[01:15:22.692] Build status: STARTED
[01:15:22.692] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8945161054525316912:54:0) after 8m50s
[01:24:12.911] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8945161054525316912:54:0)
[01:24:12.929] Build status: STARTED
[01:24:12.929] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8945161054525316912:55:0) after 2m3s
[01:26:15.950] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8945161054525316912:55:0)
[01:26:15.972] Build status: STARTED
[01:26:15.972] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8945161054525316912:56:0) after 4m45s
[01:31:01.075] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8945161054525316912:56:0)
[01:31:01.152] Build status: STARTED
[01:31:01.152] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8945161054525316912:57:0) after 3m36s
[01:34:37.181] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8945161054525316912:57:0)
[01:34:37.214] Build status: STARTED
[01:34:37.214] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8945161054525316912:58:0) after 1m37s
[01:36:14.302] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8945161054525316912:58:0)
[01:36:14.323] Build status: STARTED
[01:36:14.323] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8945161054525316912:59:0) after 1m2s
[01:37:16.404] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8945161054525316912:59:0)
[01:37:16.436] Build status: STARTED
[01:37:16.436] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8945161054525316912:60:0) after 8m48s
[01:46:04.541] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8945161054525316912:60:0)
[01:46:04.556] Build status: STARTED
[01:46:04.556] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8945161054525316912:61:0) after 6m57s
[01:53:01.537] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8945161054525316912:61:0)
[01:53:01.563] Build status: STARTED
[01:53:01.563] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8945161054525316912:62:0) after 3m37s
[01:56:38.797] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8945161054525316912:62:0)
[01:56:38.818] Build status: STARTED
[01:56:38.818] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8945161054525316912:63:0) after 6m48s
[02:03:27.022] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8945161054525316912:63:0)
[02:03:27.053] Build status: STARTED
[02:03:27.053] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8945161054525316912:64:0) after 4m13s
[02:07:40.077] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8945161054525316912:64:0)
[02:07:40.096] Build status: STARTED
[02:07:40.096] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8945161054525316912:65:0) after 1m58s
[02:09:38.114] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8945161054525316912:65:0)
[02:09:38.136] Build status: STARTED
[02:09:38.136] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8945161054525316912:66:0) after 7m29s
[02:17:07.168] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8945161054525316912:66:0)
[02:17:07.191] Build status: STARTED
[02:17:07.191] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8945161054525316912:67:0) after 6m7s
[02:23:14.235] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8945161054525316912:67:0)
[02:23:14.255] Build status: STARTED
[02:23:14.255] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8945161054525316912:68:0) after 9m28s
[02:32:42.357] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8945161054525316912:68:0)
[02:32:42.388] Build status: STARTED
[02:32:42.388] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8945161054525316912:69:0) after 5m17s
[02:37:59.471] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8945161054525316912:69:0)
[02:37:59.494] Build status: STARTED
[02:37:59.494] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8945161054525316912:70:0) after 3m13s
[02:41:12.623] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8945161054525316912:70:0)
[02:41:12.649] Build status: STARTED
[02:41:12.649] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8945161054525316912:71:0) after 9m56s
[02:51:08.818] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8945161054525316912:71:0)
[02:51:08.843] Build status: STARTED
[02:51:08.843] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8945161054525316912:72:0) after 6m30s
[02:57:39.011] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8945161054525316912:72:0)
[02:57:39.040] Build status: STARTED
[02:57:39.041] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8945161054525316912:73:0) after 2m6s
[02:59:45.063] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8945161054525316912:73:0)
[02:59:45.141] Build status: STARTED
[02:59:45.141] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8945161054525316912:74:0) after 2m8s
[03:01:53.161] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8945161054525316912:74:0)
[03:01:53.202] Build status: STARTED
[03:01:53.202] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8945161054525316912:75:0) after 8m11s
[03:10:04.270] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8945161054525316912:75:0)
[03:10:04.295] Build status: STARTED
[03:10:04.295] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8945161054525316912:76:0) after 1m36s
[03:11:40.314] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8945161054525316912:76:0)
[03:11:40.340] Build status: STARTED
[03:11:40.340] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8945161054525316912:77:0) after 6m31s
[03:18:11.358] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8945161054525316912:77:0)
[03:18:11.377] Build status: STARTED
[03:18:11.377] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8945161054525316912:78:0) after 4m12s
[03:22:23.400] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8945161054525316912:78:0)
[03:22:23.423] Build status: STARTED
[03:22:23.423] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8945161054525316912:79:0) after 3m25s
[03:25:48.447] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8945161054525316912:79:0)
[03:25:48.468] Build status: STARTED
[03:25:48.468] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8945161054525316912:80:0) after 9m12s
[03:35:00.596] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8945161054525316912:80:0)
[03:35:00.686] Build status: STARTED
[03:35:00.686] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8945161054525316912:81:0) after 6m38s
[03:41:38.828] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8945161054525316912:81:0)
[03:41:38.845] Build status: STARTED
[03:41:38.845] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8945161054525316912:82:0) after 8m36s
[03:50:14.877] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8945161054525316912:82:0)
[03:50:14.898] Build status: STARTED
[03:50:14.898] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8945161054525316912:83:0) after 2m48s
[03:53:02.923] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8945161054525316912:83:0)
[03:53:02.945] Build status: STARTED
[03:53:02.945] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8945161054525316912:84:0) after 1m26s
[03:54:28.997] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8945161054525316912:84:0)
[03:54:29.022] Build status: STARTED
[03:54:29.022] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8945161054525316912:85:0) after 4m35s
[03:59:04.043] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8945161054525316912:85:0)
[03:59:04.063] Build status: STARTED
[03:59:04.063] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8945161054525316912:86:0) after 6m37s
[04:05:41.082] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8945161054525316912:86:0)
[04:05:41.101] Build status: STARTED
[04:05:41.101] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8945161054525316912:87:0) after 5m23s
[04:11:04.164] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8945161054525316912:87:0)
[04:11:04.188] Build status: STARTED
[04:11:04.188] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8945161054525316912:88:0) after 8m13s
[04:19:17.215] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8945161054525316912:88:0)
[04:19:17.236] Build status: STARTED
[04:19:17.236] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8945161054525316912:89:0) after 9m0s
[04:28:19.041] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8945161054525316912:89:0)
[04:28:19.066] Build status: STARTED
[04:28:19.066] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8945161054525316912:90:0) after 6m14s
[04:34:33.150] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8945161054525316912:90:0)
[04:34:33.170] Build status: STARTED
[04:34:33.170] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8945161054525316912:91:0) after 9m14s
[04:43:47.188] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8945161054525316912:91:0)
[04:43:47.257] Build status: STARTED
[04:43:47.257] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8945161054525316912:92:0) after 8m30s
[04:52:17.238] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8945161054525316912:92:0)
[04:52:17.255] Build status: STARTED
[04:52:17.255] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8945161054525316912:93:0) after 5m42s
[04:57:59.312] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8945161054525316912:93:0)
[04:57:59.331] Build status: STARTED
[04:57:59.331] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8945161054525316912:94:0) after 6m55s
[05:04:54.448] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8945161054525316912:94:0)
[05:04:54.517] Build status: STARTED
[05:04:54.517] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8945161054525316912:95:0) after 1m0s
[05:05:54.555] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8945161054525316912:95:0)
[05:05:54.637] Build status: STARTED
[05:05:54.637] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8945161054525316912:96:0) after 6m30s
[05:12:24.678] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8945161054525316912:96:0)
[05:12:24.742] Build status: STARTED
[05:12:24.742] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8945161054525316912:97:0) after 1m28s
[05:13:52.886] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8945161054525316912:97:0)
[05:13:52.906] Build status: STARTED
[05:13:52.906] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8945161054525316912:98:0) after 2m7s
[05:16:00.029] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8945161054525316912:98:0)
[05:16:00.059] Build status: STARTED
[05:16:00.059] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8945161054525316912:99:0) after 6m24s
[05:22:24.086] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8945161054525316912:99:0)
[05:22:24.111] Build status: STARTED
[05:22:24.111] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8945161054525316912:100:0) after 4m39s
[05:27:03.132] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8945161054525316912:100:0)
[05:27:03.180] Build status: STARTED
[05:27:03.180] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8945161054525316912:101:0) after 8m3s
[05:35:06.201] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8945161054525316912:101:0)
[05:35:06.219] Build status: STARTED
[05:35:06.219] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8945161054525316912:102:0) after 5m30s
[05:40:36.250] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8945161054525316912:102:0)
[05:40:36.291] Build status: STARTED
[05:40:36.291] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8945161054525316912:103:0) after 1m53s
[05:42:29.343] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8945161054525316912:103:0)
[05:42:29.362] Build status: STARTED
[05:42:29.362] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8945161054525316912:104:0) after 6m7s
[05:48:36.404] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8945161054525316912:104:0)
[05:48:36.444] Build status: STARTED
[05:48:36.444] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8945161054525316912:105:0) after 7m38s
[05:56:14.463] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8945161054525316912:105:0)
[05:56:14.481] Build status: STARTED
[05:56:14.481] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8945161054525316912:106:0) after 7m9s
[06:03:23.508] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8945161054525316912:106:0)
[06:03:23.535] Build status: STARTED
[06:03:23.535] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8945161054525316912:107:0) after 4m47s
[06:08:10.562] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8945161054525316912:107:0)
[06:08:10.620] Build status: STARTED
[06:08:10.620] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8945161054525316912:108:0) after 6m0s
[06:14:10.642] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8945161054525316912:108:0)
[06:14:10.665] Build status: STARTED
[06:14:10.665] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8945161054525316912:109:0) after 2m18s
[06:16:28.683] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8945161054525316912:109:0)
[06:16:28.700] Build status: STARTED
[06:16:28.700] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8945161054525316912:110:0) after 4m10s
[06:20:38.876] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8945161054525316912:110:0)
[06:20:38.918] Build status: STARTED
[06:20:38.918] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8945161054525316912:111:0) after 7m32s
[06:28:10.947] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8945161054525316912:111:0)
[06:28:10.981] Build status: STARTED
[06:28:10.981] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8945161054525316912:112:0) after 7m39s
[06:35:50.027] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8945161054525316912:112:0)
[06:35:50.051] Build status: STARTED
[06:35:50.051] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8945161054525316912:113:0) after 3m27s
[06:39:17.094] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8945161054525316912:113:0)
[06:39:17.120] Build status: STARTED
[06:39:17.120] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8945161054525316912:114:0) after 4m44s
[06:44:01.250] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8945161054525316912:114:0)
[06:44:01.269] Build status: STARTED
[06:44:01.269] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8945161054525316912:115:0) after 4m22s
[06:48:23.290] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8945161054525316912:115:0)
[06:48:23.313] Build status: STARTED
[06:48:23.313] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8945161054525316912:116:0) after 9m49s
[06:58:12.536] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8945161054525316912:116:0)
[06:58:12.563] Build status: STARTED
[06:58:12.563] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8945161054525316912:117:0) after 1m52s
[07:00:04.596] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8945161054525316912:117:0)
[07:00:04.660] Build status: STARTED
[07:00:04.660] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8945161054525316912:118:0) after 6m14s
[07:02:35.037] Received PubSub notification, asking Buildbucket for the build status
[07:02:35.061] Build:
{
"id": "8779730992561671217",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "Win 10 Fast Ring"
},
"number": 13402,
"createdBy": "project:chromium",
"createTime": "2023-05-29T20:44:29.645852363Z",
"startTime": "2023-05-29T21:02:15.667711Z",
"endTime": "2023-05-30T07:02:34.724504679Z",
"updateTime": "2023-05-30T07:02:34.724504679Z",
"status": "CANCELED",
"statusDetails": {
"timeout": {
}
},
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "05a4bcf9edd2d0222f574056cc853337b6d21108",
"ref": "refs/heads/main"
}
}
}
[07:02:35.061] Invocation finished in 10h18m6.672536014s with status ABORTED