[10:14:58.806] New invocation is queued and will start shortly
[10:14:59.927] Starting the invocation (attempt 1)
[10:14:59.955] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/59e079fdd7b525cfe81858a69a637891f6722cf5"
[10:14:59.955] Popped gitiles commit info from properties and tags
[10:14:59.955] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[10:14:59.955] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[10:14:59.956] Buildbucket request:
{
"requestId": "8854966080274413824",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "Linux Viz"
},
"properties": {
},
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "59e079fdd7b525cfe81858a69a637891f6722cf5",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8854966080274413824"
},
{
"key": "scheduler_job_id",
"value": "chromium/Linux Viz"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[10:15:00.405] Scheduled build:
{
"id": "8689536018367449921",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "Linux Viz"
},
"number": 47989,
"createdBy": "project:chromium",
"createTime": "2026-02-18T10:15:00.003369198Z",
"updateTime": "2026-02-18T10:15:00.003369198Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "59e079fdd7b525cfe81858a69a637891f6722cf5",
"ref": "refs/heads/main"
}
}
}
[10:15:00.405] Task URL: https://cr-buildbucket.appspot.com/build/8689536018367449921
[10:15:00.405] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:8854966080274413824:2:0) after 2m8s
[10:15:01.376] Received PubSub notification, asking Buildbucket for the build status
[10:15:01.470] Build status: SCHEDULED
[10:16:01.472] Received PubSub notification, asking Buildbucket for the build status
[10:16:01.486] Build status: STARTED
[10:17:08.376] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:8854966080274413824:2:0)
[10:17:08.391] Build status: STARTED
[10:17:08.391] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:8854966080274413824:5:0) after 3m27s
[10:20:35.462] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:8854966080274413824:5:0)
[10:20:35.476] Build status: STARTED
[10:20:35.476] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:8854966080274413824:6:0) after 8m54s
[10:29:29.498] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:8854966080274413824:6:0)
[10:29:29.530] Build status: STARTED
[10:29:29.530] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:8854966080274413824:7:0) after 5m46s
[10:35:15.578] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:8854966080274413824:7:0)
[10:35:15.592] Build status: STARTED
[10:35:15.592] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:8854966080274413824:8:0) after 3m5s
[10:38:20.608] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:8854966080274413824:8:0)
[10:38:20.627] Build status: STARTED
[10:38:20.627] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:8854966080274413824:9:0) after 6m44s
[10:45:04.700] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:8854966080274413824:9:0)
[10:45:04.730] Build status: STARTED
[10:45:04.730] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:8854966080274413824:10:0) after 6m18s
[10:51:22.743] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:8854966080274413824:10:0)
[10:51:22.779] Build status: STARTED
[10:51:22.779] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:8854966080274413824:11:0) after 7m3s
[10:58:26.111] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:8854966080274413824:11:0)
[10:58:26.126] Build status: STARTED
[10:58:26.126] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:8854966080274413824:12:0) after 8m14s
[11:06:40.128] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:8854966080274413824:12:0)
[11:06:40.141] Build status: STARTED
[11:06:40.141] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:8854966080274413824:13:0) after 7m47s
[11:14:27.217] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:8854966080274413824:13:0)
[11:14:27.234] Build status: STARTED
[11:14:27.234] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:8854966080274413824:14:0) after 8m13s
[11:22:40.251] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:8854966080274413824:14:0)
[11:22:40.308] Build status: STARTED
[11:22:40.309] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:8854966080274413824:15:0) after 4m57s
[11:27:37.329] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:8854966080274413824:15:0)
[11:27:37.342] Build status: STARTED
[11:27:37.342] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:8854966080274413824:16:0) after 8m39s
[11:36:16.385] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:8854966080274413824:16:0)
[11:36:16.402] Build status: STARTED
[11:36:16.402] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:8854966080274413824:17:0) after 4m31s
[11:40:47.465] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:8854966080274413824:17:0)
[11:40:47.489] Build status: STARTED
[11:40:47.490] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:8854966080274413824:18:0) after 6m24s
[11:47:11.553] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:8854966080274413824:18:0)
[11:47:11.570] Build status: STARTED
[11:47:11.570] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:8854966080274413824:19:0) after 1m44s
[11:48:55.589] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:8854966080274413824:19:0)
[11:48:55.664] Build status: STARTED
[11:48:55.665] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:8854966080274413824:20:0) after 6m30s
[11:55:25.727] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:8854966080274413824:20:0)
[11:55:25.800] Build status: STARTED
[11:55:25.800] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:8854966080274413824:21:0) after 2m52s
[11:58:17.829] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:8854966080274413824:21:0)
[11:58:17.849] Build status: STARTED
[11:58:17.849] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:8854966080274413824:22:0) after 8m53s
[12:07:10.912] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:8854966080274413824:22:0)
[12:07:10.929] Build status: STARTED
[12:07:10.929] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:8854966080274413824:23:0) after 3m28s
[12:10:38.997] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:8854966080274413824:23:0)
[12:10:39.056] Build status: STARTED
[12:10:39.056] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:8854966080274413824:24:0) after 4m32s
[12:15:11.071] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:8854966080274413824:24:0)
[12:15:11.086] Build status: STARTED
[12:15:11.086] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:8854966080274413824:25:0) after 7m7s
[12:22:18.107] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:8854966080274413824:25:0)
[12:22:18.123] Build status: STARTED
[12:22:18.123] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:8854966080274413824:26:0) after 4m47s
[12:27:05.189] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:8854966080274413824:26:0)
[12:27:05.268] Build status: STARTED
[12:27:05.268] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:8854966080274413824:27:0) after 8m48s
[12:35:53.286] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:8854966080274413824:27:0)
[12:35:53.301] Build status: STARTED
[12:35:53.302] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:8854966080274413824:28:0) after 9m44s
[12:45:37.324] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:8854966080274413824:28:0)
[12:45:37.439] Build status: STARTED
[12:45:37.439] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:8854966080274413824:29:0) after 2m0s
[12:47:37.547] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:8854966080274413824:29:0)
[12:47:37.564] Build status: STARTED
[12:47:37.564] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:8854966080274413824:30:0) after 2m13s
[12:49:50.583] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:8854966080274413824:30:0)
[12:49:50.610] Build status: STARTED
[12:49:50.610] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:8854966080274413824:31:0) after 3m49s
[12:53:39.627] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:8854966080274413824:31:0)
[12:53:39.651] Build status: STARTED
[12:53:39.651] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:8854966080274413824:32:0) after 3m32s
[12:57:11.673] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:8854966080274413824:32:0)
[12:57:11.688] Build status: STARTED
[12:57:11.689] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:8854966080274413824:33:0) after 7m21s
[13:04:32.755] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:8854966080274413824:33:0)
[13:04:32.782] Build status: STARTED
[13:04:32.782] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:8854966080274413824:34:0) after 9m21s
[13:13:53.896] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:8854966080274413824:34:0)
[13:13:53.912] Build status: STARTED
[13:13:53.912] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:8854966080274413824:35:0) after 4m55s
[13:18:49.215] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:8854966080274413824:35:0)
[13:18:49.230] Build status: STARTED
[13:18:49.230] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:8854966080274413824:36:0) after 1m49s
[13:20:38.454] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:8854966080274413824:36:0)
[13:20:38.526] Build status: STARTED
[13:20:38.526] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:8854966080274413824:37:0) after 6m58s
[13:27:36.570] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:8854966080274413824:37:0)
[13:27:36.586] Build status: STARTED
[13:27:36.586] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:8854966080274413824:38:0) after 8m33s
[13:36:09.613] Handling timer "check-buildbucket-build-status" (chromium/Linux Viz:8854966080274413824:38:0)
[13:36:09.652] Build status: STARTED
[13:36:09.652] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Viz:8854966080274413824:39:0) after 2m54s
[13:37:33.582] Received PubSub notification, asking Buildbucket for the build status
[13:37:33.667] Build:
{
"id": "8689536018367449921",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "Linux Viz"
},
"number": 47989,
"createdBy": "project:chromium",
"createTime": "2026-02-18T10:15:00.003369198Z",
"startTime": "2026-02-18T10:16:00.845496850Z",
"endTime": "2026-02-18T13:37:07.795925693Z",
"updateTime": "2026-02-18T13:37:07.795925693Z",
"status": "FAILURE",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "59e079fdd7b525cfe81858a69a637891f6722cf5",
"ref": "refs/heads/main"
}
}
}
[13:37:33.667] Invocation finished in 3h22m34.865799143s with status FAILED