[18:17:39.287] New invocation is queued and will start shortly
[18:17:40.476] Starting the invocation (attempt 1)
[18:17:40.505] Popped buildset tag "buildset:commit/gitiles/rust.googlesource.com/rust/+/b889870082dd0b0e3594bbfbebb4545d54710829"
[18:17:40.505] Popped gitiles commit info from properties and tags
[18:17:40.505] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[18:17:40.505] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[18:17:40.506] Buildbucket request:
{
"requestId": "8860462127966875776",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "rust-linux-x64"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8860462127966875776",
"job": "fuchsia/toolchain.ci-rust-linux-x64-85c13e79",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://rust.googlesource.com/rust",
"revision": "0383197fbe1d293c1b10e05f463b00075e7f1320"
},
"id": "https://rust.googlesource.com/rust/+/refs/heads/main@0383197fbe1d293c1b10e05f463b00075e7f1320",
"title": "0383197fbe1d293c1b10e05f463b00075e7f1320",
"url": "https://rust.googlesource.com/rust/+/0383197fbe1d293c1b10e05f463b00075e7f1320"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://rust.googlesource.com/rust",
"revision": "1ae96045d255ebda6ae9bb4a3b578f47ec24f6e7"
},
"id": "https://rust.googlesource.com/rust/+/refs/heads/main@1ae96045d255ebda6ae9bb4a3b578f47ec24f6e7",
"title": "1ae96045d255ebda6ae9bb4a3b578f47ec24f6e7",
"url": "https://rust.googlesource.com/rust/+/1ae96045d255ebda6ae9bb4a3b578f47ec24f6e7"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://rust.googlesource.com/rust",
"revision": "7e63bc07de1e638ceab5894f9163fdd8dc289359"
},
"id": "https://rust.googlesource.com/rust/+/refs/heads/main@7e63bc07de1e638ceab5894f9163fdd8dc289359",
"title": "7e63bc07de1e638ceab5894f9163fdd8dc289359",
"url": "https://rust.googlesource.com/rust/+/7e63bc07de1e638ceab5894f9163fdd8dc289359"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://rust.googlesource.com/rust",
"revision": "c040bb1c7eeb21e5e9dfb2843eba75a8168e0791"
},
"id": "https://rust.googlesource.com/rust/+/refs/heads/main@c040bb1c7eeb21e5e9dfb2843eba75a8168e0791",
"title": "c040bb1c7eeb21e5e9dfb2843eba75a8168e0791",
"url": "https://rust.googlesource.com/rust/+/c040bb1c7eeb21e5e9dfb2843eba75a8168e0791"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://rust.googlesource.com/rust",
"revision": "0e64ced2f7aa5fa912d5a0ef9a5db843e8f4737c"
},
"id": "https://rust.googlesource.com/rust/+/refs/heads/main@0e64ced2f7aa5fa912d5a0ef9a5db843e8f4737c",
"title": "0e64ced2f7aa5fa912d5a0ef9a5db843e8f4737c",
"url": "https://rust.googlesource.com/rust/+/0e64ced2f7aa5fa912d5a0ef9a5db843e8f4737c"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://rust.googlesource.com/rust",
"revision": "f140bba8d98844567a08f69dd4e1f3ff7c098e41"
},
"id": "https://rust.googlesource.com/rust/+/refs/heads/main@f140bba8d98844567a08f69dd4e1f3ff7c098e41",
"title": "f140bba8d98844567a08f69dd4e1f3ff7c098e41",
"url": "https://rust.googlesource.com/rust/+/f140bba8d98844567a08f69dd4e1f3ff7c098e41"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://rust.googlesource.com/rust",
"revision": "77491e7878ecd6d3073cbcebd92cba35ed600909"
},
"id": "https://rust.googlesource.com/rust/+/refs/heads/main@77491e7878ecd6d3073cbcebd92cba35ed600909",
"title": "77491e7878ecd6d3073cbcebd92cba35ed600909",
"url": "https://rust.googlesource.com/rust/+/77491e7878ecd6d3073cbcebd92cba35ed600909"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://rust.googlesource.com/rust",
"revision": "b889870082dd0b0e3594bbfbebb4545d54710829"
},
"id": "https://rust.googlesource.com/rust/+/refs/heads/main@b889870082dd0b0e3594bbfbebb4545d54710829",
"title": "b889870082dd0b0e3594bbfbebb4545d54710829",
"url": "https://rust.googlesource.com/rust/+/b889870082dd0b0e3594bbfbebb4545d54710829"
}
]
}
},
"gitilesCommit": {
"host": "rust.googlesource.com",
"project": "rust",
"id": "b889870082dd0b0e3594bbfbebb4545d54710829",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8860462127966875776"
},
{
"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"
}
}
[18:17:40.839] Scheduled build:
{
"id": "8695032065975324337",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "rust-linux-x64"
},
"createdBy": "project:fuchsia",
"createTime": "2025-12-19T18:17:40.558951011Z",
"updateTime": "2025-12-19T18:17:40.558951011Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "rust.googlesource.com",
"project": "rust",
"id": "b889870082dd0b0e3594bbfbebb4545d54710829",
"ref": "refs/heads/main"
}
}
}
[18:17:40.840] Task URL: https://cr-buildbucket.appspot.com/build/8695032065975324337
[18:17:40.840] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust-linux-x64-85c13e79:8860462127966875776:2:0) after 7m37s
[18:17:41.000] Received PubSub notification, asking Buildbucket for the build status
[18:17:41.026] Build status: SCHEDULED
[18:17:43.899] Received PubSub notification, asking Buildbucket for the build status
[18:17:43.921] Build status: STARTED
[18:25:17.848] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust-linux-x64-85c13e79:8860462127966875776:2:0)
[18:25:17.867] Build status: STARTED
[18:25:17.867] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust-linux-x64-85c13e79:8860462127966875776:5:0) after 1m11s
[18:26:28.860] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust-linux-x64-85c13e79:8860462127966875776:5:0)
[18:26:28.964] Build status: STARTED
[18:26:28.964] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust-linux-x64-85c13e79:8860462127966875776:6:0) after 2m56s
[18:29:25.142] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust-linux-x64-85c13e79:8860462127966875776:6:0)
[18:29:25.161] Build status: STARTED
[18:29:25.161] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust-linux-x64-85c13e79:8860462127966875776:7:0) after 9m19s
[18:38:44.295] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust-linux-x64-85c13e79:8860462127966875776:7:0)
[18:38:44.314] Build status: STARTED
[18:38:44.314] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust-linux-x64-85c13e79:8860462127966875776:8:0) after 4m58s
[18:43:42.379] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust-linux-x64-85c13e79:8860462127966875776:8:0)
[18:43:42.399] Build status: STARTED
[18:43:42.399] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust-linux-x64-85c13e79:8860462127966875776:9:0) after 3m15s
[18:46:57.623] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust-linux-x64-85c13e79:8860462127966875776:9:0)
[18:46:57.806] Build status: STARTED
[18:46:57.806] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust-linux-x64-85c13e79:8860462127966875776:10:0) after 3m4s
[18:50:02.063] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust-linux-x64-85c13e79:8860462127966875776:10:0)
[18:50:02.078] Build status: STARTED
[18:50:02.078] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust-linux-x64-85c13e79:8860462127966875776:11:0) after 9m2s
[18:59:04.153] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust-linux-x64-85c13e79:8860462127966875776:11:0)
[18:59:04.235] Build status: STARTED
[18:59:04.235] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust-linux-x64-85c13e79:8860462127966875776:12:0) after 8m58s
[19:08:02.389] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust-linux-x64-85c13e79:8860462127966875776:12:0)
[19:08:02.408] Build status: STARTED
[19:08:02.408] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust-linux-x64-85c13e79:8860462127966875776:13:0) after 4m43s
[19:12:45.509] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust-linux-x64-85c13e79:8860462127966875776:13:0)
[19:12:45.530] Build status: STARTED
[19:12:45.530] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust-linux-x64-85c13e79:8860462127966875776:14:0) after 7m46s
[19:17:14.559] Received PubSub notification, asking Buildbucket for the build status
[19:17:14.612] Build:
{
"id": "8695032065975324337",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "rust-linux-x64"
},
"createdBy": "project:fuchsia",
"createTime": "2025-12-19T18:17:40.558951011Z",
"startTime": "2025-12-19T18:17:43.750691417Z",
"endTime": "2025-12-19T19:17:14.243764324Z",
"updateTime": "2025-12-19T19:17:14.243764324Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "rust.googlesource.com",
"project": "rust",
"id": "b889870082dd0b0e3594bbfbebb4545d54710829",
"ref": "refs/heads/main"
}
}
}
[19:17:14.612] Invocation finished in 59m35.337523212s with status SUCCEEDED