[02:23:02.551] New invocation is queued and will start shortly
[02:23:03.621] Starting the invocation (attempt 1)
[02:23:03.651] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/04062685498d473b4645d10e18882c62a3deb7e8"
[02:23:03.651] Popped gitiles commit info from properties and tags
[02:23:03.651] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[02:23:03.651] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[02:23:03.651] Buildbucket request:
{
"requestId": "8878460386322244560",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "linux-chromeos-rel"
},
"properties": {
},
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "04062685498d473b4645d10e18882c62a3deb7e8",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8878460386322244560"
},
{
"key": "scheduler_job_id",
"value": "chromium/linux-chromeos-rel"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[02:23:04.112] Scheduled build:
{
"id": "8713030324448303249",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "linux-chromeos-rel"
},
"number": 89828,
"createdBy": "project:chromium",
"createTime": "2025-06-04T02:23:03.712101619Z",
"updateTime": "2025-06-04T02:23:03.712101619Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "04062685498d473b4645d10e18882c62a3deb7e8",
"ref": "refs/heads/main"
}
}
}
[02:23:04.112] Task URL: https://cr-buildbucket.appspot.com/build/8713030324448303249
[02:23:04.112] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:8878460386322244560:2:0) after 4m21s
[02:23:05.124] Received PubSub notification, asking Buildbucket for the build status
[02:23:05.152] Build status: SCHEDULED
[02:24:01.365] Received PubSub notification, asking Buildbucket for the build status
[02:24:01.398] Build status: STARTED
[02:27:25.130] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:8878460386322244560:2:0)
[02:27:25.158] Build status: STARTED
[02:27:25.158] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:8878460386322244560:5:0) after 6m32s
[02:33:57.185] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:8878460386322244560:5:0)
[02:33:57.204] Build status: STARTED
[02:33:57.204] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:8878460386322244560:6:0) after 4m4s
[02:38:01.216] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:8878460386322244560:6:0)
[02:38:01.239] Build status: STARTED
[02:38:01.239] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:8878460386322244560:7:0) after 1m6s
[02:39:07.249] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:8878460386322244560:7:0)
[02:39:07.277] Build status: STARTED
[02:39:07.277] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:8878460386322244560:8:0) after 8m7s
[02:47:14.324] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:8878460386322244560:8:0)
[02:47:14.344] Build status: STARTED
[02:47:14.344] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:8878460386322244560:9:0) after 2m5s
[02:49:19.411] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:8878460386322244560:9:0)
[02:49:19.439] Build status: STARTED
[02:49:19.439] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:8878460386322244560:10:0) after 1m22s
[02:50:41.476] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:8878460386322244560:10:0)
[02:50:41.506] Build status: STARTED
[02:50:41.506] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:8878460386322244560:11:0) after 8m35s
[02:59:16.568] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:8878460386322244560:11:0)
[02:59:16.585] Build status: STARTED
[02:59:16.585] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:8878460386322244560:12:0) after 5m57s
[03:05:13.612] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:8878460386322244560:12:0)
[03:05:13.707] Build status: STARTED
[03:05:13.707] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:8878460386322244560:13:0) after 4m12s
[03:09:25.732] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:8878460386322244560:13:0)
[03:09:25.749] Build status: STARTED
[03:09:25.749] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:8878460386322244560:14:0) after 6m15s
[03:15:40.770] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:8878460386322244560:14:0)
[03:15:40.800] Build status: STARTED
[03:15:40.800] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:8878460386322244560:15:0) after 7m17s
[03:22:57.824] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:8878460386322244560:15:0)
[03:22:57.845] Build status: STARTED
[03:22:57.845] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:8878460386322244560:16:0) after 6m43s
[03:29:40.833] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:8878460386322244560:16:0)
[03:29:40.861] Build status: STARTED
[03:29:40.861] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:8878460386322244560:17:0) after 5m53s
[03:35:34.157] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:8878460386322244560:17:0)
[03:35:34.223] Build status: STARTED
[03:35:34.223] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:8878460386322244560:18:0) after 8m27s
[03:44:01.238] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:8878460386322244560:18:0)
[03:44:01.262] Build status: STARTED
[03:44:01.262] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:8878460386322244560:19:0) after 9m13s
[03:53:14.429] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:8878460386322244560:19:0)
[03:53:14.451] Build status: STARTED
[03:53:14.451] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:8878460386322244560:20:0) after 4m19s
[03:57:33.919] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:8878460386322244560:20:0)
[03:57:33.937] Build status: STARTED
[03:57:33.937] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:8878460386322244560:21:0) after 3m51s
[04:01:24.966] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:8878460386322244560:21:0)
[04:01:25.223] Build status: STARTED
[04:01:25.223] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:8878460386322244560:22:0) after 6m44s
[04:08:09.308] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:8878460386322244560:22:0)
[04:08:09.330] Build status: STARTED
[04:08:09.330] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:8878460386322244560:23:0) after 5m55s
[04:14:04.449] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:8878460386322244560:23:0)
[04:14:04.463] Build status: STARTED
[04:14:04.463] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:8878460386322244560:24:0) after 5m56s
[04:20:00.508] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:8878460386322244560:24:0)
[04:20:00.534] Build status: STARTED
[04:20:00.534] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:8878460386322244560:25:0) after 4m1s
[04:24:01.555] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:8878460386322244560:25:0)
[04:24:01.573] Build status: STARTED
[04:24:01.573] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:8878460386322244560:26:0) after 7m24s
[04:31:25.743] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:8878460386322244560:26:0)
[04:31:25.763] Build status: STARTED
[04:31:25.763] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:8878460386322244560:27:0) after 4m23s
[04:35:48.785] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:8878460386322244560:27:0)
[04:35:48.806] Build status: STARTED
[04:35:48.806] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:8878460386322244560:28:0) after 5m49s
[04:41:37.827] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:8878460386322244560:28:0)
[04:41:37.846] Build status: STARTED
[04:41:37.846] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:8878460386322244560:29:0) after 7m23s
[04:49:00.916] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:8878460386322244560:29:0)
[04:49:00.959] Build status: STARTED
[04:49:00.959] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:8878460386322244560:30:0) after 3m14s
[04:52:15.125] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:8878460386322244560:30:0)
[04:52:15.143] Build status: STARTED
[04:52:15.143] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:8878460386322244560:31:0) after 9m15s
[04:55:17.008] Received PubSub notification, asking Buildbucket for the build status
[04:55:17.027] Build:
{
"id": "8713030324448303249",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "linux-chromeos-rel"
},
"number": 89828,
"createdBy": "project:chromium",
"createTime": "2025-06-04T02:23:03.712101619Z",
"startTime": "2025-06-04T02:24:00.907140955Z",
"endTime": "2025-06-04T04:55:16.654272298Z",
"updateTime": "2025-06-04T04:55:16.654272298Z",
"status": "FAILURE",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "04062685498d473b4645d10e18882c62a3deb7e8",
"ref": "refs/heads/main"
}
}
}
[04:55:17.027] Invocation finished in 2h32m14.484642618s with status FAILED