[14:12:42.798] New invocation is queued and will start shortly
[14:12:44.999] Starting the invocation (attempt 1)
[14:12:45.038] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/29a25d978c8256429c9c8aa0c741510fd41b1206"
[14:12:45.038] Popped gitiles commit info from properties and tags
[14:12:45.038] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[14:12:45.039] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[14:12:45.039] Buildbucket request:
{
"requestId": "8835200984719933008",
"builder": {
"project": "chromium-m155",
"bucket": "ci",
"builder": "chromeos-arm64-generic-rel"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8835200984719933008",
"job": "chromium-m155/chromeos-arm64-generic-rel",
"triggers": [
{
"gitiles": {
"ref": "refs/branch-heads/8059",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "82460fa313c17c937e596874cfdaa928cad65cd7"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/8059@82460fa313c17c937e596874cfdaa928cad65cd7",
"title": "82460fa313c17c937e596874cfdaa928cad65cd7",
"url": "https://chromium.googlesource.com/chromium/src/+/82460fa313c17c937e596874cfdaa928cad65cd7"
},
{
"gitiles": {
"ref": "refs/branch-heads/8059",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "06ef0abdbff52c4696952af0ec23ca4fe3f1fe18"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/8059@06ef0abdbff52c4696952af0ec23ca4fe3f1fe18",
"title": "06ef0abdbff52c4696952af0ec23ca4fe3f1fe18",
"url": "https://chromium.googlesource.com/chromium/src/+/06ef0abdbff52c4696952af0ec23ca4fe3f1fe18"
},
{
"gitiles": {
"ref": "refs/branch-heads/8059",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "02710ffb436621556b8f0b12fc20fb7479084cc3"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/8059@02710ffb436621556b8f0b12fc20fb7479084cc3",
"title": "02710ffb436621556b8f0b12fc20fb7479084cc3",
"url": "https://chromium.googlesource.com/chromium/src/+/02710ffb436621556b8f0b12fc20fb7479084cc3"
},
{
"gitiles": {
"ref": "refs/branch-heads/8059",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "10fe1e58492cbb098c9a78d8ec05e0c4666af2c6"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/8059@10fe1e58492cbb098c9a78d8ec05e0c4666af2c6",
"title": "10fe1e58492cbb098c9a78d8ec05e0c4666af2c6",
"url": "https://chromium.googlesource.com/chromium/src/+/10fe1e58492cbb098c9a78d8ec05e0c4666af2c6"
},
{
"gitiles": {
"ref": "refs/branch-heads/8059",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "b931f00775a93ead35a03deb20247bc902791fc6"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/8059@b931f00775a93ead35a03deb20247bc902791fc6",
"title": "b931f00775a93ead35a03deb20247bc902791fc6",
"url": "https://chromium.googlesource.com/chromium/src/+/b931f00775a93ead35a03deb20247bc902791fc6"
},
{
"gitiles": {
"ref": "refs/branch-heads/8059",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "4b327594b67ef3edf101a0b19f153ed01b03b1fa"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/8059@4b327594b67ef3edf101a0b19f153ed01b03b1fa",
"title": "4b327594b67ef3edf101a0b19f153ed01b03b1fa",
"url": "https://chromium.googlesource.com/chromium/src/+/4b327594b67ef3edf101a0b19f153ed01b03b1fa"
},
{
"gitiles": {
"ref": "refs/branch-heads/8059",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "cf3d13d94ef2c4570ce08a82d8d0212e6a97c9c3"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/8059@cf3d13d94ef2c4570ce08a82d8d0212e6a97c9c3",
"title": "cf3d13d94ef2c4570ce08a82d8d0212e6a97c9c3",
"url": "https://chromium.googlesource.com/chromium/src/+/cf3d13d94ef2c4570ce08a82d8d0212e6a97c9c3"
},
{
"gitiles": {
"ref": "refs/branch-heads/8059",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "556bede5f558ca6725f14728eabff1a19f1961ba"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/8059@556bede5f558ca6725f14728eabff1a19f1961ba",
"title": "556bede5f558ca6725f14728eabff1a19f1961ba",
"url": "https://chromium.googlesource.com/chromium/src/+/556bede5f558ca6725f14728eabff1a19f1961ba"
},
{
"gitiles": {
"ref": "refs/branch-heads/8059",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "17876035ec5174d8c99db549e0da4ef611e7d991"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/8059@17876035ec5174d8c99db549e0da4ef611e7d991",
"title": "17876035ec5174d8c99db549e0da4ef611e7d991",
"url": "https://chromium.googlesource.com/chromium/src/+/17876035ec5174d8c99db549e0da4ef611e7d991"
},
{
"gitiles": {
"ref": "refs/branch-heads/8059",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "29a25d978c8256429c9c8aa0c741510fd41b1206"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/8059@29a25d978c8256429c9c8aa0c741510fd41b1206",
"title": "29a25d978c8256429c9c8aa0c741510fd41b1206",
"url": "https://chromium.googlesource.com/chromium/src/+/29a25d978c8256429c9c8aa0c741510fd41b1206"
}
]
}
},
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "29a25d978c8256429c9c8aa0c741510fd41b1206",
"ref": "refs/branch-heads/8059"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8835200984719933008"
},
{
"key": "scheduler_job_id",
"value": "chromium-m155/chromeos-arm64-generic-rel"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[14:12:45.616] Scheduled build:
{
"id": "8669770921630669153",
"builder": {
"project": "chromium-m155",
"bucket": "ci",
"builder": "chromeos-arm64-generic-rel"
},
"number": 91,
"createdBy": "project:chromium-m155",
"createTime": "2026-09-24T14:12:45.123397688Z",
"updateTime": "2026-09-24T14:12:45.123397688Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "29a25d978c8256429c9c8aa0c741510fd41b1206",
"ref": "refs/branch-heads/8059"
}
}
}
[14:12:45.616] Task URL: https://cr-buildbucket.appspot.com/build/8669770921630669153
[14:12:45.616] Scheduling timer "check-buildbucket-build-status" (chromium-m155/chromeos-arm64-generic-rel:8835200984719933008:2:0) after 7m52s
[14:12:46.599] Received PubSub notification, asking Buildbucket for the build status
[14:12:46.623] Build status: SCHEDULED
[14:20:37.634] Handling timer "check-buildbucket-build-status" (chromium-m155/chromeos-arm64-generic-rel:8835200984719933008:2:0)
[14:20:37.665] Build status: SCHEDULED
[14:20:37.665] Scheduling timer "check-buildbucket-build-status" (chromium-m155/chromeos-arm64-generic-rel:8835200984719933008:4:0) after 9m28s
[14:30:05.904] Handling timer "check-buildbucket-build-status" (chromium-m155/chromeos-arm64-generic-rel:8835200984719933008:4:0)
[14:30:05.927] Build status: SCHEDULED
[14:30:05.927] Scheduling timer "check-buildbucket-build-status" (chromium-m155/chromeos-arm64-generic-rel:8835200984719933008:5:0) after 8m32s
[14:38:38.000] Handling timer "check-buildbucket-build-status" (chromium-m155/chromeos-arm64-generic-rel:8835200984719933008:5:0)
[14:38:38.051] Build status: SCHEDULED
[14:38:38.051] Scheduling timer "check-buildbucket-build-status" (chromium-m155/chromeos-arm64-generic-rel:8835200984719933008:6:0) after 1m32s
[14:40:10.099] Handling timer "check-buildbucket-build-status" (chromium-m155/chromeos-arm64-generic-rel:8835200984719933008:6:0)
[14:40:10.169] Build status: SCHEDULED
[14:40:10.169] Scheduling timer "check-buildbucket-build-status" (chromium-m155/chromeos-arm64-generic-rel:8835200984719933008:7:0) after 8m25s
[14:48:35.159] Handling timer "check-buildbucket-build-status" (chromium-m155/chromeos-arm64-generic-rel:8835200984719933008:7:0)
[14:48:35.181] Build status: SCHEDULED
[14:48:35.181] Scheduling timer "check-buildbucket-build-status" (chromium-m155/chromeos-arm64-generic-rel:8835200984719933008:8:0) after 7m8s
[14:55:43.287] Handling timer "check-buildbucket-build-status" (chromium-m155/chromeos-arm64-generic-rel:8835200984719933008:8:0)
[14:55:43.315] Build status: SCHEDULED
[14:55:43.315] Scheduling timer "check-buildbucket-build-status" (chromium-m155/chromeos-arm64-generic-rel:8835200984719933008:9:0) after 5m32s
[15:01:15.391] Handling timer "check-buildbucket-build-status" (chromium-m155/chromeos-arm64-generic-rel:8835200984719933008:9:0)
[15:01:15.430] Build status: SCHEDULED
[15:01:15.430] Scheduling timer "check-buildbucket-build-status" (chromium-m155/chromeos-arm64-generic-rel:8835200984719933008:10:0) after 7m40s
[15:08:55.457] Handling timer "check-buildbucket-build-status" (chromium-m155/chromeos-arm64-generic-rel:8835200984719933008:10:0)
[15:08:55.631] Build status: SCHEDULED
[15:08:55.631] Scheduling timer "check-buildbucket-build-status" (chromium-m155/chromeos-arm64-generic-rel:8835200984719933008:11:0) after 9m17s
[15:18:12.660] Handling timer "check-buildbucket-build-status" (chromium-m155/chromeos-arm64-generic-rel:8835200984719933008:11:0)
[15:18:12.694] Build status: SCHEDULED
[15:18:12.694] Scheduling timer "check-buildbucket-build-status" (chromium-m155/chromeos-arm64-generic-rel:8835200984719933008:12:0) after 7m50s
[15:26:02.809] Handling timer "check-buildbucket-build-status" (chromium-m155/chromeos-arm64-generic-rel:8835200984719933008:12:0)
[15:26:02.844] Build status: SCHEDULED
[15:26:02.844] Scheduling timer "check-buildbucket-build-status" (chromium-m155/chromeos-arm64-generic-rel:8835200984719933008:13:0) after 7m36s
[15:33:38.874] Handling timer "check-buildbucket-build-status" (chromium-m155/chromeos-arm64-generic-rel:8835200984719933008:13:0)
[15:33:38.930] Build status: SCHEDULED
[15:33:38.930] Scheduling timer "check-buildbucket-build-status" (chromium-m155/chromeos-arm64-generic-rel:8835200984719933008:14:0) after 4m39s
[15:38:08.292] Received PubSub notification, asking Buildbucket for the build status
[15:38:08.331] Build status: STARTED
[15:38:17.948] Handling timer "check-buildbucket-build-status" (chromium-m155/chromeos-arm64-generic-rel:8835200984719933008:14:0)
[15:38:17.980] Build status: STARTED
[15:38:17.980] Scheduling timer "check-buildbucket-build-status" (chromium-m155/chromeos-arm64-generic-rel:8835200984719933008:16:0) after 7m10s
[15:45:28.010] Handling timer "check-buildbucket-build-status" (chromium-m155/chromeos-arm64-generic-rel:8835200984719933008:16:0)
[15:45:28.120] Build status: STARTED
[15:45:28.120] Scheduling timer "check-buildbucket-build-status" (chromium-m155/chromeos-arm64-generic-rel:8835200984719933008:17:0) after 6m51s
[15:52:19.190] Handling timer "check-buildbucket-build-status" (chromium-m155/chromeos-arm64-generic-rel:8835200984719933008:17:0)
[15:52:19.219] Build status: STARTED
[15:52:19.219] Scheduling timer "check-buildbucket-build-status" (chromium-m155/chromeos-arm64-generic-rel:8835200984719933008:18:0) after 8m5s
[16:00:24.234] Handling timer "check-buildbucket-build-status" (chromium-m155/chromeos-arm64-generic-rel:8835200984719933008:18:0)
[16:00:24.275] Build status: STARTED
[16:00:24.275] Scheduling timer "check-buildbucket-build-status" (chromium-m155/chromeos-arm64-generic-rel:8835200984719933008:19:0) after 9m21s
[16:09:45.585] Handling timer "check-buildbucket-build-status" (chromium-m155/chromeos-arm64-generic-rel:8835200984719933008:19:0)
[16:09:45.634] Build status: STARTED
[16:09:45.634] Scheduling timer "check-buildbucket-build-status" (chromium-m155/chromeos-arm64-generic-rel:8835200984719933008:20:0) after 1m21s
[16:11:06.654] Handling timer "check-buildbucket-build-status" (chromium-m155/chromeos-arm64-generic-rel:8835200984719933008:20:0)
[16:11:06.673] Build status: STARTED
[16:11:06.673] Scheduling timer "check-buildbucket-build-status" (chromium-m155/chromeos-arm64-generic-rel:8835200984719933008:21:0) after 5m46s
[16:16:52.747] Handling timer "check-buildbucket-build-status" (chromium-m155/chromeos-arm64-generic-rel:8835200984719933008:21:0)
[16:16:52.769] Build status: STARTED
[16:16:52.769] Scheduling timer "check-buildbucket-build-status" (chromium-m155/chromeos-arm64-generic-rel:8835200984719933008:22:0) after 4m29s
[16:21:21.787] Handling timer "check-buildbucket-build-status" (chromium-m155/chromeos-arm64-generic-rel:8835200984719933008:22:0)
[16:21:21.825] Build status: STARTED
[16:21:21.825] Scheduling timer "check-buildbucket-build-status" (chromium-m155/chromeos-arm64-generic-rel:8835200984719933008:23:0) after 8m19s
[16:29:40.842] Handling timer "check-buildbucket-build-status" (chromium-m155/chromeos-arm64-generic-rel:8835200984719933008:23:0)
[16:29:40.883] Build status: STARTED
[16:29:40.883] Scheduling timer "check-buildbucket-build-status" (chromium-m155/chromeos-arm64-generic-rel:8835200984719933008:24:0) after 6m3s
[16:35:43.855] Handling timer "check-buildbucket-build-status" (chromium-m155/chromeos-arm64-generic-rel:8835200984719933008:24:0)
[16:35:43.878] Build status: STARTED
[16:35:43.878] Scheduling timer "check-buildbucket-build-status" (chromium-m155/chromeos-arm64-generic-rel:8835200984719933008:25:0) after 9m58s
[16:45:41.967] Handling timer "check-buildbucket-build-status" (chromium-m155/chromeos-arm64-generic-rel:8835200984719933008:25:0)
[16:45:41.983] Build status: STARTED
[16:45:41.983] Scheduling timer "check-buildbucket-build-status" (chromium-m155/chromeos-arm64-generic-rel:8835200984719933008:26:0) after 7m54s
[16:53:36.119] Handling timer "check-buildbucket-build-status" (chromium-m155/chromeos-arm64-generic-rel:8835200984719933008:26:0)
[16:53:36.138] Build status: STARTED
[16:53:36.138] Scheduling timer "check-buildbucket-build-status" (chromium-m155/chromeos-arm64-generic-rel:8835200984719933008:27:0) after 4m25s
[16:58:01.347] Handling timer "check-buildbucket-build-status" (chromium-m155/chromeos-arm64-generic-rel:8835200984719933008:27:0)
[16:58:01.475] Build status: STARTED
[16:58:01.475] Scheduling timer "check-buildbucket-build-status" (chromium-m155/chromeos-arm64-generic-rel:8835200984719933008:28:0) after 5m24s
[17:03:25.575] Handling timer "check-buildbucket-build-status" (chromium-m155/chromeos-arm64-generic-rel:8835200984719933008:28:0)
[17:03:25.769] Build status: STARTED
[17:03:25.769] Scheduling timer "check-buildbucket-build-status" (chromium-m155/chromeos-arm64-generic-rel:8835200984719933008:29:0) after 8m56s
[17:12:21.934] Handling timer "check-buildbucket-build-status" (chromium-m155/chromeos-arm64-generic-rel:8835200984719933008:29:0)
[17:12:21.979] Build status: STARTED
[17:12:21.979] Scheduling timer "check-buildbucket-build-status" (chromium-m155/chromeos-arm64-generic-rel:8835200984719933008:30:0) after 6m3s
[17:18:25.002] Handling timer "check-buildbucket-build-status" (chromium-m155/chromeos-arm64-generic-rel:8835200984719933008:30:0)
[17:18:25.039] Build status: STARTED
[17:18:25.039] Scheduling timer "check-buildbucket-build-status" (chromium-m155/chromeos-arm64-generic-rel:8835200984719933008:31:0) after 3m1s
[17:21:26.096] Handling timer "check-buildbucket-build-status" (chromium-m155/chromeos-arm64-generic-rel:8835200984719933008:31:0)
[17:21:26.216] Build status: STARTED
[17:21:26.216] Scheduling timer "check-buildbucket-build-status" (chromium-m155/chromeos-arm64-generic-rel:8835200984719933008:32:0) after 6m42s
[17:28:08.234] Handling timer "check-buildbucket-build-status" (chromium-m155/chromeos-arm64-generic-rel:8835200984719933008:32:0)
[17:28:08.257] Build status: STARTED
[17:28:08.257] Scheduling timer "check-buildbucket-build-status" (chromium-m155/chromeos-arm64-generic-rel:8835200984719933008:33:0) after 4m35s
[17:32:43.300] Handling timer "check-buildbucket-build-status" (chromium-m155/chromeos-arm64-generic-rel:8835200984719933008:33:0)
[17:32:43.358] Build status: STARTED
[17:32:43.358] Scheduling timer "check-buildbucket-build-status" (chromium-m155/chromeos-arm64-generic-rel:8835200984719933008:34:0) after 3m34s
[17:36:17.595] Handling timer "check-buildbucket-build-status" (chromium-m155/chromeos-arm64-generic-rel:8835200984719933008:34:0)
[17:36:17.618] Build status: STARTED
[17:36:17.618] Scheduling timer "check-buildbucket-build-status" (chromium-m155/chromeos-arm64-generic-rel:8835200984719933008:35:0) after 2m40s
[17:38:57.634] Handling timer "check-buildbucket-build-status" (chromium-m155/chromeos-arm64-generic-rel:8835200984719933008:35:0)
[17:38:57.659] Build status: STARTED
[17:38:57.659] Scheduling timer "check-buildbucket-build-status" (chromium-m155/chromeos-arm64-generic-rel:8835200984719933008:36:0) after 4m49s
[17:42:52.545] Received PubSub notification, asking Buildbucket for the build status
[17:42:52.566] Build:
{
"id": "8669770921630669153",
"builder": {
"project": "chromium-m155",
"bucket": "ci",
"builder": "chromeos-arm64-generic-rel"
},
"number": 91,
"createdBy": "project:chromium-m155",
"createTime": "2026-09-24T14:12:45.123397688Z",
"startTime": "2026-09-24T15:38:08.092062136Z",
"endTime": "2026-09-24T17:42:52.207563700Z",
"updateTime": "2026-09-24T17:42:52.207563700Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "29a25d978c8256429c9c8aa0c741510fd41b1206",
"ref": "refs/branch-heads/8059"
}
}
}
[17:42:52.566] Invocation finished in 3h30m9.772981046s with status SUCCEEDED