[18:21:50.294] New invocation is queued and will start shortly
[18:21:50.294] Triggered by user:tools-ci-builder@fuchsia-infra.iam.gserviceaccount.com
[18:21:51.507] Starting the invocation (attempt 1)
[18:21:51.537] Popped buildset tag "buildset:commit/gitiles/fuchsia.googlesource.com/third_party/rust/+/251206c27b619ccf3a08e2ac4c525dc343f08492"
[18:21:51.537] Reconstructed gitiles commit from tags
[18:21:51.537] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[18:21:51.537] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[18:21:51.538] Buildbucket request:
{
"requestId": "8891627221208668496",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "rust_toolchain.core.arm64-debug"
},
"properties": {
"$fuchsia/checkout": {
"gitiles_commit": {
"host": "fuchsia.googlesource.com",
"id": "a6b1b152ddb723cb1ea8a7f8e1b082edf57d6944",
"project": "integration",
"ref": "refs/heads/releases/canary"
},
"rust_toolchain": {
"cas_digest": "97784cefd132957bb63fd97079f7a95c76e377c33adbddeac1b8d0f9c419da6d/394",
"cas_instance": "projects/chromium-swarm/instances/default_instance"
}
},
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8891627221208668496",
"job": "fuchsia/rust_toolchain.core.arm64-debug",
"triggers": [
{
"buildbucket": {
"properties": {
"$fuchsia/checkout": {
"gitiles_commit": {
"host": "fuchsia.googlesource.com",
"id": "a6b1b152ddb723cb1ea8a7f8e1b082edf57d6944",
"project": "integration",
"ref": "refs/heads/releases/canary"
},
"rust_toolchain": {
"cas_digest": "fe7f11947b491e75628cea5d55e7cf377e1639db64e19ca1641ac68ffb8a3255/394",
"cas_instance": "projects/chromium-swarm/instances/default_instance"
}
},
"rust_toolchain": {
"git_repository": "https://fuchsia.googlesource.com/third_party/rust",
"git_revision": "251206c27b619ccf3a08e2ac4c525dc343f08492"
}
},
"tags": [
"buildset:commit/gitiles/fuchsia.googlesource.com/third_party/rust/+/251206c27b619ccf3a08e2ac4c525dc343f08492",
"gitiles_ref:refs/heads/main",
"parent_buildername:rust-x64-linux",
"user_agent:recipe"
]
},
"id": "b3f930d2-2bd3-473a-8545-deb8872f3204",
"title": "rust-x64-linux/0"
},
{
"buildbucket": {
"properties": {
"$fuchsia/checkout": {
"gitiles_commit": {
"host": "fuchsia.googlesource.com",
"id": "a6b1b152ddb723cb1ea8a7f8e1b082edf57d6944",
"project": "integration",
"ref": "refs/heads/releases/canary"
},
"rust_toolchain": {
"cas_digest": "97784cefd132957bb63fd97079f7a95c76e377c33adbddeac1b8d0f9c419da6d/394",
"cas_instance": "projects/chromium-swarm/instances/default_instance"
}
},
"rust_toolchain": {
"git_repository": "https://fuchsia.googlesource.com/third_party/rust",
"git_revision": "251206c27b619ccf3a08e2ac4c525dc343f08492"
}
},
"tags": [
"buildset:commit/gitiles/fuchsia.googlesource.com/third_party/rust/+/251206c27b619ccf3a08e2ac4c525dc343f08492",
"gitiles_ref:refs/heads/main",
"parent_buildername:rust-x64-linux-bootstrap",
"user_agent:recipe"
]
},
"id": "61713834-b0c0-47f9-aa04-7faec9d6d5d4",
"title": "rust-x64-linux-bootstrap/0"
}
]
},
"rust_toolchain": {
"git_repository": "https://fuchsia.googlesource.com/third_party/rust",
"git_revision": "251206c27b619ccf3a08e2ac4c525dc343f08492"
}
},
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "third_party/rust",
"id": "251206c27b619ccf3a08e2ac4c525dc343f08492",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8891627221208668496"
},
{
"key": "scheduler_job_id",
"value": "fuchsia/rust_toolchain.core.arm64-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"
}
}
[18:21:51.893] Scheduled build:
{
"id": "8726197159183409441",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "rust_toolchain.core.arm64-debug"
},
"createdBy": "project:fuchsia",
"createTime": "2025-01-09T18:21:51.597151132Z",
"updateTime": "2025-01-09T18:21:51.597151132Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "third_party/rust",
"id": "251206c27b619ccf3a08e2ac4c525dc343f08492",
"ref": "refs/heads/main"
}
}
}
[18:21:51.893] Task URL: https://cr-buildbucket.appspot.com/build/8726197159183409441
[18:21:51.893] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.arm64-debug:8891627221208668496:2:0) after 7m32s
[18:21:52.968] Received PubSub notification, asking Buildbucket for the build status
[18:21:52.998] Build status: SCHEDULED
[18:21:57.527] Received PubSub notification, asking Buildbucket for the build status
[18:21:57.551] Build status: STARTED
[18:29:24.012] Handling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.arm64-debug:8891627221208668496:2:0)
[18:29:24.042] Build status: STARTED
[18:29:24.042] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.arm64-debug:8891627221208668496:5:0) after 4m14s
[18:33:38.102] Handling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.arm64-debug:8891627221208668496:5:0)
[18:33:38.138] Build status: STARTED
[18:33:38.138] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.arm64-debug:8891627221208668496:6:0) after 6m2s
[18:39:40.212] Handling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.arm64-debug:8891627221208668496:6:0)
[18:39:40.235] Build status: STARTED
[18:39:40.236] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.arm64-debug:8891627221208668496:7:0) after 7m36s
[18:47:16.251] Handling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.arm64-debug:8891627221208668496:7:0)
[18:47:16.271] Build status: STARTED
[18:47:16.271] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.arm64-debug:8891627221208668496:8:0) after 4m57s
[18:52:13.342] Handling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.arm64-debug:8891627221208668496:8:0)
[18:52:13.369] Build status: STARTED
[18:52:13.369] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.arm64-debug:8891627221208668496:9:0) after 4m11s
[18:56:24.456] Handling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.arm64-debug:8891627221208668496:9:0)
[18:56:24.474] Build status: STARTED
[18:56:24.474] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.arm64-debug:8891627221208668496:10:0) after 7m33s
[19:03:57.506] Handling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.arm64-debug:8891627221208668496:10:0)
[19:03:57.526] Build status: STARTED
[19:03:57.526] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.arm64-debug:8891627221208668496:11:0) after 7m28s
[19:11:25.631] Handling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.arm64-debug:8891627221208668496:11:0)
[19:11:25.657] Build status: STARTED
[19:11:25.657] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.arm64-debug:8891627221208668496:12:0) after 6m42s
[19:18:07.816] Handling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.arm64-debug:8891627221208668496:12:0)
[19:18:07.850] Build status: STARTED
[19:18:07.850] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.arm64-debug:8891627221208668496:13:0) after 8m2s
[19:26:09.983] Handling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.arm64-debug:8891627221208668496:13:0)
[19:26:10.004] Build status: STARTED
[19:26:10.004] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.arm64-debug:8891627221208668496:14:0) after 1m56s
[19:28:06.029] Handling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.arm64-debug:8891627221208668496:14:0)
[19:28:06.079] Build status: STARTED
[19:28:06.079] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.arm64-debug:8891627221208668496:15:0) after 4m45s
[19:32:51.150] Handling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.arm64-debug:8891627221208668496:15:0)
[19:32:51.177] Build status: STARTED
[19:32:51.177] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.arm64-debug:8891627221208668496:16:0) after 7m20s
[19:40:11.209] Handling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.arm64-debug:8891627221208668496:16:0)
[19:40:11.240] Build status: STARTED
[19:40:11.240] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.arm64-debug:8891627221208668496:17:0) after 3m3s
[19:43:14.393] Handling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.arm64-debug:8891627221208668496:17:0)
[19:43:14.415] Build status: STARTED
[19:43:14.415] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.arm64-debug:8891627221208668496:18:0) after 9m44s
[19:52:58.442] Handling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.arm64-debug:8891627221208668496:18:0)
[19:52:58.460] Build status: STARTED
[19:52:58.460] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.arm64-debug:8891627221208668496:19:0) after 7m49s
[20:00:47.462] Handling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.arm64-debug:8891627221208668496:19:0)
[20:00:47.485] Build status: STARTED
[20:00:47.485] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.arm64-debug:8891627221208668496:20:0) after 9m51s
[20:10:38.553] Handling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.arm64-debug:8891627221208668496:20:0)
[20:10:38.577] Build status: STARTED
[20:10:38.577] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.arm64-debug:8891627221208668496:21:0) after 4m2s
[20:14:40.627] Handling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.arm64-debug:8891627221208668496:21:0)
[20:14:40.651] Build status: STARTED
[20:14:40.651] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.arm64-debug:8891627221208668496:22:0) after 4m51s
[20:19:31.676] Handling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.arm64-debug:8891627221208668496:22:0)
[20:19:31.696] Build status: STARTED
[20:19:31.696] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.arm64-debug:8891627221208668496:23:0) after 8m26s
[20:27:57.754] Handling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.arm64-debug:8891627221208668496:23:0)
[20:27:57.779] Build status: STARTED
[20:27:57.779] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.arm64-debug:8891627221208668496:24:0) after 1m27s
[20:28:55.855] Received PubSub notification, asking Buildbucket for the build status
[20:28:55.876] Build:
{
"id": "8726197159183409441",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "rust_toolchain.core.arm64-debug"
},
"createdBy": "project:fuchsia",
"createTime": "2025-01-09T18:21:51.597151132Z",
"startTime": "2025-01-09T18:21:57.171737994Z",
"endTime": "2025-01-09T20:28:55.278953886Z",
"updateTime": "2025-01-09T20:28:55.278953886Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "third_party/rust",
"id": "251206c27b619ccf3a08e2ac4c525dc343f08492",
"ref": "refs/heads/main"
}
}
}
[20:28:55.876] Invocation finished in 2h7m5.59357667s with status SUCCEEDED