[14:10:15.107] New invocation is queued and will start shortly
[14:10:19.557] Starting the invocation (attempt 1)
[14:10:19.586] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/90bcd709238a22e936d68c8dea2456aa6475b863"
[14:10:19.586] Popped gitiles commit info from properties and tags
[14:10:19.586] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[14:10:19.586] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[14:10:19.587] Buildbucket request:
{
"requestId": "8840365166672031968",
"builder": {
"project": "chromium-m152",
"bucket": "ci",
"builder": "fuchsia-x64-cast-receiver-dbg"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8840365166672031968",
"job": "chromium-m152/fuchsia-x64-cast-receiver-dbg",
"triggers": [
{
"gitiles": {
"ref": "refs/branch-heads/7977",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "967979fe9f7e9edc109280134a9472b3abd68ba1"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7977@967979fe9f7e9edc109280134a9472b3abd68ba1",
"title": "967979fe9f7e9edc109280134a9472b3abd68ba1",
"url": "https://chromium.googlesource.com/chromium/src/+/967979fe9f7e9edc109280134a9472b3abd68ba1"
},
{
"gitiles": {
"ref": "refs/branch-heads/7977",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "a4be4cb3fa6f745dc213a5905d023e2fcff86cba"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7977@a4be4cb3fa6f745dc213a5905d023e2fcff86cba",
"title": "a4be4cb3fa6f745dc213a5905d023e2fcff86cba",
"url": "https://chromium.googlesource.com/chromium/src/+/a4be4cb3fa6f745dc213a5905d023e2fcff86cba"
},
{
"gitiles": {
"ref": "refs/branch-heads/7977",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "80f8f0042c4995ac82d0b2902b393894edd46e0d"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7977@80f8f0042c4995ac82d0b2902b393894edd46e0d",
"title": "80f8f0042c4995ac82d0b2902b393894edd46e0d",
"url": "https://chromium.googlesource.com/chromium/src/+/80f8f0042c4995ac82d0b2902b393894edd46e0d"
},
{
"gitiles": {
"ref": "refs/branch-heads/7977",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "8fac7eb78da93c69d8dc8395f4702ab54d3cf14c"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7977@8fac7eb78da93c69d8dc8395f4702ab54d3cf14c",
"title": "8fac7eb78da93c69d8dc8395f4702ab54d3cf14c",
"url": "https://chromium.googlesource.com/chromium/src/+/8fac7eb78da93c69d8dc8395f4702ab54d3cf14c"
},
{
"gitiles": {
"ref": "refs/branch-heads/7977",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "3b362b5f5805d09c13e457cd532bf45e116ecf68"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7977@3b362b5f5805d09c13e457cd532bf45e116ecf68",
"title": "3b362b5f5805d09c13e457cd532bf45e116ecf68",
"url": "https://chromium.googlesource.com/chromium/src/+/3b362b5f5805d09c13e457cd532bf45e116ecf68"
},
{
"gitiles": {
"ref": "refs/branch-heads/7977",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "90bcd709238a22e936d68c8dea2456aa6475b863"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7977@90bcd709238a22e936d68c8dea2456aa6475b863",
"title": "90bcd709238a22e936d68c8dea2456aa6475b863",
"url": "https://chromium.googlesource.com/chromium/src/+/90bcd709238a22e936d68c8dea2456aa6475b863"
}
]
}
},
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "90bcd709238a22e936d68c8dea2456aa6475b863",
"ref": "refs/branch-heads/7977"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8840365166672031968"
},
{
"key": "scheduler_job_id",
"value": "chromium-m152/fuchsia-x64-cast-receiver-dbg"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[14:10:20.326] Scheduled build:
{
"id": "8674935101212009073",
"builder": {
"project": "chromium-m152",
"bucket": "ci",
"builder": "fuchsia-x64-cast-receiver-dbg"
},
"number": 12,
"createdBy": "project:chromium-m152",
"createTime": "2026-07-29T14:10:19.691709412Z",
"updateTime": "2026-07-29T14:10:19.691709412Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "90bcd709238a22e936d68c8dea2456aa6475b863",
"ref": "refs/branch-heads/7977"
}
}
}
[14:10:20.326] Task URL: https://cr-buildbucket.appspot.com/build/8674935101212009073
[14:10:20.326] Scheduling timer "check-buildbucket-build-status" (chromium-m152/fuchsia-x64-cast-receiver-dbg:8840365166672031968:2:0) after 5m15s
[14:10:21.204] Received PubSub notification, asking Buildbucket for the build status
[14:10:21.341] Build status: SCHEDULED
[14:15:35.385] Handling timer "check-buildbucket-build-status" (chromium-m152/fuchsia-x64-cast-receiver-dbg:8840365166672031968:2:0)
[14:15:35.411] Build status: SCHEDULED
[14:15:35.411] Scheduling timer "check-buildbucket-build-status" (chromium-m152/fuchsia-x64-cast-receiver-dbg:8840365166672031968:4:0) after 7m5s
[14:22:40.474] Handling timer "check-buildbucket-build-status" (chromium-m152/fuchsia-x64-cast-receiver-dbg:8840365166672031968:4:0)
[14:22:40.502] Build status: SCHEDULED
[14:22:40.502] Scheduling timer "check-buildbucket-build-status" (chromium-m152/fuchsia-x64-cast-receiver-dbg:8840365166672031968:5:0) after 6m6s
[14:28:46.536] Handling timer "check-buildbucket-build-status" (chromium-m152/fuchsia-x64-cast-receiver-dbg:8840365166672031968:5:0)
[14:28:46.563] Build status: SCHEDULED
[14:28:46.563] Scheduling timer "check-buildbucket-build-status" (chromium-m152/fuchsia-x64-cast-receiver-dbg:8840365166672031968:6:0) after 7m19s
[14:36:05.601] Handling timer "check-buildbucket-build-status" (chromium-m152/fuchsia-x64-cast-receiver-dbg:8840365166672031968:6:0)
[14:36:05.623] Build status: SCHEDULED
[14:36:05.623] Scheduling timer "check-buildbucket-build-status" (chromium-m152/fuchsia-x64-cast-receiver-dbg:8840365166672031968:7:0) after 8m16s
[14:44:21.757] Handling timer "check-buildbucket-build-status" (chromium-m152/fuchsia-x64-cast-receiver-dbg:8840365166672031968:7:0)
[14:44:21.775] Build status: SCHEDULED
[14:44:21.775] Scheduling timer "check-buildbucket-build-status" (chromium-m152/fuchsia-x64-cast-receiver-dbg:8840365166672031968:8:0) after 7m27s
[14:45:09.791] Received PubSub notification, asking Buildbucket for the build status
[14:45:09.816] Build status: STARTED
[14:51:48.791] Handling timer "check-buildbucket-build-status" (chromium-m152/fuchsia-x64-cast-receiver-dbg:8840365166672031968:8:0)
[14:51:48.823] Build status: STARTED
[14:51:48.823] Scheduling timer "check-buildbucket-build-status" (chromium-m152/fuchsia-x64-cast-receiver-dbg:8840365166672031968:10:0) after 3m28s
[14:55:16.794] Handling timer "check-buildbucket-build-status" (chromium-m152/fuchsia-x64-cast-receiver-dbg:8840365166672031968:10:0)
[14:55:16.813] Build status: STARTED
[14:55:16.813] Scheduling timer "check-buildbucket-build-status" (chromium-m152/fuchsia-x64-cast-receiver-dbg:8840365166672031968:11:0) after 7m24s
[15:02:40.927] Handling timer "check-buildbucket-build-status" (chromium-m152/fuchsia-x64-cast-receiver-dbg:8840365166672031968:11:0)
[15:02:40.953] Build status: STARTED
[15:02:40.953] Scheduling timer "check-buildbucket-build-status" (chromium-m152/fuchsia-x64-cast-receiver-dbg:8840365166672031968:12:0) after 2m15s
[15:04:56.029] Handling timer "check-buildbucket-build-status" (chromium-m152/fuchsia-x64-cast-receiver-dbg:8840365166672031968:12:0)
[15:04:56.047] Build status: STARTED
[15:04:56.047] Scheduling timer "check-buildbucket-build-status" (chromium-m152/fuchsia-x64-cast-receiver-dbg:8840365166672031968:13:0) after 9m15s
[15:14:11.117] Handling timer "check-buildbucket-build-status" (chromium-m152/fuchsia-x64-cast-receiver-dbg:8840365166672031968:13:0)
[15:14:11.172] Build status: STARTED
[15:14:11.172] Scheduling timer "check-buildbucket-build-status" (chromium-m152/fuchsia-x64-cast-receiver-dbg:8840365166672031968:14:0) after 2m7s
[15:16:18.237] Handling timer "check-buildbucket-build-status" (chromium-m152/fuchsia-x64-cast-receiver-dbg:8840365166672031968:14:0)
[15:16:18.307] Build status: STARTED
[15:16:18.307] Scheduling timer "check-buildbucket-build-status" (chromium-m152/fuchsia-x64-cast-receiver-dbg:8840365166672031968:15:0) after 3m5s
[15:19:23.374] Handling timer "check-buildbucket-build-status" (chromium-m152/fuchsia-x64-cast-receiver-dbg:8840365166672031968:15:0)
[15:19:23.396] Build status: STARTED
[15:19:23.396] Scheduling timer "check-buildbucket-build-status" (chromium-m152/fuchsia-x64-cast-receiver-dbg:8840365166672031968:16:0) after 1m54s
[15:21:17.430] Handling timer "check-buildbucket-build-status" (chromium-m152/fuchsia-x64-cast-receiver-dbg:8840365166672031968:16:0)
[15:21:17.612] Build status: STARTED
[15:21:17.612] Scheduling timer "check-buildbucket-build-status" (chromium-m152/fuchsia-x64-cast-receiver-dbg:8840365166672031968:17:0) after 1m1s
[15:22:18.681] Handling timer "check-buildbucket-build-status" (chromium-m152/fuchsia-x64-cast-receiver-dbg:8840365166672031968:17:0)
[15:22:18.708] Build status: STARTED
[15:22:18.708] Scheduling timer "check-buildbucket-build-status" (chromium-m152/fuchsia-x64-cast-receiver-dbg:8840365166672031968:18:0) after 5m51s
[15:28:09.842] Handling timer "check-buildbucket-build-status" (chromium-m152/fuchsia-x64-cast-receiver-dbg:8840365166672031968:18:0)
[15:28:09.870] Build status: STARTED
[15:28:09.870] Scheduling timer "check-buildbucket-build-status" (chromium-m152/fuchsia-x64-cast-receiver-dbg:8840365166672031968:19:0) after 4m57s
[15:33:06.989] Handling timer "check-buildbucket-build-status" (chromium-m152/fuchsia-x64-cast-receiver-dbg:8840365166672031968:19:0)
[15:33:07.007] Build status: STARTED
[15:33:07.007] Scheduling timer "check-buildbucket-build-status" (chromium-m152/fuchsia-x64-cast-receiver-dbg:8840365166672031968:20:0) after 6m53s
[15:40:00.069] Handling timer "check-buildbucket-build-status" (chromium-m152/fuchsia-x64-cast-receiver-dbg:8840365166672031968:20:0)
[15:40:00.103] Build status: STARTED
[15:40:00.103] Scheduling timer "check-buildbucket-build-status" (chromium-m152/fuchsia-x64-cast-receiver-dbg:8840365166672031968:21:0) after 2m39s
[15:42:39.119] Handling timer "check-buildbucket-build-status" (chromium-m152/fuchsia-x64-cast-receiver-dbg:8840365166672031968:21:0)
[15:42:39.144] Build status: STARTED
[15:42:39.145] Scheduling timer "check-buildbucket-build-status" (chromium-m152/fuchsia-x64-cast-receiver-dbg:8840365166672031968:22:0) after 8m1s
[15:50:40.125] Handling timer "check-buildbucket-build-status" (chromium-m152/fuchsia-x64-cast-receiver-dbg:8840365166672031968:22:0)
[15:50:40.142] Build status: STARTED
[15:50:40.142] Scheduling timer "check-buildbucket-build-status" (chromium-m152/fuchsia-x64-cast-receiver-dbg:8840365166672031968:23:0) after 8m19s
[15:58:59.184] Handling timer "check-buildbucket-build-status" (chromium-m152/fuchsia-x64-cast-receiver-dbg:8840365166672031968:23:0)
[15:58:59.202] Build status: STARTED
[15:58:59.202] Scheduling timer "check-buildbucket-build-status" (chromium-m152/fuchsia-x64-cast-receiver-dbg:8840365166672031968:24:0) after 8m18s
[16:07:17.352] Handling timer "check-buildbucket-build-status" (chromium-m152/fuchsia-x64-cast-receiver-dbg:8840365166672031968:24:0)
[16:07:17.477] Build status: STARTED
[16:07:17.477] Scheduling timer "check-buildbucket-build-status" (chromium-m152/fuchsia-x64-cast-receiver-dbg:8840365166672031968:25:0) after 7m34s
[16:14:51.493] Handling timer "check-buildbucket-build-status" (chromium-m152/fuchsia-x64-cast-receiver-dbg:8840365166672031968:25:0)
[16:14:51.541] Build status: STARTED
[16:14:51.541] Scheduling timer "check-buildbucket-build-status" (chromium-m152/fuchsia-x64-cast-receiver-dbg:8840365166672031968:26:0) after 1m57s
[16:16:48.637] Handling timer "check-buildbucket-build-status" (chromium-m152/fuchsia-x64-cast-receiver-dbg:8840365166672031968:26:0)
[16:16:48.657] Build status: STARTED
[16:16:48.657] Scheduling timer "check-buildbucket-build-status" (chromium-m152/fuchsia-x64-cast-receiver-dbg:8840365166672031968:27:0) after 3m51s
[16:20:39.785] Handling timer "check-buildbucket-build-status" (chromium-m152/fuchsia-x64-cast-receiver-dbg:8840365166672031968:27:0)
[16:20:39.845] Build status: STARTED
[16:20:39.845] Scheduling timer "check-buildbucket-build-status" (chromium-m152/fuchsia-x64-cast-receiver-dbg:8840365166672031968:28:0) after 2m37s
[16:23:16.851] Handling timer "check-buildbucket-build-status" (chromium-m152/fuchsia-x64-cast-receiver-dbg:8840365166672031968:28:0)
[16:23:16.873] Build status: STARTED
[16:23:16.873] Scheduling timer "check-buildbucket-build-status" (chromium-m152/fuchsia-x64-cast-receiver-dbg:8840365166672031968:29:0) after 3m11s
[16:26:27.898] Handling timer "check-buildbucket-build-status" (chromium-m152/fuchsia-x64-cast-receiver-dbg:8840365166672031968:29:0)
[16:26:27.928] Build status: STARTED
[16:26:27.928] Scheduling timer "check-buildbucket-build-status" (chromium-m152/fuchsia-x64-cast-receiver-dbg:8840365166672031968:30:0) after 4m18s
[16:30:45.984] Handling timer "check-buildbucket-build-status" (chromium-m152/fuchsia-x64-cast-receiver-dbg:8840365166672031968:30:0)
[16:30:46.002] Build status: STARTED
[16:30:46.002] Scheduling timer "check-buildbucket-build-status" (chromium-m152/fuchsia-x64-cast-receiver-dbg:8840365166672031968:31:0) after 9m46s
[16:40:32.087] Handling timer "check-buildbucket-build-status" (chromium-m152/fuchsia-x64-cast-receiver-dbg:8840365166672031968:31:0)
[16:40:32.153] Build status: STARTED
[16:40:32.153] Scheduling timer "check-buildbucket-build-status" (chromium-m152/fuchsia-x64-cast-receiver-dbg:8840365166672031968:32:0) after 4m10s
[16:44:42.185] Handling timer "check-buildbucket-build-status" (chromium-m152/fuchsia-x64-cast-receiver-dbg:8840365166672031968:32:0)
[16:44:42.210] Build status: STARTED
[16:44:42.210] Scheduling timer "check-buildbucket-build-status" (chromium-m152/fuchsia-x64-cast-receiver-dbg:8840365166672031968:33:0) after 3m11s
[16:47:53.228] Handling timer "check-buildbucket-build-status" (chromium-m152/fuchsia-x64-cast-receiver-dbg:8840365166672031968:33:0)
[16:47:53.258] Build status: STARTED
[16:47:53.258] Scheduling timer "check-buildbucket-build-status" (chromium-m152/fuchsia-x64-cast-receiver-dbg:8840365166672031968:34:0) after 2m14s
[16:50:07.273] Handling timer "check-buildbucket-build-status" (chromium-m152/fuchsia-x64-cast-receiver-dbg:8840365166672031968:34:0)
[16:50:07.302] Build status: STARTED
[16:50:07.302] Scheduling timer "check-buildbucket-build-status" (chromium-m152/fuchsia-x64-cast-receiver-dbg:8840365166672031968:35:0) after 4m4s
[16:54:11.358] Handling timer "check-buildbucket-build-status" (chromium-m152/fuchsia-x64-cast-receiver-dbg:8840365166672031968:35:0)
[16:54:11.419] Build status: STARTED
[16:54:11.419] Scheduling timer "check-buildbucket-build-status" (chromium-m152/fuchsia-x64-cast-receiver-dbg:8840365166672031968:36:0) after 6m50s
[17:01:01.451] Handling timer "check-buildbucket-build-status" (chromium-m152/fuchsia-x64-cast-receiver-dbg:8840365166672031968:36:0)
[17:01:01.470] Build status: STARTED
[17:01:01.470] Scheduling timer "check-buildbucket-build-status" (chromium-m152/fuchsia-x64-cast-receiver-dbg:8840365166672031968:37:0) after 8m34s
[17:02:16.338] Received PubSub notification, asking Buildbucket for the build status
[17:02:16.463] Build:
{
"id": "8674935101212009073",
"builder": {
"project": "chromium-m152",
"bucket": "ci",
"builder": "fuchsia-x64-cast-receiver-dbg"
},
"number": 12,
"createdBy": "project:chromium-m152",
"createTime": "2026-07-29T14:10:19.691709412Z",
"startTime": "2026-07-29T14:44:57.663815194Z",
"endTime": "2026-07-29T17:02:15.721464181Z",
"updateTime": "2026-07-29T17:02:15.721464181Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "90bcd709238a22e936d68c8dea2456aa6475b863",
"ref": "refs/branch-heads/7977"
}
}
}
[17:02:16.463] Invocation finished in 2h52m1.363282162s with status SUCCEEDED