[15:53:36.119] New invocation is queued and will start shortly
[15:53:37.196] Starting the invocation (attempt 1)
[15:53:37.219] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/b2734427a09c20b6958541d54e99ef67fd899f9b"
[15:53:37.219] Popped gitiles commit info from properties and tags
[15:53:37.219] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[15:53:37.220] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[15:53:37.220] Buildbucket request:
{
"requestId": "8837459561511951264",
"builder": {
"project": "chromium-m153",
"bucket": "ci",
"builder": "fuchsia-x64-cast-receiver-dbg"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8837459561511951264",
"job": "chromium-m153/fuchsia-x64-cast-receiver-dbg",
"triggers": [
{
"gitiles": {
"ref": "refs/branch-heads/8010",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "60b4b2b0aecbad2448ed3cd401d08a565c85f1aa"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/8010@60b4b2b0aecbad2448ed3cd401d08a565c85f1aa",
"title": "60b4b2b0aecbad2448ed3cd401d08a565c85f1aa",
"url": "https://chromium.googlesource.com/chromium/src/+/60b4b2b0aecbad2448ed3cd401d08a565c85f1aa"
},
{
"gitiles": {
"ref": "refs/branch-heads/8010",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "08dff6ef3b7426fccd796676b880baf787f3dd1a"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/8010@08dff6ef3b7426fccd796676b880baf787f3dd1a",
"title": "08dff6ef3b7426fccd796676b880baf787f3dd1a",
"url": "https://chromium.googlesource.com/chromium/src/+/08dff6ef3b7426fccd796676b880baf787f3dd1a"
},
{
"gitiles": {
"ref": "refs/branch-heads/8010",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "293324c8ac769779f0331f64ce665dbfeeb9e6cb"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/8010@293324c8ac769779f0331f64ce665dbfeeb9e6cb",
"title": "293324c8ac769779f0331f64ce665dbfeeb9e6cb",
"url": "https://chromium.googlesource.com/chromium/src/+/293324c8ac769779f0331f64ce665dbfeeb9e6cb"
},
{
"gitiles": {
"ref": "refs/branch-heads/8010",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "37f70c5578fbc943b8c5344dfe9e065c5e681541"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/8010@37f70c5578fbc943b8c5344dfe9e065c5e681541",
"title": "37f70c5578fbc943b8c5344dfe9e065c5e681541",
"url": "https://chromium.googlesource.com/chromium/src/+/37f70c5578fbc943b8c5344dfe9e065c5e681541"
},
{
"gitiles": {
"ref": "refs/branch-heads/8010",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "17b27362d73a967f10a9962735560aa9417af424"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/8010@17b27362d73a967f10a9962735560aa9417af424",
"title": "17b27362d73a967f10a9962735560aa9417af424",
"url": "https://chromium.googlesource.com/chromium/src/+/17b27362d73a967f10a9962735560aa9417af424"
},
{
"gitiles": {
"ref": "refs/branch-heads/8010",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "5b189df4b33d33d31fdbcaebb2749781fa0049db"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/8010@5b189df4b33d33d31fdbcaebb2749781fa0049db",
"title": "5b189df4b33d33d31fdbcaebb2749781fa0049db",
"url": "https://chromium.googlesource.com/chromium/src/+/5b189df4b33d33d31fdbcaebb2749781fa0049db"
},
{
"gitiles": {
"ref": "refs/branch-heads/8010",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "0f6a2739632a3cc6c57cd9c59c9b7c22d8d4f444"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/8010@0f6a2739632a3cc6c57cd9c59c9b7c22d8d4f444",
"title": "0f6a2739632a3cc6c57cd9c59c9b7c22d8d4f444",
"url": "https://chromium.googlesource.com/chromium/src/+/0f6a2739632a3cc6c57cd9c59c9b7c22d8d4f444"
},
{
"gitiles": {
"ref": "refs/branch-heads/8010",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "e6f1636270b7da91fbe7ce9828d4291be0d9aac3"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/8010@e6f1636270b7da91fbe7ce9828d4291be0d9aac3",
"title": "e6f1636270b7da91fbe7ce9828d4291be0d9aac3",
"url": "https://chromium.googlesource.com/chromium/src/+/e6f1636270b7da91fbe7ce9828d4291be0d9aac3"
},
{
"gitiles": {
"ref": "refs/branch-heads/8010",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "b2734427a09c20b6958541d54e99ef67fd899f9b"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/8010@b2734427a09c20b6958541d54e99ef67fd899f9b",
"title": "b2734427a09c20b6958541d54e99ef67fd899f9b",
"url": "https://chromium.googlesource.com/chromium/src/+/b2734427a09c20b6958541d54e99ef67fd899f9b"
}
]
}
},
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "b2734427a09c20b6958541d54e99ef67fd899f9b",
"ref": "refs/branch-heads/8010"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8837459561511951264"
},
{
"key": "scheduler_job_id",
"value": "chromium-m153/fuchsia-x64-cast-receiver-dbg"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[15:53:37.697] Scheduled build:
{
"id": "8672029499634813313",
"builder": {
"project": "chromium-m153",
"bucket": "ci",
"builder": "fuchsia-x64-cast-receiver-dbg"
},
"number": 115,
"createdBy": "project:chromium-m153",
"createTime": "2026-08-30T15:53:37.288732792Z",
"updateTime": "2026-08-30T15:53:37.288732792Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "b2734427a09c20b6958541d54e99ef67fd899f9b",
"ref": "refs/branch-heads/8010"
}
}
}
[15:53:37.697] Task URL: https://cr-buildbucket.appspot.com/build/8672029499634813313
[15:53:37.697] Scheduling timer "check-buildbucket-build-status" (chromium-m153/fuchsia-x64-cast-receiver-dbg:8837459561511951264:2:0) after 2m15s
[15:53:39.480] Received PubSub notification, asking Buildbucket for the build status
[15:53:39.502] Build status: SCHEDULED
[15:55:52.818] Handling timer "check-buildbucket-build-status" (chromium-m153/fuchsia-x64-cast-receiver-dbg:8837459561511951264:2:0)
[15:55:52.839] Build status: SCHEDULED
[15:55:52.839] Scheduling timer "check-buildbucket-build-status" (chromium-m153/fuchsia-x64-cast-receiver-dbg:8837459561511951264:4:0) after 4m51s
[16:00:44.045] Handling timer "check-buildbucket-build-status" (chromium-m153/fuchsia-x64-cast-receiver-dbg:8837459561511951264:4:0)
[16:00:44.151] Build status: SCHEDULED
[16:00:44.151] Scheduling timer "check-buildbucket-build-status" (chromium-m153/fuchsia-x64-cast-receiver-dbg:8837459561511951264:5:0) after 4m19s
[16:05:03.498] Handling timer "check-buildbucket-build-status" (chromium-m153/fuchsia-x64-cast-receiver-dbg:8837459561511951264:5:0)
[16:05:03.534] Build status: SCHEDULED
[16:05:03.534] Scheduling timer "check-buildbucket-build-status" (chromium-m153/fuchsia-x64-cast-receiver-dbg:8837459561511951264:6:0) after 4m33s
[16:09:36.696] Handling timer "check-buildbucket-build-status" (chromium-m153/fuchsia-x64-cast-receiver-dbg:8837459561511951264:6:0)
[16:09:36.711] Build status: SCHEDULED
[16:09:36.712] Scheduling timer "check-buildbucket-build-status" (chromium-m153/fuchsia-x64-cast-receiver-dbg:8837459561511951264:7:0) after 3m18s
[16:12:54.777] Handling timer "check-buildbucket-build-status" (chromium-m153/fuchsia-x64-cast-receiver-dbg:8837459561511951264:7:0)
[16:12:54.815] Build status: SCHEDULED
[16:12:54.815] Scheduling timer "check-buildbucket-build-status" (chromium-m153/fuchsia-x64-cast-receiver-dbg:8837459561511951264:8:0) after 2m28s
[16:15:22.834] Handling timer "check-buildbucket-build-status" (chromium-m153/fuchsia-x64-cast-receiver-dbg:8837459561511951264:8:0)
[16:15:22.927] Build status: SCHEDULED
[16:15:22.928] Scheduling timer "check-buildbucket-build-status" (chromium-m153/fuchsia-x64-cast-receiver-dbg:8837459561511951264:9:0) after 4m1s
[16:19:23.941] Handling timer "check-buildbucket-build-status" (chromium-m153/fuchsia-x64-cast-receiver-dbg:8837459561511951264:9:0)
[16:19:23.967] Build status: SCHEDULED
[16:19:23.967] Scheduling timer "check-buildbucket-build-status" (chromium-m153/fuchsia-x64-cast-receiver-dbg:8837459561511951264:10:0) after 2m6s
[16:21:30.221] Handling timer "check-buildbucket-build-status" (chromium-m153/fuchsia-x64-cast-receiver-dbg:8837459561511951264:10:0)
[16:21:30.239] Build status: SCHEDULED
[16:21:30.239] Scheduling timer "check-buildbucket-build-status" (chromium-m153/fuchsia-x64-cast-receiver-dbg:8837459561511951264:11:0) after 1m18s
[16:22:48.429] Handling timer "check-buildbucket-build-status" (chromium-m153/fuchsia-x64-cast-receiver-dbg:8837459561511951264:11:0)
[16:22:48.452] Build status: SCHEDULED
[16:22:48.452] Scheduling timer "check-buildbucket-build-status" (chromium-m153/fuchsia-x64-cast-receiver-dbg:8837459561511951264:12:0) after 4m8s
[16:26:56.467] Handling timer "check-buildbucket-build-status" (chromium-m153/fuchsia-x64-cast-receiver-dbg:8837459561511951264:12:0)
[16:26:56.490] Build status: SCHEDULED
[16:26:56.490] Scheduling timer "check-buildbucket-build-status" (chromium-m153/fuchsia-x64-cast-receiver-dbg:8837459561511951264:13:0) after 7m26s
[16:34:22.504] Handling timer "check-buildbucket-build-status" (chromium-m153/fuchsia-x64-cast-receiver-dbg:8837459561511951264:13:0)
[16:34:22.522] Build status: SCHEDULED
[16:34:22.522] Scheduling timer "check-buildbucket-build-status" (chromium-m153/fuchsia-x64-cast-receiver-dbg:8837459561511951264:14:0) after 6m43s
[16:35:46.782] Received PubSub notification, asking Buildbucket for the build status
[16:35:46.808] Build status: STARTED
[16:41:05.510] Handling timer "check-buildbucket-build-status" (chromium-m153/fuchsia-x64-cast-receiver-dbg:8837459561511951264:14:0)
[16:41:05.535] Build status: STARTED
[16:41:05.535] Scheduling timer "check-buildbucket-build-status" (chromium-m153/fuchsia-x64-cast-receiver-dbg:8837459561511951264:16:0) after 4m16s
[16:45:21.551] Handling timer "check-buildbucket-build-status" (chromium-m153/fuchsia-x64-cast-receiver-dbg:8837459561511951264:16:0)
[16:45:21.579] Build status: STARTED
[16:45:21.579] Scheduling timer "check-buildbucket-build-status" (chromium-m153/fuchsia-x64-cast-receiver-dbg:8837459561511951264:17:0) after 7m28s
[16:52:49.769] Handling timer "check-buildbucket-build-status" (chromium-m153/fuchsia-x64-cast-receiver-dbg:8837459561511951264:17:0)
[16:52:49.794] Build status: STARTED
[16:52:49.794] Scheduling timer "check-buildbucket-build-status" (chromium-m153/fuchsia-x64-cast-receiver-dbg:8837459561511951264:18:0) after 3m23s
[16:56:12.971] Handling timer "check-buildbucket-build-status" (chromium-m153/fuchsia-x64-cast-receiver-dbg:8837459561511951264:18:0)
[16:56:12.996] Build status: STARTED
[16:56:12.996] Scheduling timer "check-buildbucket-build-status" (chromium-m153/fuchsia-x64-cast-receiver-dbg:8837459561511951264:19:0) after 8m43s
[17:04:56.013] Handling timer "check-buildbucket-build-status" (chromium-m153/fuchsia-x64-cast-receiver-dbg:8837459561511951264:19:0)
[17:04:56.036] Build status: STARTED
[17:04:56.041] Scheduling timer "check-buildbucket-build-status" (chromium-m153/fuchsia-x64-cast-receiver-dbg:8837459561511951264:20:0) after 8m38s
[17:13:34.077] Handling timer "check-buildbucket-build-status" (chromium-m153/fuchsia-x64-cast-receiver-dbg:8837459561511951264:20:0)
[17:13:34.103] Build status: STARTED
[17:13:34.103] Scheduling timer "check-buildbucket-build-status" (chromium-m153/fuchsia-x64-cast-receiver-dbg:8837459561511951264:21:0) after 2m35s
[17:16:09.193] Handling timer "check-buildbucket-build-status" (chromium-m153/fuchsia-x64-cast-receiver-dbg:8837459561511951264:21:0)
[17:16:09.225] Build status: STARTED
[17:16:09.225] Scheduling timer "check-buildbucket-build-status" (chromium-m153/fuchsia-x64-cast-receiver-dbg:8837459561511951264:22:0) after 4m46s
[17:20:55.373] Handling timer "check-buildbucket-build-status" (chromium-m153/fuchsia-x64-cast-receiver-dbg:8837459561511951264:22:0)
[17:20:55.391] Build status: STARTED
[17:20:55.392] Scheduling timer "check-buildbucket-build-status" (chromium-m153/fuchsia-x64-cast-receiver-dbg:8837459561511951264:23:0) after 7m6s
[17:28:01.461] Handling timer "check-buildbucket-build-status" (chromium-m153/fuchsia-x64-cast-receiver-dbg:8837459561511951264:23:0)
[17:28:01.497] Build status: STARTED
[17:28:01.497] Scheduling timer "check-buildbucket-build-status" (chromium-m153/fuchsia-x64-cast-receiver-dbg:8837459561511951264:24:0) after 2m11s
[17:30:12.510] Handling timer "check-buildbucket-build-status" (chromium-m153/fuchsia-x64-cast-receiver-dbg:8837459561511951264:24:0)
[17:30:12.533] Build status: STARTED
[17:30:12.533] Scheduling timer "check-buildbucket-build-status" (chromium-m153/fuchsia-x64-cast-receiver-dbg:8837459561511951264:25:0) after 4m59s
[17:35:11.556] Handling timer "check-buildbucket-build-status" (chromium-m153/fuchsia-x64-cast-receiver-dbg:8837459561511951264:25:0)
[17:35:11.579] Build status: STARTED
[17:35:11.579] Scheduling timer "check-buildbucket-build-status" (chromium-m153/fuchsia-x64-cast-receiver-dbg:8837459561511951264:26:0) after 3m48s
[17:38:59.615] Handling timer "check-buildbucket-build-status" (chromium-m153/fuchsia-x64-cast-receiver-dbg:8837459561511951264:26:0)
[17:38:59.647] Build status: STARTED
[17:38:59.647] Scheduling timer "check-buildbucket-build-status" (chromium-m153/fuchsia-x64-cast-receiver-dbg:8837459561511951264:27:0) after 1m8s
[17:40:07.684] Handling timer "check-buildbucket-build-status" (chromium-m153/fuchsia-x64-cast-receiver-dbg:8837459561511951264:27:0)
[17:40:07.702] Build status: STARTED
[17:40:07.702] Scheduling timer "check-buildbucket-build-status" (chromium-m153/fuchsia-x64-cast-receiver-dbg:8837459561511951264:28:0) after 4m41s
[17:44:48.721] Handling timer "check-buildbucket-build-status" (chromium-m153/fuchsia-x64-cast-receiver-dbg:8837459561511951264:28:0)
[17:44:48.738] Build status: STARTED
[17:44:48.738] Scheduling timer "check-buildbucket-build-status" (chromium-m153/fuchsia-x64-cast-receiver-dbg:8837459561511951264:29:0) after 1m22s
[17:46:10.896] Handling timer "check-buildbucket-build-status" (chromium-m153/fuchsia-x64-cast-receiver-dbg:8837459561511951264:29:0)
[17:46:10.925] Build status: STARTED
[17:46:10.925] Scheduling timer "check-buildbucket-build-status" (chromium-m153/fuchsia-x64-cast-receiver-dbg:8837459561511951264:30:0) after 7m14s
[17:53:25.015] Handling timer "check-buildbucket-build-status" (chromium-m153/fuchsia-x64-cast-receiver-dbg:8837459561511951264:30:0)
[17:53:25.097] Build status: STARTED
[17:53:25.097] Scheduling timer "check-buildbucket-build-status" (chromium-m153/fuchsia-x64-cast-receiver-dbg:8837459561511951264:31:0) after 3m45s
[17:57:10.113] Handling timer "check-buildbucket-build-status" (chromium-m153/fuchsia-x64-cast-receiver-dbg:8837459561511951264:31:0)
[17:57:10.139] Build status: STARTED
[17:57:10.139] Scheduling timer "check-buildbucket-build-status" (chromium-m153/fuchsia-x64-cast-receiver-dbg:8837459561511951264:32:0) after 4m30s
[18:01:40.207] Handling timer "check-buildbucket-build-status" (chromium-m153/fuchsia-x64-cast-receiver-dbg:8837459561511951264:32:0)
[18:01:40.229] Build status: STARTED
[18:01:40.229] Scheduling timer "check-buildbucket-build-status" (chromium-m153/fuchsia-x64-cast-receiver-dbg:8837459561511951264:33:0) after 7m49s
[18:09:29.344] Handling timer "check-buildbucket-build-status" (chromium-m153/fuchsia-x64-cast-receiver-dbg:8837459561511951264:33:0)
[18:09:29.361] Build status: STARTED
[18:09:29.361] Scheduling timer "check-buildbucket-build-status" (chromium-m153/fuchsia-x64-cast-receiver-dbg:8837459561511951264:34:0) after 5m15s
[18:14:44.420] Handling timer "check-buildbucket-build-status" (chromium-m153/fuchsia-x64-cast-receiver-dbg:8837459561511951264:34:0)
[18:14:44.441] Build status: STARTED
[18:14:44.441] Scheduling timer "check-buildbucket-build-status" (chromium-m153/fuchsia-x64-cast-receiver-dbg:8837459561511951264:35:0) after 3m37s
[18:18:21.653] Handling timer "check-buildbucket-build-status" (chromium-m153/fuchsia-x64-cast-receiver-dbg:8837459561511951264:35:0)
[18:18:21.688] Build status: STARTED
[18:18:21.688] Scheduling timer "check-buildbucket-build-status" (chromium-m153/fuchsia-x64-cast-receiver-dbg:8837459561511951264:36:0) after 3m45s
[18:22:06.795] Handling timer "check-buildbucket-build-status" (chromium-m153/fuchsia-x64-cast-receiver-dbg:8837459561511951264:36:0)
[18:22:06.852] Build status: STARTED
[18:22:06.863] Scheduling timer "check-buildbucket-build-status" (chromium-m153/fuchsia-x64-cast-receiver-dbg:8837459561511951264:37:0) after 4m18s
[18:26:24.902] Handling timer "check-buildbucket-build-status" (chromium-m153/fuchsia-x64-cast-receiver-dbg:8837459561511951264:37:0)
[18:26:24.956] Build status: STARTED
[18:26:24.956] Scheduling timer "check-buildbucket-build-status" (chromium-m153/fuchsia-x64-cast-receiver-dbg:8837459561511951264:38:0) after 8m35s
[18:34:59.979] Handling timer "check-buildbucket-build-status" (chromium-m153/fuchsia-x64-cast-receiver-dbg:8837459561511951264:38:0)
[18:35:00.026] Build status: STARTED
[18:35:00.027] Scheduling timer "check-buildbucket-build-status" (chromium-m153/fuchsia-x64-cast-receiver-dbg:8837459561511951264:39:0) after 3m25s
[18:35:24.359] Received PubSub notification, asking Buildbucket for the build status
[18:35:24.386] Build:
{
"id": "8672029499634813313",
"builder": {
"project": "chromium-m153",
"bucket": "ci",
"builder": "fuchsia-x64-cast-receiver-dbg"
},
"number": 115,
"createdBy": "project:chromium-m153",
"createTime": "2026-08-30T15:53:37.288732792Z",
"startTime": "2026-08-30T16:35:46.495428746Z",
"endTime": "2026-08-30T18:35:23.132685682Z",
"updateTime": "2026-08-30T18:35:23.132685682Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "b2734427a09c20b6958541d54e99ef67fd899f9b",
"ref": "refs/branch-heads/8010"
}
}
}
[18:35:24.386] Invocation finished in 2h41m48.270811305s with status SUCCEEDED