[15:02:16.954] New invocation is queued and will start shortly
[15:02:18.230] Starting the invocation (attempt 1)
[15:02:18.257] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/46b3f8b793775ddb6e315c5dcfdd31ccc575af9b"
[15:02:18.257] Popped gitiles commit info from properties and tags
[15:02:18.257] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[15:02:18.258] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[15:02:18.258] Buildbucket request:
{
"requestId": "8837100402390842576",
"builder": {
"project": "chromium-m154",
"bucket": "ci",
"builder": "linux-arm64-official"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8837100402390842576",
"job": "chromium-m154/linux-arm64-official",
"triggers": [
{
"gitiles": {
"ref": "refs/branch-heads/8037",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "890e68bc1a3d1ff0d021caa458a123a1d03e9aec"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/8037@890e68bc1a3d1ff0d021caa458a123a1d03e9aec",
"title": "890e68bc1a3d1ff0d021caa458a123a1d03e9aec",
"url": "https://chromium.googlesource.com/chromium/src/+/890e68bc1a3d1ff0d021caa458a123a1d03e9aec"
},
{
"gitiles": {
"ref": "refs/branch-heads/8037",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "b8a483340bf34ac1e1dc45210a65007d2e8bb649"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/8037@b8a483340bf34ac1e1dc45210a65007d2e8bb649",
"title": "b8a483340bf34ac1e1dc45210a65007d2e8bb649",
"url": "https://chromium.googlesource.com/chromium/src/+/b8a483340bf34ac1e1dc45210a65007d2e8bb649"
},
{
"gitiles": {
"ref": "refs/branch-heads/8037",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "23df26bd0f5b5c9a2fcb6ad9096c5ab3ce74179c"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/8037@23df26bd0f5b5c9a2fcb6ad9096c5ab3ce74179c",
"title": "23df26bd0f5b5c9a2fcb6ad9096c5ab3ce74179c",
"url": "https://chromium.googlesource.com/chromium/src/+/23df26bd0f5b5c9a2fcb6ad9096c5ab3ce74179c"
},
{
"gitiles": {
"ref": "refs/branch-heads/8037",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "36e68c45a75d03e5c35ec175325107592eda02ed"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/8037@36e68c45a75d03e5c35ec175325107592eda02ed",
"title": "36e68c45a75d03e5c35ec175325107592eda02ed",
"url": "https://chromium.googlesource.com/chromium/src/+/36e68c45a75d03e5c35ec175325107592eda02ed"
},
{
"gitiles": {
"ref": "refs/branch-heads/8037",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "1ee6135a21845418e22141882e84c4c5fa42b003"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/8037@1ee6135a21845418e22141882e84c4c5fa42b003",
"title": "1ee6135a21845418e22141882e84c4c5fa42b003",
"url": "https://chromium.googlesource.com/chromium/src/+/1ee6135a21845418e22141882e84c4c5fa42b003"
},
{
"gitiles": {
"ref": "refs/branch-heads/8037",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "46b3f8b793775ddb6e315c5dcfdd31ccc575af9b"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/8037@46b3f8b793775ddb6e315c5dcfdd31ccc575af9b",
"title": "46b3f8b793775ddb6e315c5dcfdd31ccc575af9b",
"url": "https://chromium.googlesource.com/chromium/src/+/46b3f8b793775ddb6e315c5dcfdd31ccc575af9b"
}
]
}
},
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "46b3f8b793775ddb6e315c5dcfdd31ccc575af9b",
"ref": "refs/branch-heads/8037"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8837100402390842576"
},
{
"key": "scheduler_job_id",
"value": "chromium-m154/linux-arm64-official"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[15:02:18.850] Scheduled build:
{
"id": "8671670340273380273",
"builder": {
"project": "chromium-m154",
"bucket": "ci",
"builder": "linux-arm64-official"
},
"number": 30,
"createdBy": "project:chromium-m154",
"createTime": "2026-09-03T15:02:18.347842709Z",
"updateTime": "2026-09-03T15:02:18.347842709Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "46b3f8b793775ddb6e315c5dcfdd31ccc575af9b",
"ref": "refs/branch-heads/8037"
}
}
}
[15:02:18.850] Task URL: https://cr-buildbucket.appspot.com/build/8671670340273380273
[15:02:18.850] Scheduling timer "check-buildbucket-build-status" (chromium-m154/linux-arm64-official:8837100402390842576:2:0) after 9m53s
[15:02:20.881] Received PubSub notification, asking Buildbucket for the build status
[15:02:20.904] Build status: SCHEDULED
[15:02:40.755] Received PubSub notification, asking Buildbucket for the build status
[15:02:40.861] Build status: STARTED
[15:12:11.818] Handling timer "check-buildbucket-build-status" (chromium-m154/linux-arm64-official:8837100402390842576:2:0)
[15:12:11.842] Build status: STARTED
[15:12:11.843] Scheduling timer "check-buildbucket-build-status" (chromium-m154/linux-arm64-official:8837100402390842576:5:0) after 9m2s
[15:21:13.920] Handling timer "check-buildbucket-build-status" (chromium-m154/linux-arm64-official:8837100402390842576:5:0)
[15:21:13.942] Build status: STARTED
[15:21:13.942] Scheduling timer "check-buildbucket-build-status" (chromium-m154/linux-arm64-official:8837100402390842576:6:0) after 4m34s
[15:25:47.979] Handling timer "check-buildbucket-build-status" (chromium-m154/linux-arm64-official:8837100402390842576:6:0)
[15:25:48.006] Build status: STARTED
[15:25:48.006] Scheduling timer "check-buildbucket-build-status" (chromium-m154/linux-arm64-official:8837100402390842576:7:0) after 8m41s
[15:34:29.139] Handling timer "check-buildbucket-build-status" (chromium-m154/linux-arm64-official:8837100402390842576:7:0)
[15:34:29.218] Build status: STARTED
[15:34:29.218] Scheduling timer "check-buildbucket-build-status" (chromium-m154/linux-arm64-official:8837100402390842576:8:0) after 9m43s
[15:44:12.271] Handling timer "check-buildbucket-build-status" (chromium-m154/linux-arm64-official:8837100402390842576:8:0)
[15:44:12.292] Build status: STARTED
[15:44:12.292] Scheduling timer "check-buildbucket-build-status" (chromium-m154/linux-arm64-official:8837100402390842576:9:0) after 4m20s
[15:48:32.310] Handling timer "check-buildbucket-build-status" (chromium-m154/linux-arm64-official:8837100402390842576:9:0)
[15:48:32.329] Build status: STARTED
[15:48:32.329] Scheduling timer "check-buildbucket-build-status" (chromium-m154/linux-arm64-official:8837100402390842576:10:0) after 3m37s
[15:52:09.358] Handling timer "check-buildbucket-build-status" (chromium-m154/linux-arm64-official:8837100402390842576:10:0)
[15:52:09.528] Build status: STARTED
[15:52:09.528] Scheduling timer "check-buildbucket-build-status" (chromium-m154/linux-arm64-official:8837100402390842576:11:0) after 2m36s
[15:54:45.592] Handling timer "check-buildbucket-build-status" (chromium-m154/linux-arm64-official:8837100402390842576:11:0)
[15:54:45.682] Build status: STARTED
[15:54:45.682] Scheduling timer "check-buildbucket-build-status" (chromium-m154/linux-arm64-official:8837100402390842576:12:0) after 5m5s
[15:59:50.767] Handling timer "check-buildbucket-build-status" (chromium-m154/linux-arm64-official:8837100402390842576:12:0)
[15:59:50.796] Build status: STARTED
[15:59:50.796] Scheduling timer "check-buildbucket-build-status" (chromium-m154/linux-arm64-official:8837100402390842576:13:0) after 1m33s
[16:01:23.822] Handling timer "check-buildbucket-build-status" (chromium-m154/linux-arm64-official:8837100402390842576:13:0)
[16:01:23.843] Build status: STARTED
[16:01:23.843] Scheduling timer "check-buildbucket-build-status" (chromium-m154/linux-arm64-official:8837100402390842576:14:0) after 2m15s
[16:03:38.892] Handling timer "check-buildbucket-build-status" (chromium-m154/linux-arm64-official:8837100402390842576:14:0)
[16:03:38.932] Build status: STARTED
[16:03:38.932] Scheduling timer "check-buildbucket-build-status" (chromium-m154/linux-arm64-official:8837100402390842576:15:0) after 6m27s
[16:10:05.950] Handling timer "check-buildbucket-build-status" (chromium-m154/linux-arm64-official:8837100402390842576:15:0)
[16:10:05.976] Build status: STARTED
[16:10:05.977] Scheduling timer "check-buildbucket-build-status" (chromium-m154/linux-arm64-official:8837100402390842576:16:0) after 6m46s
[16:16:52.007] Handling timer "check-buildbucket-build-status" (chromium-m154/linux-arm64-official:8837100402390842576:16:0)
[16:16:52.025] Build status: STARTED
[16:16:52.025] Scheduling timer "check-buildbucket-build-status" (chromium-m154/linux-arm64-official:8837100402390842576:17:0) after 4m41s
[16:21:33.110] Handling timer "check-buildbucket-build-status" (chromium-m154/linux-arm64-official:8837100402390842576:17:0)
[16:21:33.126] Build status: STARTED
[16:21:33.126] Scheduling timer "check-buildbucket-build-status" (chromium-m154/linux-arm64-official:8837100402390842576:18:0) after 8m32s
[16:30:05.252] Handling timer "check-buildbucket-build-status" (chromium-m154/linux-arm64-official:8837100402390842576:18:0)
[16:30:05.281] Build status: STARTED
[16:30:05.281] Scheduling timer "check-buildbucket-build-status" (chromium-m154/linux-arm64-official:8837100402390842576:19:0) after 4m59s
[16:35:04.277] Handling timer "check-buildbucket-build-status" (chromium-m154/linux-arm64-official:8837100402390842576:19:0)
[16:35:04.304] Build status: STARTED
[16:35:04.304] Scheduling timer "check-buildbucket-build-status" (chromium-m154/linux-arm64-official:8837100402390842576:20:0) after 6m33s
[16:41:37.324] Handling timer "check-buildbucket-build-status" (chromium-m154/linux-arm64-official:8837100402390842576:20:0)
[16:41:37.341] Build status: STARTED
[16:41:37.341] Scheduling timer "check-buildbucket-build-status" (chromium-m154/linux-arm64-official:8837100402390842576:21:0) after 6m31s
[16:48:08.387] Handling timer "check-buildbucket-build-status" (chromium-m154/linux-arm64-official:8837100402390842576:21:0)
[16:48:08.420] Build status: STARTED
[16:48:08.421] Scheduling timer "check-buildbucket-build-status" (chromium-m154/linux-arm64-official:8837100402390842576:22:0) after 1m44s
[16:49:52.536] Handling timer "check-buildbucket-build-status" (chromium-m154/linux-arm64-official:8837100402390842576:22:0)
[16:49:52.557] Build status: STARTED
[16:49:52.557] Scheduling timer "check-buildbucket-build-status" (chromium-m154/linux-arm64-official:8837100402390842576:23:0) after 4m36s
[16:54:28.625] Handling timer "check-buildbucket-build-status" (chromium-m154/linux-arm64-official:8837100402390842576:23:0)
[16:54:28.693] Build status: STARTED
[16:54:28.694] Scheduling timer "check-buildbucket-build-status" (chromium-m154/linux-arm64-official:8837100402390842576:24:0) after 9m20s
[17:03:48.812] Handling timer "check-buildbucket-build-status" (chromium-m154/linux-arm64-official:8837100402390842576:24:0)
[17:03:48.894] Build status: STARTED
[17:03:48.894] Scheduling timer "check-buildbucket-build-status" (chromium-m154/linux-arm64-official:8837100402390842576:25:0) after 8m22s
[17:12:10.901] Handling timer "check-buildbucket-build-status" (chromium-m154/linux-arm64-official:8837100402390842576:25:0)
[17:12:10.951] Build status: STARTED
[17:12:10.951] Scheduling timer "check-buildbucket-build-status" (chromium-m154/linux-arm64-official:8837100402390842576:26:0) after 3m46s
[17:15:57.109] Handling timer "check-buildbucket-build-status" (chromium-m154/linux-arm64-official:8837100402390842576:26:0)
[17:15:57.219] Build status: STARTED
[17:15:57.219] Scheduling timer "check-buildbucket-build-status" (chromium-m154/linux-arm64-official:8837100402390842576:27:0) after 7m30s
[17:23:27.236] Handling timer "check-buildbucket-build-status" (chromium-m154/linux-arm64-official:8837100402390842576:27:0)
[17:23:27.267] Build status: STARTED
[17:23:27.267] Scheduling timer "check-buildbucket-build-status" (chromium-m154/linux-arm64-official:8837100402390842576:28:0) after 9m24s
[17:32:51.324] Handling timer "check-buildbucket-build-status" (chromium-m154/linux-arm64-official:8837100402390842576:28:0)
[17:32:51.375] Build status: STARTED
[17:32:51.375] Scheduling timer "check-buildbucket-build-status" (chromium-m154/linux-arm64-official:8837100402390842576:29:0) after 9m21s
[17:42:12.481] Handling timer "check-buildbucket-build-status" (chromium-m154/linux-arm64-official:8837100402390842576:29:0)
[17:42:12.507] Build status: STARTED
[17:42:12.507] Scheduling timer "check-buildbucket-build-status" (chromium-m154/linux-arm64-official:8837100402390842576:30:0) after 6m50s
[17:49:02.572] Handling timer "check-buildbucket-build-status" (chromium-m154/linux-arm64-official:8837100402390842576:30:0)
[17:49:02.599] Build status: STARTED
[17:49:02.599] Scheduling timer "check-buildbucket-build-status" (chromium-m154/linux-arm64-official:8837100402390842576:31:0) after 5m48s
[17:54:50.598] Handling timer "check-buildbucket-build-status" (chromium-m154/linux-arm64-official:8837100402390842576:31:0)
[17:54:50.623] Build status: STARTED
[17:54:50.623] Scheduling timer "check-buildbucket-build-status" (chromium-m154/linux-arm64-official:8837100402390842576:32:0) after 5m54s
[18:00:44.630] Handling timer "check-buildbucket-build-status" (chromium-m154/linux-arm64-official:8837100402390842576:32:0)
[18:00:44.656] Build status: STARTED
[18:00:44.656] Scheduling timer "check-buildbucket-build-status" (chromium-m154/linux-arm64-official:8837100402390842576:33:0) after 9m46s
[18:10:30.706] Handling timer "check-buildbucket-build-status" (chromium-m154/linux-arm64-official:8837100402390842576:33:0)
[18:10:30.732] Build status: STARTED
[18:10:30.732] Scheduling timer "check-buildbucket-build-status" (chromium-m154/linux-arm64-official:8837100402390842576:34:0) after 7m57s
[18:18:27.809] Handling timer "check-buildbucket-build-status" (chromium-m154/linux-arm64-official:8837100402390842576:34:0)
[18:18:27.836] Build status: STARTED
[18:18:27.836] Scheduling timer "check-buildbucket-build-status" (chromium-m154/linux-arm64-official:8837100402390842576:35:0) after 2m5s
[18:20:32.857] Handling timer "check-buildbucket-build-status" (chromium-m154/linux-arm64-official:8837100402390842576:35:0)
[18:20:32.885] Build status: STARTED
[18:20:32.885] Scheduling timer "check-buildbucket-build-status" (chromium-m154/linux-arm64-official:8837100402390842576:36:0) after 8m1s
[18:22:03.811] Received PubSub notification, asking Buildbucket for the build status
[18:22:03.843] Build:
{
"id": "8671670340273380273",
"builder": {
"project": "chromium-m154",
"bucket": "ci",
"builder": "linux-arm64-official"
},
"number": 30,
"createdBy": "project:chromium-m154",
"createTime": "2026-09-03T15:02:18.347842709Z",
"startTime": "2026-09-03T15:02:39.043353974Z",
"endTime": "2026-09-03T18:22:03.129280893Z",
"updateTime": "2026-09-03T18:22:03.129280893Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "46b3f8b793775ddb6e315c5dcfdd31ccc575af9b",
"ref": "refs/branch-heads/8037"
}
}
}
[18:22:03.843] Invocation finished in 3h19m46.899001603s with status SUCCEEDED