[20:39:08.354] New invocation is queued and will start shortly
[20:39:09.434] Starting the invocation (attempt 1)
[20:39:09.486] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/fc7936d52590947007f19fcbfc7d4914e565fa4a"
[20:39:09.486] Popped gitiles commit info from properties and tags
[20:39:09.486] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[20:39:09.486] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[20:39:09.486] Buildbucket request:
{
"requestId": "8960834665302036128",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "Win 10 Fast Ring"
},
"properties": {
},
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "fc7936d52590947007f19fcbfc7d4914e565fa4a",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8960834665302036128"
},
{
"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:39:10.065] Scheduled build:
{
"id": "8795404603340390545",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "Win 10 Fast Ring"
},
"number": 12039,
"createdBy": "project:chromium",
"createTime": "2022-12-07T20:39:09.600622785Z",
"updateTime": "2022-12-07T20:39:09.600622785Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "fc7936d52590947007f19fcbfc7d4914e565fa4a",
"ref": "refs/heads/main"
}
}
}
[20:39:10.065] Task URL: https://cr-buildbucket.appspot.com/build/8795404603340390545
[20:39:10.065] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8960834665302036128:2:0) after 2m29s
[20:40:32.051] Received PubSub notification, asking Buildbucket for the build status
[20:40:32.107] Build status: STARTED
[20:41:39.092] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8960834665302036128:2:0)
[20:41:39.150] Build status: STARTED
[20:41:39.150] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8960834665302036128:4:0) after 8m8s
[20:49:47.197] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8960834665302036128:4:0)
[20:49:47.220] Build status: STARTED
[20:49:47.220] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8960834665302036128:5:0) after 1m7s
[20:50:54.256] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8960834665302036128:5:0)
[20:50:54.278] Build status: STARTED
[20:50:54.278] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8960834665302036128:6:0) after 3m9s
[20:54:03.338] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8960834665302036128:6:0)
[20:54:03.367] Build status: STARTED
[20:54:03.367] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8960834665302036128:7:0) after 1m8s
[20:55:11.523] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8960834665302036128:7:0)
[20:55:11.562] Build status: STARTED
[20:55:11.562] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8960834665302036128:8:0) after 5m6s
[21:00:17.668] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8960834665302036128:8:0)
[21:00:17.714] Build status: STARTED
[21:00:17.714] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8960834665302036128:9:0) after 2m16s
[21:02:34.113] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8960834665302036128:9:0)
[21:02:34.160] Build status: STARTED
[21:02:34.160] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8960834665302036128:10:0) after 4m12s
[21:06:46.191] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8960834665302036128:10:0)
[21:06:46.216] Build status: STARTED
[21:06:46.216] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8960834665302036128:11:0) after 4m46s
[21:11:32.341] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8960834665302036128:11:0)
[21:11:32.366] Build status: STARTED
[21:11:32.366] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8960834665302036128:12:0) after 4m46s
[21:16:18.729] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8960834665302036128:12:0)
[21:16:18.790] Build status: STARTED
[21:16:18.790] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8960834665302036128:13:0) after 1m31s
[21:17:49.980] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8960834665302036128:13:0)
[21:17:50.004] Build status: STARTED
[21:17:50.004] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8960834665302036128:14:0) after 7m54s
[21:25:44.035] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8960834665302036128:14:0)
[21:25:44.057] Build status: STARTED
[21:25:44.057] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8960834665302036128:15:0) after 2m6s
[21:27:50.244] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8960834665302036128:15:0)
[21:27:50.270] Build status: STARTED
[21:27:50.270] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8960834665302036128:16:0) after 4m24s
[21:32:14.583] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8960834665302036128:16:0)
[21:32:14.607] Build status: STARTED
[21:32:14.607] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8960834665302036128:17:0) after 7m30s
[21:39:44.989] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8960834665302036128:17:0)
[21:39:45.023] Build status: STARTED
[21:39:45.023] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8960834665302036128:18:0) after 2m37s
[21:42:22.172] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8960834665302036128:18:0)
[21:42:22.202] Build status: STARTED
[21:42:22.202] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8960834665302036128:19:0) after 3m33s
[21:45:55.208] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8960834665302036128:19:0)
[21:45:55.315] Build status: STARTED
[21:45:55.315] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8960834665302036128:20:0) after 9m59s
[21:55:54.471] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8960834665302036128:20:0)
[21:55:54.540] Build status: STARTED
[21:55:54.540] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8960834665302036128:21:0) after 1m19s
[21:57:13.759] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8960834665302036128:21:0)
[21:57:13.785] Build status: STARTED
[21:57:13.785] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8960834665302036128:22:0) after 3m58s
[22:01:11.899] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8960834665302036128:22:0)
[22:01:11.998] Build status: STARTED
[22:01:11.998] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8960834665302036128:23:0) after 9m58s
[22:11:10.238] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8960834665302036128:23:0)
[22:11:10.328] Build status: STARTED
[22:11:10.328] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8960834665302036128:24:0) after 3m35s
[22:14:45.357] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8960834665302036128:24:0)
[22:14:45.397] Build status: STARTED
[22:14:45.397] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8960834665302036128:25:0) after 6m32s
[22:21:17.498] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8960834665302036128:25:0)
[22:21:17.599] Build status: STARTED
[22:21:17.599] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8960834665302036128:26:0) after 6m20s
[22:27:37.710] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8960834665302036128:26:0)
[22:27:37.774] Build status: STARTED
[22:27:37.774] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8960834665302036128:27:0) after 3m13s
[22:30:50.809] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8960834665302036128:27:0)
[22:30:50.831] Build status: STARTED
[22:30:50.832] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8960834665302036128:28:0) after 9m54s
[22:40:44.936] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8960834665302036128:28:0)
[22:40:45.009] Build status: STARTED
[22:40:45.009] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8960834665302036128:29:0) after 3m17s
[22:44:02.058] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8960834665302036128:29:0)
[22:44:02.117] Build status: STARTED
[22:44:02.117] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8960834665302036128:30:0) after 3m44s
[22:47:46.152] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8960834665302036128:30:0)
[22:47:46.180] Build status: STARTED
[22:47:46.180] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8960834665302036128:31:0) after 9m50s
[22:57:36.315] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8960834665302036128:31:0)
[22:57:36.336] Build status: STARTED
[22:57:36.336] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8960834665302036128:32:0) after 7m14s
[23:04:50.413] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8960834665302036128:32:0)
[23:04:50.444] Build status: STARTED
[23:04:50.444] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8960834665302036128:33:0) after 1m13s
[23:06:03.498] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8960834665302036128:33:0)
[23:06:03.534] Build status: STARTED
[23:06:03.534] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8960834665302036128:34:0) after 3m27s
[23:09:30.604] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8960834665302036128:34:0)
[23:09:30.626] Build status: STARTED
[23:09:30.626] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8960834665302036128:35:0) after 5m12s
[23:14:42.789] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8960834665302036128:35:0)
[23:14:42.811] Build status: STARTED
[23:14:42.811] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8960834665302036128:36:0) after 7m40s
[23:22:22.995] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8960834665302036128:36:0)
[23:22:23.027] Build status: STARTED
[23:22:23.027] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8960834665302036128:37:0) after 1m13s
[23:23:36.060] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8960834665302036128:37:0)
[23:23:36.096] Build status: STARTED
[23:23:36.096] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8960834665302036128:38:0) after 2m2s
[23:25:38.252] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8960834665302036128:38:0)
[23:25:38.304] Build status: STARTED
[23:25:38.304] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8960834665302036128:39:0) after 5m41s
[23:31:19.395] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8960834665302036128:39:0)
[23:31:19.425] Build status: STARTED
[23:31:19.425] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8960834665302036128:40:0) after 5m11s
[23:36:30.458] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8960834665302036128:40:0)
[23:36:30.485] Build status: STARTED
[23:36:30.485] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8960834665302036128:41:0) after 8m47s
[23:45:17.629] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8960834665302036128:41:0)
[23:45:17.654] Build status: STARTED
[23:45:17.655] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8960834665302036128:42:0) after 3m19s
[23:48:36.696] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8960834665302036128:42:0)
[23:48:36.722] Build status: STARTED
[23:48:36.722] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8960834665302036128:43:0) after 5m45s
[23:54:21.854] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8960834665302036128:43:0)
[23:54:21.879] Build status: STARTED
[23:54:21.879] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8960834665302036128:44:0) after 9m35s
[00:03:57.002] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8960834665302036128:44:0)
[00:03:57.025] Build status: STARTED
[00:03:57.025] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8960834665302036128:45:0) after 5m35s
[00:09:32.068] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8960834665302036128:45:0)
[00:09:32.091] Build status: STARTED
[00:09:32.091] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8960834665302036128:46:0) after 3m2s
[00:12:34.123] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8960834665302036128:46:0)
[00:12:34.150] Build status: STARTED
[00:12:34.150] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8960834665302036128:47:0) after 5m34s
[00:18:08.248] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8960834665302036128:47:0)
[00:18:08.280] Build status: STARTED
[00:18:08.280] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8960834665302036128:48:0) after 6m47s
[00:24:55.392] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8960834665302036128:48:0)
[00:24:55.417] Build status: STARTED
[00:24:55.417] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8960834665302036128:49:0) after 8m24s
[00:33:19.611] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8960834665302036128:49:0)
[00:33:19.643] Build status: STARTED
[00:33:19.643] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8960834665302036128:50:0) after 9m0s
[00:42:19.659] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8960834665302036128:50:0)
[00:42:19.686] Build status: STARTED
[00:42:19.686] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8960834665302036128:51:0) after 8m4s
[00:50:23.847] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8960834665302036128:51:0)
[00:50:23.875] Build status: STARTED
[00:50:23.876] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8960834665302036128:52:0) after 4m49s
[00:55:13.011] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8960834665302036128:52:0)
[00:55:13.061] Build status: STARTED
[00:55:13.062] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8960834665302036128:53:0) after 8m42s
[01:03:55.161] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8960834665302036128:53:0)
[01:03:55.186] Build status: STARTED
[01:03:55.186] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8960834665302036128:54:0) after 3m57s
[01:07:52.224] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8960834665302036128:54:0)
[01:07:52.269] Build status: STARTED
[01:07:52.269] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8960834665302036128:55:0) after 3m43s
[01:11:35.414] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8960834665302036128:55:0)
[01:11:35.438] Build status: STARTED
[01:11:35.438] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8960834665302036128:56:0) after 1m6s
[01:12:41.510] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8960834665302036128:56:0)
[01:12:41.600] Build status: STARTED
[01:12:41.600] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8960834665302036128:57:0) after 8m4s
[01:20:46.098] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8960834665302036128:57:0)
[01:20:46.119] Build status: STARTED
[01:20:46.119] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8960834665302036128:58:0) after 6m44s
[01:27:30.178] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8960834665302036128:58:0)
[01:27:30.208] Build status: STARTED
[01:27:30.208] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8960834665302036128:59:0) after 4m8s
[01:31:38.996] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8960834665302036128:59:0)
[01:31:39.064] Build status: STARTED
[01:31:39.064] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8960834665302036128:60:0) after 7m19s
[01:38:58.334] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8960834665302036128:60:0)
[01:38:58.382] Build status: STARTED
[01:38:58.382] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8960834665302036128:61:0) after 9m15s
[01:48:13.529] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8960834665302036128:61:0)
[01:48:13.553] Build status: STARTED
[01:48:13.553] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8960834665302036128:62:0) after 3m20s
[01:51:33.818] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8960834665302036128:62:0)
[01:51:33.881] Build status: STARTED
[01:51:33.882] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8960834665302036128:63:0) after 8m46s
[02:00:19.962] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8960834665302036128:63:0)
[02:00:19.990] Build status: STARTED
[02:00:19.990] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8960834665302036128:64:0) after 1m44s
[02:02:04.223] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8960834665302036128:64:0)
[02:02:04.298] Build status: STARTED
[02:02:04.298] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8960834665302036128:65:0) after 1m45s
[02:03:49.589] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8960834665302036128:65:0)
[02:03:49.610] Build status: STARTED
[02:03:49.611] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8960834665302036128:66:0) after 6m4s
[02:09:53.779] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8960834665302036128:66:0)
[02:09:53.805] Build status: STARTED
[02:09:53.805] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8960834665302036128:67:0) after 6m25s
[02:16:19.379] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8960834665302036128:67:0)
[02:16:19.401] Build status: STARTED
[02:16:19.401] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8960834665302036128:68:0) after 2m26s
[02:18:45.534] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8960834665302036128:68:0)
[02:18:45.557] Build status: STARTED
[02:18:45.557] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8960834665302036128:69:0) after 1m27s
[02:20:12.725] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8960834665302036128:69:0)
[02:20:12.747] Build status: STARTED
[02:20:12.747] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8960834665302036128:70:0) after 6m16s
[02:26:28.908] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8960834665302036128:70:0)
[02:26:28.929] Build status: STARTED
[02:26:28.929] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8960834665302036128:71:0) after 5m22s
[02:31:51.042] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8960834665302036128:71:0)
[02:31:51.071] Build status: STARTED
[02:31:51.071] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8960834665302036128:72:0) after 2m45s
[02:34:36.263] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8960834665302036128:72:0)
[02:34:36.288] Build status: STARTED
[02:34:36.288] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8960834665302036128:73:0) after 5m53s
[02:40:29.317] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8960834665302036128:73:0)
[02:40:29.340] Build status: STARTED
[02:40:29.340] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8960834665302036128:74:0) after 9m59s
[02:50:28.467] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8960834665302036128:74:0)
[02:50:28.489] Build status: STARTED
[02:50:28.489] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8960834665302036128:75:0) after 3m46s
[02:54:14.876] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8960834665302036128:75:0)
[02:54:14.897] Build status: STARTED
[02:54:14.897] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8960834665302036128:76:0) after 9m8s
[03:03:22.931] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8960834665302036128:76:0)
[03:03:23.012] Build status: STARTED
[03:03:23.012] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8960834665302036128:77:0) after 1m12s
[03:04:35.071] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8960834665302036128:77:0)
[03:04:35.101] Build status: STARTED
[03:04:35.101] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8960834665302036128:78:0) after 7m26s
[03:12:01.314] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8960834665302036128:78:0)
[03:12:01.337] Build status: STARTED
[03:12:01.337] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8960834665302036128:79:0) after 9m8s
[03:21:09.495] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8960834665302036128:79:0)
[03:21:09.515] Build status: STARTED
[03:21:09.515] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8960834665302036128:80:0) after 3m58s
[03:25:07.784] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8960834665302036128:80:0)
[03:25:07.872] Build status: STARTED
[03:25:07.872] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8960834665302036128:81:0) after 1m27s
[03:26:35.336] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8960834665302036128:81:0)
[03:26:35.367] Build status: STARTED
[03:26:35.367] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8960834665302036128:82:0) after 1m46s
[03:28:21.806] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8960834665302036128:82:0)
[03:28:21.833] Build status: STARTED
[03:28:21.833] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8960834665302036128:83:0) after 4m49s
[03:33:10.869] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8960834665302036128:83:0)
[03:33:10.892] Build status: STARTED
[03:33:10.892] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8960834665302036128:84:0) after 4m44s
[03:37:55.022] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8960834665302036128:84:0)
[03:37:55.084] Build status: STARTED
[03:37:55.084] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8960834665302036128:85:0) after 1m33s
[03:39:28.114] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8960834665302036128:85:0)
[03:39:28.138] Build status: STARTED
[03:39:28.139] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8960834665302036128:86:0) after 7m53s
[03:47:21.167] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8960834665302036128:86:0)
[03:47:21.200] Build status: STARTED
[03:47:21.200] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8960834665302036128:87:0) after 3m22s
[03:50:43.346] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8960834665302036128:87:0)
[03:50:43.369] Build status: STARTED
[03:50:43.369] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8960834665302036128:88:0) after 2m38s
[03:53:21.499] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8960834665302036128:88:0)
[03:53:21.522] Build status: STARTED
[03:53:21.523] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8960834665302036128:89:0) after 3m17s
[03:56:38.594] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8960834665302036128:89:0)
[03:56:38.629] Build status: STARTED
[03:56:38.629] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8960834665302036128:90:0) after 6m10s
[04:02:48.685] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8960834665302036128:90:0)
[04:02:48.707] Build status: STARTED
[04:02:48.707] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8960834665302036128:91:0) after 2m36s
[04:05:24.746] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8960834665302036128:91:0)
[04:05:24.769] Build status: STARTED
[04:05:24.769] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8960834665302036128:92:0) after 4m20s
[04:09:45.223] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8960834665302036128:92:0)
[04:09:45.247] Build status: STARTED
[04:09:45.247] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8960834665302036128:93:0) after 8m18s
[04:18:03.273] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8960834665302036128:93:0)
[04:18:03.340] Build status: STARTED
[04:18:03.341] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8960834665302036128:94:0) after 8m5s
[04:26:08.649] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8960834665302036128:94:0)
[04:26:08.671] Build status: STARTED
[04:26:08.671] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8960834665302036128:95:0) after 1m42s
[04:27:51.074] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8960834665302036128:95:0)
[04:27:51.099] Build status: STARTED
[04:27:51.099] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8960834665302036128:96:0) after 2m40s
[04:30:31.401] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8960834665302036128:96:0)
[04:30:31.426] Build status: STARTED
[04:30:31.427] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8960834665302036128:97:0) after 8m39s
[04:39:10.449] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8960834665302036128:97:0)
[04:39:10.480] Build status: STARTED
[04:39:10.480] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8960834665302036128:98:0) after 6m31s
[04:45:41.519] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8960834665302036128:98:0)
[04:45:41.549] Build status: STARTED
[04:45:41.549] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8960834665302036128:99:0) after 4m59s
[04:50:40.669] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8960834665302036128:99:0)
[04:50:40.698] Build status: STARTED
[04:50:40.698] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8960834665302036128:100:0) after 3m46s
[04:54:26.740] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8960834665302036128:100:0)
[04:54:26.759] Build status: STARTED
[04:54:26.759] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8960834665302036128:101:0) after 3m47s
[04:58:13.795] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8960834665302036128:101:0)
[04:58:13.836] Build status: STARTED
[04:58:13.836] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8960834665302036128:102:0) after 5m42s
[05:03:55.989] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8960834665302036128:102:0)
[05:03:56.021] Build status: STARTED
[05:03:56.021] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8960834665302036128:103:0) after 4m14s
[05:08:10.136] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8960834665302036128:103:0)
[05:08:10.159] Build status: STARTED
[05:08:10.159] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8960834665302036128:104:0) after 3m16s
[05:11:26.193] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8960834665302036128:104:0)
[05:11:26.225] Build status: STARTED
[05:11:26.225] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8960834665302036128:105:0) after 2m47s
[05:14:13.468] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8960834665302036128:105:0)
[05:14:13.493] Build status: STARTED
[05:14:13.493] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8960834665302036128:106:0) after 8m27s
[05:22:40.512] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8960834665302036128:106:0)
[05:22:40.554] Build status: STARTED
[05:22:40.554] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8960834665302036128:107:0) after 1m34s
[05:24:14.606] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8960834665302036128:107:0)
[05:24:14.630] Build status: STARTED
[05:24:14.631] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8960834665302036128:108:0) after 1m40s
[05:25:54.775] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8960834665302036128:108:0)
[05:25:54.832] Build status: STARTED
[05:25:54.832] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8960834665302036128:109:0) after 2m52s
[05:28:46.920] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8960834665302036128:109:0)
[05:28:46.947] Build status: STARTED
[05:28:46.948] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8960834665302036128:110:0) after 2m29s
[05:31:15.985] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8960834665302036128:110:0)
[05:31:16.024] Build status: STARTED
[05:31:16.024] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8960834665302036128:111:0) after 2m49s
[05:34:05.084] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8960834665302036128:111:0)
[05:34:05.115] Build status: STARTED
[05:34:05.115] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8960834665302036128:112:0) after 1m56s
[05:36:01.148] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8960834665302036128:112:0)
[05:36:01.172] Build status: STARTED
[05:36:01.172] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8960834665302036128:113:0) after 2m37s
[05:38:38.209] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8960834665302036128:113:0)
[05:38:38.237] Build status: STARTED
[05:38:38.237] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8960834665302036128:114:0) after 2m27s
[05:41:05.283] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8960834665302036128:114:0)
[05:41:05.305] Build status: STARTED
[05:41:05.305] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8960834665302036128:115:0) after 8m23s
[05:49:28.376] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8960834665302036128:115:0)
[05:49:28.401] Build status: STARTED
[05:49:28.401] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8960834665302036128:116:0) after 1m36s
[05:51:04.478] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8960834665302036128:116:0)
[05:51:04.545] Build status: STARTED
[05:51:04.545] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8960834665302036128:117:0) after 1m3s
[05:52:07.661] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8960834665302036128:117:0)
[05:52:07.691] Build status: STARTED
[05:52:07.691] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8960834665302036128:118:0) after 4m0s
[05:56:07.810] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8960834665302036128:118:0)
[05:56:07.841] Build status: STARTED
[05:56:07.841] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8960834665302036128:119:0) after 6m36s
[06:02:43.907] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8960834665302036128:119:0)
[06:02:44.012] Build status: STARTED
[06:02:44.012] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8960834665302036128:120:0) after 4m0s
[06:06:44.038] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8960834665302036128:120:0)
[06:06:44.058] Build status: STARTED
[06:06:44.058] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8960834665302036128:121:0) after 6m3s
[06:12:47.190] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8960834665302036128:121:0)
[06:12:47.219] Build status: STARTED
[06:12:47.219] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8960834665302036128:122:0) after 1m59s
[06:14:46.461] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8960834665302036128:122:0)
[06:14:46.482] Build status: STARTED
[06:14:46.482] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8960834665302036128:123:0) after 2m34s
[06:17:20.511] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8960834665302036128:123:0)
[06:17:20.535] Build status: STARTED
[06:17:20.535] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8960834665302036128:124:0) after 8m20s
[06:25:40.576] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8960834665302036128:124:0)
[06:25:40.598] Build status: STARTED
[06:25:40.598] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8960834665302036128:125:0) after 5m38s
[06:31:18.792] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8960834665302036128:125:0)
[06:31:18.821] Build status: STARTED
[06:31:18.821] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8960834665302036128:126:0) after 2m24s
[06:33:43.380] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8960834665302036128:126:0)
[06:33:43.408] Build status: STARTED
[06:33:43.408] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8960834665302036128:127:0) after 2m20s
[06:36:03.441] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8960834665302036128:127:0)
[06:36:03.464] Build status: STARTED
[06:36:03.465] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8960834665302036128:128:0) after 6m8s
[06:42:11.492] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8960834665302036128:128:0)
[06:42:11.520] Build status: STARTED
[06:42:11.520] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8960834665302036128:129:0) after 5m14s
[06:47:25.588] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8960834665302036128:129:0)
[06:47:25.624] Build status: STARTED
[06:47:25.624] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8960834665302036128:130:0) after 5m43s
[06:53:08.683] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8960834665302036128:130:0)
[06:53:08.712] Build status: STARTED
[06:53:08.712] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8960834665302036128:131:0) after 3m8s
[06:53:09.589] Received PubSub notification, asking Buildbucket for the build status
[06:53:09.617] Build:
{
"id": "8795404603340390545",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "Win 10 Fast Ring"
},
"number": 12039,
"createdBy": "project:chromium",
"createTime": "2022-12-07T20:39:09.600622785Z",
"startTime": "2022-12-07T20:40:31.017941Z",
"endTime": "2022-12-08T06:53:08.860779Z",
"updateTime": "2022-12-08T06:53:08.860779Z",
"status": "INFRA_FAILURE",
"statusDetails": {
"timeout": {
}
},
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "fc7936d52590947007f19fcbfc7d4914e565fa4a",
"ref": "refs/heads/main"
}
}
}
[06:53:09.617] Invocation finished in 10h14m1.271031528s with status FAILED