[13:46:56.195] New invocation is queued and will start shortly
[13:46:57.270] Starting the invocation (attempt 1)
[13:46:57.305] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/58c43ed0842fb70a972cd4ad2e4c28d832873cf4"
[13:46:57.305] Popped gitiles commit info from properties and tags
[13:46:57.305] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[13:46:57.305] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[13:46:57.306] Buildbucket request:
{
"requestId": "8956149556606345680",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "CFI Linux ToT"
},
"properties": {
},
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "58c43ed0842fb70a972cd4ad2e4c28d832873cf4",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8956149556606345680"
},
{
"key": "scheduler_job_id",
"value": "chromium/CFI Linux ToT"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[13:46:57.767] Scheduled build:
{
"id": "8790719494698287265",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "CFI Linux ToT"
},
"number": 17902,
"createdBy": "project:chromium",
"createTime": "2023-01-28T13:46:57.382109443Z",
"updateTime": "2023-01-28T13:46:57.382109443Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "58c43ed0842fb70a972cd4ad2e4c28d832873cf4",
"ref": "refs/heads/main"
}
}
}
[13:46:57.767] Task URL: https://cr-buildbucket.appspot.com/build/8790719494698287265
[13:46:57.767] Scheduling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956149556606345680:2:0) after 5m21s
[13:52:07.911] Received PubSub notification, asking Buildbucket for the build status
[13:52:07.987] Build status: STARTED
[13:52:18.934] Handling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956149556606345680:2:0)
[13:52:18.962] Build status: STARTED
[13:52:18.962] Scheduling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956149556606345680:4:0) after 9m30s
[14:01:49.129] Handling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956149556606345680:4:0)
[14:01:49.215] Build status: STARTED
[14:01:49.215] Scheduling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956149556606345680:5:0) after 7m45s
[14:09:34.232] Handling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956149556606345680:5:0)
[14:09:34.260] Build status: STARTED
[14:09:34.260] Scheduling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956149556606345680:6:0) after 4m41s
[14:14:15.361] Handling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956149556606345680:6:0)
[14:14:15.382] Build status: STARTED
[14:14:15.382] Scheduling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956149556606345680:7:0) after 3m15s
[14:17:30.403] Handling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956149556606345680:7:0)
[14:17:30.428] Build status: STARTED
[14:17:30.428] Scheduling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956149556606345680:8:0) after 7m47s
[14:25:17.465] Handling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956149556606345680:8:0)
[14:25:17.553] Build status: STARTED
[14:25:17.553] Scheduling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956149556606345680:9:0) after 9m34s
[14:34:51.665] Handling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956149556606345680:9:0)
[14:34:51.703] Build status: STARTED
[14:34:51.703] Scheduling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956149556606345680:10:0) after 8m47s
[14:43:38.757] Handling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956149556606345680:10:0)
[14:43:38.786] Build status: STARTED
[14:43:38.786] Scheduling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956149556606345680:11:0) after 4m38s
[14:48:16.806] Handling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956149556606345680:11:0)
[14:48:16.832] Build status: STARTED
[14:48:16.832] Scheduling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956149556606345680:12:0) after 7m41s
[14:55:57.952] Handling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956149556606345680:12:0)
[14:55:57.973] Build status: STARTED
[14:55:57.973] Scheduling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956149556606345680:13:0) after 4m48s
[15:00:45.993] Handling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956149556606345680:13:0)
[15:00:46.020] Build status: STARTED
[15:00:46.020] Scheduling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956149556606345680:14:0) after 7m28s
[15:08:14.043] Handling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956149556606345680:14:0)
[15:08:14.117] Build status: STARTED
[15:08:14.117] Scheduling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956149556606345680:15:0) after 4m55s
[15:13:09.239] Handling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956149556606345680:15:0)
[15:13:09.263] Build status: STARTED
[15:13:09.263] Scheduling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956149556606345680:16:0) after 7m28s
[15:20:37.284] Handling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956149556606345680:16:0)
[15:20:37.305] Build status: STARTED
[15:20:37.305] Scheduling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956149556606345680:17:0) after 1m52s
[15:22:29.477] Handling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956149556606345680:17:0)
[15:22:29.498] Build status: STARTED
[15:22:29.498] Scheduling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956149556606345680:18:0) after 3m45s
[15:26:14.514] Handling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956149556606345680:18:0)
[15:26:14.613] Build status: STARTED
[15:26:14.613] Scheduling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956149556606345680:19:0) after 6m54s
[15:33:08.773] Handling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956149556606345680:19:0)
[15:33:08.797] Build status: STARTED
[15:33:08.797] Scheduling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956149556606345680:20:0) after 1m59s
[15:35:07.819] Handling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956149556606345680:20:0)
[15:35:07.844] Build status: STARTED
[15:35:07.844] Scheduling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956149556606345680:21:0) after 2m47s
[15:37:54.863] Handling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956149556606345680:21:0)
[15:37:54.884] Build status: STARTED
[15:37:54.884] Scheduling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956149556606345680:22:0) after 1m16s
[15:39:10.901] Handling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956149556606345680:22:0)
[15:39:10.923] Build status: STARTED
[15:39:10.923] Scheduling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956149556606345680:23:0) after 4m10s
[15:43:20.940] Handling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956149556606345680:23:0)
[15:43:20.965] Build status: STARTED
[15:43:20.965] Scheduling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956149556606345680:24:0) after 1m17s
[15:44:37.988] Handling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956149556606345680:24:0)
[15:44:38.020] Build status: STARTED
[15:44:38.020] Scheduling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956149556606345680:25:0) after 6m39s
[15:51:17.132] Handling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956149556606345680:25:0)
[15:51:17.159] Build status: STARTED
[15:51:17.159] Scheduling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956149556606345680:26:0) after 2m18s
[15:53:35.189] Handling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956149556606345680:26:0)
[15:53:35.211] Build status: STARTED
[15:53:35.211] Scheduling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956149556606345680:27:0) after 9m15s
[16:02:50.233] Handling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956149556606345680:27:0)
[16:02:50.255] Build status: STARTED
[16:02:50.255] Scheduling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956149556606345680:28:0) after 3m26s
[16:06:16.276] Handling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956149556606345680:28:0)
[16:06:16.296] Build status: STARTED
[16:06:16.296] Scheduling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956149556606345680:29:0) after 8m15s
[16:14:31.314] Handling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956149556606345680:29:0)
[16:14:31.338] Build status: STARTED
[16:14:31.338] Scheduling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956149556606345680:30:0) after 4m34s
[16:19:05.447] Handling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956149556606345680:30:0)
[16:19:05.472] Build status: STARTED
[16:19:05.472] Scheduling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956149556606345680:31:0) after 7m20s
[16:26:25.490] Handling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956149556606345680:31:0)
[16:26:25.547] Build status: STARTED
[16:26:25.548] Scheduling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956149556606345680:32:0) after 8m58s
[16:35:23.573] Handling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956149556606345680:32:0)
[16:35:23.599] Build status: STARTED
[16:35:23.599] Scheduling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956149556606345680:33:0) after 7m3s
[16:42:26.623] Handling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956149556606345680:33:0)
[16:42:26.652] Build status: STARTED
[16:42:26.652] Scheduling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956149556606345680:34:0) after 1m0s
[16:43:26.697] Handling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956149556606345680:34:0)
[16:43:26.721] Build status: STARTED
[16:43:26.721] Scheduling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956149556606345680:35:0) after 1m9s
[16:44:35.767] Handling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956149556606345680:35:0)
[16:44:35.799] Build status: STARTED
[16:44:35.799] Scheduling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956149556606345680:36:0) after 1m50s
[16:46:25.921] Handling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956149556606345680:36:0)
[16:46:25.941] Build status: STARTED
[16:46:25.941] Scheduling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956149556606345680:37:0) after 1m17s
[16:47:43.184] Handling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956149556606345680:37:0)
[16:47:43.209] Build status: STARTED
[16:47:43.209] Scheduling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956149556606345680:38:0) after 3m38s
[16:51:21.229] Handling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956149556606345680:38:0)
[16:51:21.253] Build status: STARTED
[16:51:21.253] Scheduling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956149556606345680:39:0) after 9m56s
[17:01:17.275] Handling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956149556606345680:39:0)
[17:01:17.297] Build status: STARTED
[17:01:17.297] Scheduling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956149556606345680:40:0) after 1m38s
[17:02:55.433] Handling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956149556606345680:40:0)
[17:02:55.458] Build status: STARTED
[17:02:55.458] Scheduling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956149556606345680:41:0) after 5m30s
[17:08:25.693] Handling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956149556606345680:41:0)
[17:08:25.714] Build status: STARTED
[17:08:25.714] Scheduling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956149556606345680:42:0) after 8m52s
[17:17:17.967] Handling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956149556606345680:42:0)
[17:17:17.989] Build status: STARTED
[17:17:17.989] Scheduling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956149556606345680:43:0) after 9m43s
[17:27:01.015] Handling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956149556606345680:43:0)
[17:27:01.037] Build status: STARTED
[17:27:01.037] Scheduling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956149556606345680:44:0) after 1m22s
[17:28:23.061] Handling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956149556606345680:44:0)
[17:28:23.084] Build status: STARTED
[17:28:23.084] Scheduling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956149556606345680:45:0) after 7m43s
[17:36:06.116] Handling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956149556606345680:45:0)
[17:36:06.140] Build status: STARTED
[17:36:06.140] Scheduling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956149556606345680:46:0) after 1m58s
[17:38:04.387] Handling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956149556606345680:46:0)
[17:38:04.452] Build status: STARTED
[17:38:04.452] Scheduling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956149556606345680:47:0) after 1m55s
[17:39:59.471] Handling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956149556606345680:47:0)
[17:39:59.490] Build status: STARTED
[17:39:59.490] Scheduling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956149556606345680:48:0) after 2m51s
[17:42:50.490] Handling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956149556606345680:48:0)
[17:42:50.509] Build status: STARTED
[17:42:50.509] Scheduling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956149556606345680:49:0) after 8m30s
[17:51:20.683] Handling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956149556606345680:49:0)
[17:51:20.710] Build status: STARTED
[17:51:20.710] Scheduling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956149556606345680:50:0) after 9m51s
[18:01:11.751] Handling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956149556606345680:50:0)
[18:01:11.799] Build status: STARTED
[18:01:11.799] Scheduling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956149556606345680:51:0) after 8m2s
[18:09:13.939] Handling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956149556606345680:51:0)
[18:09:13.959] Build status: STARTED
[18:09:13.959] Scheduling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956149556606345680:52:0) after 8m45s
[18:17:59.040] Handling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956149556606345680:52:0)
[18:17:59.113] Build status: STARTED
[18:17:59.113] Scheduling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956149556606345680:53:0) after 4m16s
[18:22:15.239] Handling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956149556606345680:53:0)
[18:22:15.262] Build status: STARTED
[18:22:15.262] Scheduling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956149556606345680:54:0) after 5m40s
[18:27:55.324] Handling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956149556606345680:54:0)
[18:27:55.346] Build status: STARTED
[18:27:55.346] Scheduling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956149556606345680:55:0) after 4m0s
[18:31:55.470] Handling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956149556606345680:55:0)
[18:31:55.495] Build status: STARTED
[18:31:55.495] Scheduling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956149556606345680:56:0) after 7m54s
[18:39:49.526] Handling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956149556606345680:56:0)
[18:39:49.550] Build status: STARTED
[18:39:49.550] Scheduling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956149556606345680:57:0) after 9m40s
[18:49:29.866] Handling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956149556606345680:57:0)
[18:49:29.934] Build status: STARTED
[18:49:29.934] Scheduling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956149556606345680:58:0) after 7m21s
[18:56:50.966] Handling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956149556606345680:58:0)
[18:56:51.000] Build status: STARTED
[18:56:51.000] Scheduling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956149556606345680:59:0) after 1m18s
[18:58:09.129] Handling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956149556606345680:59:0)
[18:58:09.150] Build status: STARTED
[18:58:09.151] Scheduling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956149556606345680:60:0) after 3m31s
[19:01:40.169] Handling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956149556606345680:60:0)
[19:01:40.195] Build status: STARTED
[19:01:40.195] Scheduling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956149556606345680:61:0) after 3m15s
[19:04:55.216] Handling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956149556606345680:61:0)
[19:04:55.267] Build status: STARTED
[19:04:55.267] Scheduling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956149556606345680:62:0) after 9m28s
[19:14:23.287] Handling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956149556606345680:62:0)
[19:14:23.312] Build status: STARTED
[19:14:23.312] Scheduling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956149556606345680:63:0) after 7m46s
[19:22:09.330] Handling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956149556606345680:63:0)
[19:22:09.353] Build status: STARTED
[19:22:09.353] Scheduling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956149556606345680:64:0) after 9m25s
[19:31:34.374] Handling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956149556606345680:64:0)
[19:31:34.396] Build status: STARTED
[19:31:34.396] Scheduling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956149556606345680:65:0) after 3m32s
[19:35:06.936] Handling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956149556606345680:65:0)
[19:35:06.955] Build status: STARTED
[19:35:06.955] Scheduling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956149556606345680:66:0) after 4m31s
[19:39:38.054] Handling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956149556606345680:66:0)
[19:39:38.077] Build status: STARTED
[19:39:38.077] Scheduling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956149556606345680:67:0) after 7m21s
[19:46:59.296] Handling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956149556606345680:67:0)
[19:46:59.321] Build status: STARTED
[19:46:59.321] Scheduling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956149556606345680:68:0) after 8m25s
[19:55:24.492] Handling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956149556606345680:68:0)
[19:55:24.512] Build status: STARTED
[19:55:24.512] Scheduling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956149556606345680:69:0) after 2m14s
[19:57:38.539] Handling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956149556606345680:69:0)
[19:57:38.560] Build status: STARTED
[19:57:38.560] Scheduling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956149556606345680:70:0) after 7m18s
[20:04:57.314] Handling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956149556606345680:70:0)
[20:04:57.343] Build status: STARTED
[20:04:57.343] Scheduling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956149556606345680:71:0) after 2m18s
[20:07:15.487] Handling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956149556606345680:71:0)
[20:07:15.524] Build status: STARTED
[20:07:15.524] Scheduling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956149556606345680:72:0) after 3m39s
[20:10:54.546] Handling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956149556606345680:72:0)
[20:10:54.569] Build status: STARTED
[20:10:54.569] Scheduling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956149556606345680:73:0) after 4m9s
[20:15:03.626] Handling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956149556606345680:73:0)
[20:15:03.648] Build status: STARTED
[20:15:03.648] Scheduling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956149556606345680:74:0) after 7m36s
[20:22:40.057] Handling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956149556606345680:74:0)
[20:22:40.085] Build status: STARTED
[20:22:40.085] Scheduling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956149556606345680:75:0) after 4m4s
[20:26:44.243] Handling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956149556606345680:75:0)
[20:26:44.285] Build status: STARTED
[20:26:44.285] Scheduling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956149556606345680:76:0) after 2m49s
[20:29:33.306] Handling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956149556606345680:76:0)
[20:29:33.330] Build status: STARTED
[20:29:33.330] Scheduling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956149556606345680:77:0) after 4m17s
[20:33:50.356] Handling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956149556606345680:77:0)
[20:33:50.380] Build status: STARTED
[20:33:50.380] Scheduling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956149556606345680:78:0) after 6m51s
[20:40:41.506] Handling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956149556606345680:78:0)
[20:40:41.546] Build status: STARTED
[20:40:41.546] Scheduling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956149556606345680:79:0) after 9m20s
[20:50:02.090] Handling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956149556606345680:79:0)
[20:50:02.157] Build status: STARTED
[20:50:02.157] Scheduling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956149556606345680:80:0) after 1m1s
[20:51:03.188] Handling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956149556606345680:80:0)
[20:51:03.209] Build status: STARTED
[20:51:03.209] Scheduling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956149556606345680:81:0) after 1m17s
[20:52:20.500] Handling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956149556606345680:81:0)
[20:52:20.520] Build status: STARTED
[20:52:20.520] Scheduling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956149556606345680:82:0) after 1m48s
[20:54:09.000] Handling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956149556606345680:82:0)
[20:54:09.035] Build status: STARTED
[20:54:09.035] Scheduling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956149556606345680:83:0) after 2m0s
[20:56:09.877] Handling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956149556606345680:83:0)
[20:56:09.940] Build status: STARTED
[20:56:09.940] Scheduling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956149556606345680:84:0) after 4m28s
[21:00:38.311] Handling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956149556606345680:84:0)
[21:00:38.338] Build status: STARTED
[21:00:38.338] Scheduling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956149556606345680:85:0) after 8m50s
[21:09:28.368] Handling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956149556606345680:85:0)
[21:09:28.405] Build status: STARTED
[21:09:28.405] Scheduling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956149556606345680:86:0) after 3m5s
[21:12:33.498] Handling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956149556606345680:86:0)
[21:12:33.518] Build status: STARTED
[21:12:33.518] Scheduling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956149556606345680:87:0) after 3m0s
[21:15:33.540] Handling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956149556606345680:87:0)
[21:15:33.563] Build status: STARTED
[21:15:33.563] Scheduling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956149556606345680:88:0) after 6m11s
[21:21:44.712] Handling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956149556606345680:88:0)
[21:21:44.731] Build status: STARTED
[21:21:44.731] Scheduling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956149556606345680:89:0) after 1m37s
[21:23:21.756] Handling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956149556606345680:89:0)
[21:23:21.781] Build status: STARTED
[21:23:21.781] Scheduling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956149556606345680:90:0) after 1m3s
[21:24:24.799] Handling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956149556606345680:90:0)
[21:24:24.843] Build status: STARTED
[21:24:24.843] Scheduling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956149556606345680:91:0) after 8m20s
[21:32:44.870] Handling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956149556606345680:91:0)
[21:32:44.900] Build status: STARTED
[21:32:44.900] Scheduling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956149556606345680:92:0) after 1m43s
[21:34:28.474] Handling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956149556606345680:92:0)
[21:34:28.498] Build status: STARTED
[21:34:28.498] Scheduling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956149556606345680:93:0) after 1m37s
[21:36:05.724] Handling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956149556606345680:93:0)
[21:36:05.753] Build status: STARTED
[21:36:05.753] Scheduling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956149556606345680:94:0) after 4m7s
[21:40:13.187] Handling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956149556606345680:94:0)
[21:40:13.213] Build status: STARTED
[21:40:13.213] Scheduling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956149556606345680:95:0) after 5m19s
[21:45:32.320] Handling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956149556606345680:95:0)
[21:45:32.358] Build status: STARTED
[21:45:32.358] Scheduling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956149556606345680:96:0) after 6m40s
[21:52:12.384] Handling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956149556606345680:96:0)
[21:52:12.410] Build status: STARTED
[21:52:12.410] Scheduling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956149556606345680:97:0) after 1m11s
[21:53:23.485] Handling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956149556606345680:97:0)
[21:53:23.506] Build status: STARTED
[21:53:23.506] Scheduling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956149556606345680:98:0) after 7m3s
[22:00:26.563] Handling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956149556606345680:98:0)
[22:00:26.586] Build status: STARTED
[22:00:26.587] Scheduling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956149556606345680:99:0) after 7m59s
[22:08:25.629] Handling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956149556606345680:99:0)
[22:08:25.654] Build status: STARTED
[22:08:25.654] Scheduling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956149556606345680:100:0) after 3m24s
[22:11:49.724] Handling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956149556606345680:100:0)
[22:11:49.772] Build status: STARTED
[22:11:49.772] Scheduling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956149556606345680:101:0) after 8m53s
[22:20:42.804] Handling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956149556606345680:101:0)
[22:20:42.837] Build status: STARTED
[22:20:42.837] Scheduling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956149556606345680:102:0) after 3m35s
[22:24:17.857] Handling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956149556606345680:102:0)
[22:24:17.882] Build status: STARTED
[22:24:17.882] Scheduling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956149556606345680:103:0) after 9m0s
[22:33:17.937] Handling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956149556606345680:103:0)
[22:33:17.955] Build status: STARTED
[22:33:17.955] Scheduling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956149556606345680:104:0) after 2m1s
[22:35:18.970] Handling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956149556606345680:104:0)
[22:35:18.991] Build status: STARTED
[22:35:18.991] Scheduling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956149556606345680:105:0) after 6m8s
[22:41:27.016] Handling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956149556606345680:105:0)
[22:41:27.036] Build status: STARTED
[22:41:27.036] Scheduling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956149556606345680:106:0) after 5m21s
[22:46:48.087] Handling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956149556606345680:106:0)
[22:46:48.106] Build status: STARTED
[22:46:48.106] Scheduling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956149556606345680:107:0) after 6m0s
[22:52:48.596] Handling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956149556606345680:107:0)
[22:52:48.615] Build status: STARTED
[22:52:48.615] Scheduling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956149556606345680:108:0) after 5m56s
[22:58:44.639] Handling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956149556606345680:108:0)
[22:58:44.659] Build status: STARTED
[22:58:44.659] Scheduling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956149556606345680:109:0) after 1m46s
[23:00:30.806] Handling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956149556606345680:109:0)
[23:00:30.835] Build status: STARTED
[23:00:30.835] Scheduling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956149556606345680:110:0) after 7m4s
[23:07:34.854] Handling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956149556606345680:110:0)
[23:07:34.876] Build status: STARTED
[23:07:34.876] Scheduling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956149556606345680:111:0) after 4m25s
[23:11:59.986] Handling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956149556606345680:111:0)
[23:12:00.009] Build status: STARTED
[23:12:00.009] Scheduling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956149556606345680:112:0) after 7m38s
[23:19:38.033] Handling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956149556606345680:112:0)
[23:19:38.055] Build status: STARTED
[23:19:38.055] Scheduling timer "check-buildbucket-build-status" (chromium/CFI Linux ToT:8956149556606345680:113:0) after 1m46s
[23:20:16.866] Received PubSub notification, asking Buildbucket for the build status
[23:20:16.892] Build:
{
"id": "8790719494698287265",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "CFI Linux ToT"
},
"number": 17902,
"createdBy": "project:chromium",
"createTime": "2023-01-28T13:46:57.382109443Z",
"startTime": "2023-01-28T13:52:06.269211Z",
"endTime": "2023-01-28T23:20:16.022965848Z",
"updateTime": "2023-01-28T23:20:16.022965848Z",
"status": "FAILURE",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "58c43ed0842fb70a972cd4ad2e4c28d832873cf4",
"ref": "refs/heads/main"
}
}
}
[23:20:16.892] Invocation finished in 9h33m20.712521931s with status FAILED