[03:39:52.527] New invocation is queued and will start shortly
[03:39:52.527] Triggered by user:tools-ci-builder@fuchsia-infra.iam.gserviceaccount.com
[03:39:53.615] Starting the invocation (attempt 1)
[03:39:53.640] Popped buildset tag "buildset:commit/gitiles/fuchsia.googlesource.com/third_party/rust/+/62bf38fa600f4beb878d61c537837729d4ee689e"
[03:39:53.640] Reconstructed gitiles commit from tags
[03:39:53.640] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[03:39:53.640] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[03:39:53.640] Buildbucket request:
{
"requestId": "8891592112541959392",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "rust_toolchain.core.x64-debug"
},
"properties": {
"$fuchsia/checkout": {
"gitiles_commit": {
"host": "fuchsia.googlesource.com",
"id": "4a3ec9b05b27261ed2eddfc4a62f8e408864887f",
"project": "integration",
"ref": "refs/heads/releases/canary"
},
"rust_toolchain": {
"cas_digest": "483c6463a4923e37f45ce6e432dbaded5750798e6f8094ff7d77f1b1d3c575e2/394",
"cas_instance": "projects/chromium-swarm/instances/default_instance"
}
},
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8891592112541959392",
"job": "fuchsia/rust_toolchain.core.x64-debug",
"triggers": [
{
"buildbucket": {
"properties": {
"$fuchsia/checkout": {
"gitiles_commit": {
"host": "fuchsia.googlesource.com",
"id": "4a3ec9b05b27261ed2eddfc4a62f8e408864887f",
"project": "integration",
"ref": "refs/heads/releases/canary"
},
"rust_toolchain": {
"cas_digest": "483c6463a4923e37f45ce6e432dbaded5750798e6f8094ff7d77f1b1d3c575e2/394",
"cas_instance": "projects/chromium-swarm/instances/default_instance"
}
},
"rust_toolchain": {
"git_repository": "https://fuchsia.googlesource.com/third_party/rust",
"git_revision": "62bf38fa600f4beb878d61c537837729d4ee689e"
}
},
"tags": [
"buildset:commit/gitiles/fuchsia.googlesource.com/third_party/rust/+/62bf38fa600f4beb878d61c537837729d4ee689e",
"gitiles_ref:refs/heads/main",
"parent_buildername:rust-x64-linux-bootstrap",
"user_agent:recipe"
]
},
"id": "4d8d4c5b-9c3a-427b-9cf5-83117fe59dc0",
"title": "rust-x64-linux-bootstrap/0"
}
]
},
"rust_toolchain": {
"git_repository": "https://fuchsia.googlesource.com/third_party/rust",
"git_revision": "62bf38fa600f4beb878d61c537837729d4ee689e"
}
},
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "third_party/rust",
"id": "62bf38fa600f4beb878d61c537837729d4ee689e",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8891592112541959392"
},
{
"key": "scheduler_job_id",
"value": "fuchsia/rust_toolchain.core.x64-debug"
},
{
"key": "user_agent",
"value": "luci-scheduler"
},
{
"key": "parent_buildername",
"value": "rust-x64-linux-bootstrap"
},
{
"key": "user_agent",
"value": "recipe"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[03:39:54.026] Scheduled build:
{
"id": "8726162050655980081",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "rust_toolchain.core.x64-debug"
},
"createdBy": "project:fuchsia",
"createTime": "2025-01-10T03:39:53.698312317Z",
"updateTime": "2025-01-10T03:39:53.698312317Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "third_party/rust",
"id": "62bf38fa600f4beb878d61c537837729d4ee689e",
"ref": "refs/heads/main"
}
}
}
[03:39:54.026] Task URL: https://cr-buildbucket.appspot.com/build/8726162050655980081
[03:39:54.026] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8891592112541959392:2:0) after 5m53s
[03:39:54.416] Received PubSub notification, asking Buildbucket for the build status
[03:39:54.437] Build status: SCHEDULED
[03:40:01.926] Received PubSub notification, asking Buildbucket for the build status
[03:40:01.969] Build status: STARTED
[03:45:47.027] Handling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8891592112541959392:2:0)
[03:45:47.085] Build status: STARTED
[03:45:47.085] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8891592112541959392:5:0) after 1m45s
[03:47:32.205] Handling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8891592112541959392:5:0)
[03:47:32.229] Build status: STARTED
[03:47:32.229] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8891592112541959392:6:0) after 4m36s
[03:52:08.254] Handling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8891592112541959392:6:0)
[03:52:08.282] Build status: STARTED
[03:52:08.282] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8891592112541959392:7:0) after 8m11s
[04:00:19.305] Handling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8891592112541959392:7:0)
[04:00:19.384] Build status: STARTED
[04:00:19.384] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8891592112541959392:8:0) after 2m51s
[04:03:10.408] Handling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8891592112541959392:8:0)
[04:03:10.437] Build status: STARTED
[04:03:10.437] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8891592112541959392:9:0) after 1m25s
[04:04:35.454] Handling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8891592112541959392:9:0)
[04:04:35.475] Build status: STARTED
[04:04:35.475] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8891592112541959392:10:0) after 6m59s
[04:11:34.594] Handling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8891592112541959392:10:0)
[04:11:34.622] Build status: STARTED
[04:11:34.622] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8891592112541959392:11:0) after 9m2s
[04:20:36.645] Handling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8891592112541959392:11:0)
[04:20:36.683] Build status: STARTED
[04:20:36.683] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8891592112541959392:12:0) after 2m32s
[04:23:08.774] Handling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8891592112541959392:12:0)
[04:23:08.799] Build status: STARTED
[04:23:08.799] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8891592112541959392:13:0) after 6m3s
[04:29:11.890] Handling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8891592112541959392:13:0)
[04:29:11.917] Build status: STARTED
[04:29:11.917] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8891592112541959392:14:0) after 9m41s
[04:38:53.362] Handling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8891592112541959392:14:0)
[04:38:53.398] Build status: STARTED
[04:38:53.398] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8891592112541959392:15:0) after 6m30s
[04:45:23.482] Handling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8891592112541959392:15:0)
[04:45:23.507] Build status: STARTED
[04:45:23.507] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8891592112541959392:16:0) after 4m20s
[04:49:43.533] Handling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8891592112541959392:16:0)
[04:49:43.562] Build status: STARTED
[04:49:43.562] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8891592112541959392:17:0) after 3m40s
[04:53:23.736] Handling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8891592112541959392:17:0)
[04:53:23.815] Build status: STARTED
[04:53:23.815] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8891592112541959392:18:0) after 2m43s
[04:56:06.925] Handling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8891592112541959392:18:0)
[04:56:06.941] Build status: STARTED
[04:56:06.941] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8891592112541959392:19:0) after 6m1s
[05:02:08.151] Handling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8891592112541959392:19:0)
[05:02:08.178] Build status: STARTED
[05:02:08.178] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8891592112541959392:20:0) after 6m29s
[05:08:37.230] Handling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8891592112541959392:20:0)
[05:08:37.295] Build status: STARTED
[05:08:37.295] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8891592112541959392:21:0) after 8m29s
[05:17:06.355] Handling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8891592112541959392:21:0)
[05:17:06.379] Build status: STARTED
[05:17:06.379] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8891592112541959392:22:0) after 2m6s
[05:19:12.401] Handling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8891592112541959392:22:0)
[05:19:12.422] Build status: STARTED
[05:19:12.422] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8891592112541959392:23:0) after 8m44s
[05:27:56.510] Handling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8891592112541959392:23:0)
[05:27:56.535] Build status: STARTED
[05:27:56.535] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8891592112541959392:24:0) after 3m28s
[05:31:24.828] Handling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8891592112541959392:24:0)
[05:31:24.893] Build status: STARTED
[05:31:24.894] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8891592112541959392:25:0) after 8m35s
[05:40:00.018] Handling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8891592112541959392:25:0)
[05:40:00.039] Build status: STARTED
[05:40:00.039] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8891592112541959392:26:0) after 6m4s
[05:46:04.064] Handling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8891592112541959392:26:0)
[05:46:04.142] Build status: STARTED
[05:46:04.142] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8891592112541959392:27:0) after 1m11s
[05:47:15.728] Handling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8891592112541959392:27:0)
[05:47:15.761] Build status: STARTED
[05:47:15.761] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8891592112541959392:28:0) after 4m20s
[05:51:35.869] Handling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8891592112541959392:28:0)
[05:51:35.911] Build status: STARTED
[05:51:35.911] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8891592112541959392:29:0) after 5m5s
[05:55:15.598] Received PubSub notification, asking Buildbucket for the build status
[05:55:15.626] Build:
{
"id": "8726162050655980081",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "rust_toolchain.core.x64-debug"
},
"createdBy": "project:fuchsia",
"createTime": "2025-01-10T03:39:53.698312317Z",
"startTime": "2025-01-10T03:40:01.730113630Z",
"endTime": "2025-01-10T05:55:10.949912332Z",
"updateTime": "2025-01-10T05:55:10.949912332Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "third_party/rust",
"id": "62bf38fa600f4beb878d61c537837729d4ee689e",
"ref": "refs/heads/main"
}
}
}
[05:55:15.626] Invocation finished in 2h15m23.110153823s with status SUCCEEDED