[03:23:03.038] New invocation is queued and will start shortly
[03:23:04.105] Starting the invocation (attempt 1)
[03:23:04.126] Popped buildset tag "buildset:commit/gitiles/rust.googlesource.com/rust/+/554952348a7dd13851f25789f6bb1061f45c4b60"
[03:23:04.126] Popped gitiles commit info from properties and tags
[03:23:04.126] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[03:23:04.127] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[03:23:04.128] Buildbucket request:
{
"requestId": "8861514978225498944",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "rust-linux-x64"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8861514978225498944",
"job": "fuchsia/toolchain.ci-rust-linux-x64-85c13e79",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://rust.googlesource.com/rust",
"revision": "3fadbd50b099b873b8631bc39158ce83d0845768"
},
"id": "https://rust.googlesource.com/rust/+/refs/heads/main@3fadbd50b099b873b8631bc39158ce83d0845768",
"title": "3fadbd50b099b873b8631bc39158ce83d0845768",
"url": "https://rust.googlesource.com/rust/+/3fadbd50b099b873b8631bc39158ce83d0845768"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://rust.googlesource.com/rust",
"revision": "f7d7a35daf9cb25b0b5ed0c76d176df66eb2a4e4"
},
"id": "https://rust.googlesource.com/rust/+/refs/heads/main@f7d7a35daf9cb25b0b5ed0c76d176df66eb2a4e4",
"title": "f7d7a35daf9cb25b0b5ed0c76d176df66eb2a4e4",
"url": "https://rust.googlesource.com/rust/+/f7d7a35daf9cb25b0b5ed0c76d176df66eb2a4e4"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://rust.googlesource.com/rust",
"revision": "6dbea1f0a257862d1fcc1582f80fbd701dc5f18e"
},
"id": "https://rust.googlesource.com/rust/+/refs/heads/main@6dbea1f0a257862d1fcc1582f80fbd701dc5f18e",
"title": "6dbea1f0a257862d1fcc1582f80fbd701dc5f18e",
"url": "https://rust.googlesource.com/rust/+/6dbea1f0a257862d1fcc1582f80fbd701dc5f18e"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://rust.googlesource.com/rust",
"revision": "554952348a7dd13851f25789f6bb1061f45c4b60"
},
"id": "https://rust.googlesource.com/rust/+/refs/heads/main@554952348a7dd13851f25789f6bb1061f45c4b60",
"title": "554952348a7dd13851f25789f6bb1061f45c4b60",
"url": "https://rust.googlesource.com/rust/+/554952348a7dd13851f25789f6bb1061f45c4b60"
}
]
}
},
"gitilesCommit": {
"host": "rust.googlesource.com",
"project": "rust",
"id": "554952348a7dd13851f25789f6bb1061f45c4b60",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8861514978225498944"
},
{
"key": "scheduler_job_id",
"value": "fuchsia/toolchain.ci-rust-linux-x64-85c13e79"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[03:23:04.581] Scheduled build:
{
"id": "8696084916362654161",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "rust-linux-x64"
},
"createdBy": "project:fuchsia",
"createTime": "2025-12-08T03:23:04.185098766Z",
"updateTime": "2025-12-08T03:23:04.185098766Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "rust.googlesource.com",
"project": "rust",
"id": "554952348a7dd13851f25789f6bb1061f45c4b60",
"ref": "refs/heads/main"
}
}
}
[03:23:04.582] Task URL: https://cr-buildbucket.appspot.com/build/8696084916362654161
[03:23:04.582] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust-linux-x64-85c13e79:8861514978225498944:2:0) after 3m45s
[03:23:05.227] Received PubSub notification, asking Buildbucket for the build status
[03:23:05.247] Build status: SCHEDULED
[03:23:11.088] Received PubSub notification, asking Buildbucket for the build status
[03:23:11.111] Build status: STARTED
[03:26:49.698] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust-linux-x64-85c13e79:8861514978225498944:2:0)
[03:26:49.715] Build status: STARTED
[03:26:49.715] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust-linux-x64-85c13e79:8861514978225498944:5:0) after 8m17s
[03:35:07.032] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust-linux-x64-85c13e79:8861514978225498944:5:0)
[03:35:07.074] Build status: STARTED
[03:35:07.074] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust-linux-x64-85c13e79:8861514978225498944:6:0) after 8m14s
[03:43:21.087] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust-linux-x64-85c13e79:8861514978225498944:6:0)
[03:43:21.247] Build status: STARTED
[03:43:21.248] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust-linux-x64-85c13e79:8861514978225498944:7:0) after 6m46s
[03:50:07.432] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust-linux-x64-85c13e79:8861514978225498944:7:0)
[03:50:07.448] Build status: STARTED
[03:50:07.448] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust-linux-x64-85c13e79:8861514978225498944:8:0) after 8m13s
[03:58:20.822] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust-linux-x64-85c13e79:8861514978225498944:8:0)
[03:58:20.841] Build status: STARTED
[03:58:20.841] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust-linux-x64-85c13e79:8861514978225498944:9:0) after 5m25s
[04:03:45.953] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust-linux-x64-85c13e79:8861514978225498944:9:0)
[04:03:45.988] Build status: STARTED
[04:03:45.988] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust-linux-x64-85c13e79:8861514978225498944:10:0) after 4m28s
[04:07:34.563] Received PubSub notification, asking Buildbucket for the build status
[04:07:34.576] Build:
{
"id": "8696084916362654161",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "rust-linux-x64"
},
"createdBy": "project:fuchsia",
"createTime": "2025-12-08T03:23:04.185098766Z",
"startTime": "2025-12-08T03:23:09.324461765Z",
"endTime": "2025-12-08T04:07:34.219443884Z",
"updateTime": "2025-12-08T04:07:34.219443884Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "rust.googlesource.com",
"project": "rust",
"id": "554952348a7dd13851f25789f6bb1061f45c4b60",
"ref": "refs/heads/main"
}
}
}
[04:07:34.576] Invocation finished in 44m31.55111474s with status SUCCEEDED