[15:14:34.528] New invocation is queued and will start shortly
[15:14:35.622] Starting the invocation (attempt 1)
[15:14:35.651] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/f2e40b7e3ea43ac708ca558a582d8cb3f3ea8822"
[15:14:35.651] Popped gitiles commit info from properties and tags
[15:14:35.651] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[15:14:35.651] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[15:14:35.651] Buildbucket request:
{
"requestId": "8837552613817016880",
"builder": {
"project": "chromium-m153",
"bucket": "ci",
"builder": "linux-arm64-official"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8837552613817016880",
"job": "chromium-m153/linux-arm64-official",
"triggers": [
{
"gitiles": {
"ref": "refs/branch-heads/8010",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "1d4bb224dde4d53541f5b96733d5de8d414bebb7"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/8010@1d4bb224dde4d53541f5b96733d5de8d414bebb7",
"title": "1d4bb224dde4d53541f5b96733d5de8d414bebb7",
"url": "https://chromium.googlesource.com/chromium/src/+/1d4bb224dde4d53541f5b96733d5de8d414bebb7"
},
{
"gitiles": {
"ref": "refs/branch-heads/8010",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "0f1ab7e97feca123d48ff3114850071912ca493a"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/8010@0f1ab7e97feca123d48ff3114850071912ca493a",
"title": "0f1ab7e97feca123d48ff3114850071912ca493a",
"url": "https://chromium.googlesource.com/chromium/src/+/0f1ab7e97feca123d48ff3114850071912ca493a"
},
{
"gitiles": {
"ref": "refs/branch-heads/8010",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "c9f25f9e725d20d169389c62cbc48686e0b99593"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/8010@c9f25f9e725d20d169389c62cbc48686e0b99593",
"title": "c9f25f9e725d20d169389c62cbc48686e0b99593",
"url": "https://chromium.googlesource.com/chromium/src/+/c9f25f9e725d20d169389c62cbc48686e0b99593"
},
{
"gitiles": {
"ref": "refs/branch-heads/8010",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "f2e40b7e3ea43ac708ca558a582d8cb3f3ea8822"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/8010@f2e40b7e3ea43ac708ca558a582d8cb3f3ea8822",
"title": "f2e40b7e3ea43ac708ca558a582d8cb3f3ea8822",
"url": "https://chromium.googlesource.com/chromium/src/+/f2e40b7e3ea43ac708ca558a582d8cb3f3ea8822"
}
]
}
},
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "f2e40b7e3ea43ac708ca558a582d8cb3f3ea8822",
"ref": "refs/branch-heads/8010"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8837552613817016880"
},
{
"key": "scheduler_job_id",
"value": "chromium-m153/linux-arm64-official"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[15:14:36.189] Scheduled build:
{
"id": "8672122551900589233",
"builder": {
"project": "chromium-m153",
"bucket": "ci",
"builder": "linux-arm64-official"
},
"number": 124,
"createdBy": "project:chromium-m153",
"createTime": "2026-08-29T15:14:35.732098687Z",
"updateTime": "2026-08-29T15:14:35.732098687Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "f2e40b7e3ea43ac708ca558a582d8cb3f3ea8822",
"ref": "refs/branch-heads/8010"
}
}
}
[15:14:36.189] Task URL: https://cr-buildbucket.appspot.com/build/8672122551900589233
[15:14:36.189] Scheduling timer "check-buildbucket-build-status" (chromium-m153/linux-arm64-official:8837552613817016880:2:0) after 3m16s
[15:14:36.919] Received PubSub notification, asking Buildbucket for the build status
[15:14:36.946] Build status: SCHEDULED
[15:14:41.038] Received PubSub notification, asking Buildbucket for the build status
[15:14:41.063] Build status: STARTED
[15:17:52.270] Handling timer "check-buildbucket-build-status" (chromium-m153/linux-arm64-official:8837552613817016880:2:0)
[15:17:52.297] Build status: STARTED
[15:17:52.297] Scheduling timer "check-buildbucket-build-status" (chromium-m153/linux-arm64-official:8837552613817016880:5:0) after 7m5s
[15:24:57.344] Handling timer "check-buildbucket-build-status" (chromium-m153/linux-arm64-official:8837552613817016880:5:0)
[15:24:57.371] Build status: STARTED
[15:24:57.371] Scheduling timer "check-buildbucket-build-status" (chromium-m153/linux-arm64-official:8837552613817016880:6:0) after 7m36s
[15:32:33.408] Handling timer "check-buildbucket-build-status" (chromium-m153/linux-arm64-official:8837552613817016880:6:0)
[15:32:33.429] Build status: STARTED
[15:32:33.429] Scheduling timer "check-buildbucket-build-status" (chromium-m153/linux-arm64-official:8837552613817016880:7:0) after 1m9s
[15:33:42.474] Handling timer "check-buildbucket-build-status" (chromium-m153/linux-arm64-official:8837552613817016880:7:0)
[15:33:42.499] Build status: STARTED
[15:33:42.499] Scheduling timer "check-buildbucket-build-status" (chromium-m153/linux-arm64-official:8837552613817016880:8:0) after 9m47s
[15:43:29.568] Handling timer "check-buildbucket-build-status" (chromium-m153/linux-arm64-official:8837552613817016880:8:0)
[15:43:29.586] Build status: STARTED
[15:43:29.586] Scheduling timer "check-buildbucket-build-status" (chromium-m153/linux-arm64-official:8837552613817016880:9:0) after 6m3s
[15:49:32.699] Handling timer "check-buildbucket-build-status" (chromium-m153/linux-arm64-official:8837552613817016880:9:0)
[15:49:32.723] Build status: STARTED
[15:49:32.723] Scheduling timer "check-buildbucket-build-status" (chromium-m153/linux-arm64-official:8837552613817016880:10:0) after 1m18s
[15:50:50.815] Handling timer "check-buildbucket-build-status" (chromium-m153/linux-arm64-official:8837552613817016880:10:0)
[15:50:50.859] Build status: STARTED
[15:50:50.859] Scheduling timer "check-buildbucket-build-status" (chromium-m153/linux-arm64-official:8837552613817016880:11:0) after 2m40s
[15:53:30.873] Handling timer "check-buildbucket-build-status" (chromium-m153/linux-arm64-official:8837552613817016880:11:0)
[15:53:30.897] Build status: STARTED
[15:53:30.897] Scheduling timer "check-buildbucket-build-status" (chromium-m153/linux-arm64-official:8837552613817016880:12:0) after 4m26s
[15:57:56.982] Handling timer "check-buildbucket-build-status" (chromium-m153/linux-arm64-official:8837552613817016880:12:0)
[15:57:57.010] Build status: STARTED
[15:57:57.010] Scheduling timer "check-buildbucket-build-status" (chromium-m153/linux-arm64-official:8837552613817016880:13:0) after 8m52s
[16:06:48.987] Handling timer "check-buildbucket-build-status" (chromium-m153/linux-arm64-official:8837552613817016880:13:0)
[16:06:49.012] Build status: STARTED
[16:06:49.012] Scheduling timer "check-buildbucket-build-status" (chromium-m153/linux-arm64-official:8837552613817016880:14:0) after 4m58s
[16:11:47.277] Handling timer "check-buildbucket-build-status" (chromium-m153/linux-arm64-official:8837552613817016880:14:0)
[16:11:47.315] Build status: STARTED
[16:11:47.315] Scheduling timer "check-buildbucket-build-status" (chromium-m153/linux-arm64-official:8837552613817016880:15:0) after 3m42s
[16:15:29.324] Handling timer "check-buildbucket-build-status" (chromium-m153/linux-arm64-official:8837552613817016880:15:0)
[16:15:29.344] Build status: STARTED
[16:15:29.344] Scheduling timer "check-buildbucket-build-status" (chromium-m153/linux-arm64-official:8837552613817016880:16:0) after 9m4s
[16:24:33.388] Handling timer "check-buildbucket-build-status" (chromium-m153/linux-arm64-official:8837552613817016880:16:0)
[16:24:33.422] Build status: STARTED
[16:24:33.422] Scheduling timer "check-buildbucket-build-status" (chromium-m153/linux-arm64-official:8837552613817016880:17:0) after 1m58s
[16:26:31.777] Handling timer "check-buildbucket-build-status" (chromium-m153/linux-arm64-official:8837552613817016880:17:0)
[16:26:31.801] Build status: STARTED
[16:26:31.801] Scheduling timer "check-buildbucket-build-status" (chromium-m153/linux-arm64-official:8837552613817016880:18:0) after 2m20s
[16:28:51.791] Handling timer "check-buildbucket-build-status" (chromium-m153/linux-arm64-official:8837552613817016880:18:0)
[16:28:51.811] Build status: STARTED
[16:28:51.811] Scheduling timer "check-buildbucket-build-status" (chromium-m153/linux-arm64-official:8837552613817016880:19:0) after 7m28s
[16:36:19.815] Handling timer "check-buildbucket-build-status" (chromium-m153/linux-arm64-official:8837552613817016880:19:0)
[16:36:19.886] Build status: STARTED
[16:36:19.886] Scheduling timer "check-buildbucket-build-status" (chromium-m153/linux-arm64-official:8837552613817016880:20:0) after 4m36s
[16:40:56.032] Handling timer "check-buildbucket-build-status" (chromium-m153/linux-arm64-official:8837552613817016880:20:0)
[16:40:56.052] Build status: STARTED
[16:40:56.052] Scheduling timer "check-buildbucket-build-status" (chromium-m153/linux-arm64-official:8837552613817016880:21:0) after 7m8s
[16:48:04.075] Handling timer "check-buildbucket-build-status" (chromium-m153/linux-arm64-official:8837552613817016880:21:0)
[16:48:04.100] Build status: STARTED
[16:48:04.100] Scheduling timer "check-buildbucket-build-status" (chromium-m153/linux-arm64-official:8837552613817016880:22:0) after 9m16s
[16:57:20.131] Handling timer "check-buildbucket-build-status" (chromium-m153/linux-arm64-official:8837552613817016880:22:0)
[16:57:20.150] Build status: STARTED
[16:57:20.151] Scheduling timer "check-buildbucket-build-status" (chromium-m153/linux-arm64-official:8837552613817016880:23:0) after 5m13s
[17:02:33.165] Handling timer "check-buildbucket-build-status" (chromium-m153/linux-arm64-official:8837552613817016880:23:0)
[17:02:33.187] Build status: STARTED
[17:02:33.187] Scheduling timer "check-buildbucket-build-status" (chromium-m153/linux-arm64-official:8837552613817016880:24:0) after 1m12s
[17:03:45.371] Handling timer "check-buildbucket-build-status" (chromium-m153/linux-arm64-official:8837552613817016880:24:0)
[17:03:45.408] Build status: STARTED
[17:03:45.408] Scheduling timer "check-buildbucket-build-status" (chromium-m153/linux-arm64-official:8837552613817016880:25:0) after 9m53s
[17:13:38.422] Handling timer "check-buildbucket-build-status" (chromium-m153/linux-arm64-official:8837552613817016880:25:0)
[17:13:38.441] Build status: STARTED
[17:13:38.441] Scheduling timer "check-buildbucket-build-status" (chromium-m153/linux-arm64-official:8837552613817016880:26:0) after 3m55s
[17:17:33.476] Handling timer "check-buildbucket-build-status" (chromium-m153/linux-arm64-official:8837552613817016880:26:0)
[17:17:33.645] Build status: STARTED
[17:17:33.645] Scheduling timer "check-buildbucket-build-status" (chromium-m153/linux-arm64-official:8837552613817016880:27:0) after 8m57s
[17:26:30.713] Handling timer "check-buildbucket-build-status" (chromium-m153/linux-arm64-official:8837552613817016880:27:0)
[17:26:30.738] Build status: STARTED
[17:26:30.738] Scheduling timer "check-buildbucket-build-status" (chromium-m153/linux-arm64-official:8837552613817016880:28:0) after 5m50s
[17:32:20.724] Handling timer "check-buildbucket-build-status" (chromium-m153/linux-arm64-official:8837552613817016880:28:0)
[17:32:20.742] Build status: STARTED
[17:32:20.743] Scheduling timer "check-buildbucket-build-status" (chromium-m153/linux-arm64-official:8837552613817016880:29:0) after 9m59s
[17:42:19.798] Handling timer "check-buildbucket-build-status" (chromium-m153/linux-arm64-official:8837552613817016880:29:0)
[17:42:19.839] Build status: STARTED
[17:42:19.839] Scheduling timer "check-buildbucket-build-status" (chromium-m153/linux-arm64-official:8837552613817016880:30:0) after 1m14s
[17:43:33.838] Handling timer "check-buildbucket-build-status" (chromium-m153/linux-arm64-official:8837552613817016880:30:0)
[17:43:33.907] Build status: STARTED
[17:43:33.907] Scheduling timer "check-buildbucket-build-status" (chromium-m153/linux-arm64-official:8837552613817016880:31:0) after 5m40s
[17:49:13.924] Handling timer "check-buildbucket-build-status" (chromium-m153/linux-arm64-official:8837552613817016880:31:0)
[17:49:13.944] Build status: STARTED
[17:49:13.944] Scheduling timer "check-buildbucket-build-status" (chromium-m153/linux-arm64-official:8837552613817016880:32:0) after 1m17s
[17:50:31.001] Handling timer "check-buildbucket-build-status" (chromium-m153/linux-arm64-official:8837552613817016880:32:0)
[17:50:31.022] Build status: STARTED
[17:50:31.022] Scheduling timer "check-buildbucket-build-status" (chromium-m153/linux-arm64-official:8837552613817016880:33:0) after 7m52s
[17:58:23.037] Handling timer "check-buildbucket-build-status" (chromium-m153/linux-arm64-official:8837552613817016880:33:0)
[17:58:23.056] Build status: STARTED
[17:58:23.056] Scheduling timer "check-buildbucket-build-status" (chromium-m153/linux-arm64-official:8837552613817016880:34:0) after 2m7s
[18:00:30.071] Handling timer "check-buildbucket-build-status" (chromium-m153/linux-arm64-official:8837552613817016880:34:0)
[18:00:30.097] Build status: STARTED
[18:00:30.097] Scheduling timer "check-buildbucket-build-status" (chromium-m153/linux-arm64-official:8837552613817016880:35:0) after 1m27s
[18:01:57.377] Handling timer "check-buildbucket-build-status" (chromium-m153/linux-arm64-official:8837552613817016880:35:0)
[18:01:57.401] Build status: STARTED
[18:01:57.401] Scheduling timer "check-buildbucket-build-status" (chromium-m153/linux-arm64-official:8837552613817016880:36:0) after 2m20s
[18:04:17.405] Handling timer "check-buildbucket-build-status" (chromium-m153/linux-arm64-official:8837552613817016880:36:0)
[18:04:17.431] Build status: STARTED
[18:04:17.431] Scheduling timer "check-buildbucket-build-status" (chromium-m153/linux-arm64-official:8837552613817016880:37:0) after 8m46s
[18:13:03.423] Handling timer "check-buildbucket-build-status" (chromium-m153/linux-arm64-official:8837552613817016880:37:0)
[18:13:03.460] Build status: STARTED
[18:13:03.460] Scheduling timer "check-buildbucket-build-status" (chromium-m153/linux-arm64-official:8837552613817016880:38:0) after 6m44s
[18:19:47.475] Handling timer "check-buildbucket-build-status" (chromium-m153/linux-arm64-official:8837552613817016880:38:0)
[18:19:47.492] Build status: STARTED
[18:19:47.492] Scheduling timer "check-buildbucket-build-status" (chromium-m153/linux-arm64-official:8837552613817016880:39:0) after 1m45s
[18:21:23.853] Received PubSub notification, asking Buildbucket for the build status
[18:21:23.880] Build:
{
"id": "8672122551900589233",
"builder": {
"project": "chromium-m153",
"bucket": "ci",
"builder": "linux-arm64-official"
},
"number": 124,
"createdBy": "project:chromium-m153",
"createTime": "2026-08-29T15:14:35.732098687Z",
"startTime": "2026-08-29T15:14:40.838841733Z",
"endTime": "2026-08-29T18:21:23.552465447Z",
"updateTime": "2026-08-29T18:21:23.552465447Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "f2e40b7e3ea43ac708ca558a582d8cb3f3ea8822",
"ref": "refs/branch-heads/8010"
}
}
}
[18:21:23.880] Invocation finished in 3h6m49.359042213s with status SUCCEEDED