[02:10:18.883] New invocation is queued and will start shortly
[02:10:18.883] Triggered by user:tools-ci-builder@fuchsia-infra.iam.gserviceaccount.com
[02:10:20.153] Starting the invocation (attempt 1)
[02:10:20.181] Popped buildset tag "buildset:commit/gitiles/fuchsia.googlesource.com/third_party/rust/+/8d2c06d151972fefa3f0bbf04ace3beede737145"
[02:10:20.181] Reconstructed gitiles commit from tags
[02:10:20.181] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[02:10:20.181] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[02:10:20.182] Buildbucket request:
{
"requestId": "8892141329016090592",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "rust_toolchain.core.arm64-debug"
},
"properties": {
"$fuchsia/checkout": {
"gitiles_commit": {
"host": "fuchsia.googlesource.com",
"id": "14a7a981bd43ce87938cbe67d144c7be75d60a9c",
"project": "integration",
"ref": "refs/heads/releases/canary"
},
"rust_toolchain": {
"cas_digest": "8fd3a67df891156ab694380bd6c13a74af968c3306e242c9751c3e1d1147fcb2/394",
"cas_instance": "projects/chromium-swarm/instances/default_instance"
}
},
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8892141329016090592",
"job": "fuchsia/rust_toolchain.core.arm64-debug",
"triggers": [
{
"buildbucket": {
"properties": {
"$fuchsia/checkout": {
"gitiles_commit": {
"host": "fuchsia.googlesource.com",
"id": "14a7a981bd43ce87938cbe67d144c7be75d60a9c",
"project": "integration",
"ref": "refs/heads/releases/canary"
},
"rust_toolchain": {
"cas_digest": "8fd3a67df891156ab694380bd6c13a74af968c3306e242c9751c3e1d1147fcb2/394",
"cas_instance": "projects/chromium-swarm/instances/default_instance"
}
},
"rust_toolchain": {
"git_repository": "https://fuchsia.googlesource.com/third_party/rust",
"git_revision": "8d2c06d151972fefa3f0bbf04ace3beede737145"
}
},
"tags": [
"buildset:commit/gitiles/fuchsia.googlesource.com/third_party/rust/+/8d2c06d151972fefa3f0bbf04ace3beede737145",
"gitiles_ref:refs/heads/main",
"parent_buildername:rust-x64-linux-bootstrap",
"user_agent:recipe"
]
},
"id": "5dccbac9-c455-4418-8123-ba218c311b46",
"title": "rust-x64-linux-bootstrap/0"
}
]
},
"rust_toolchain": {
"git_repository": "https://fuchsia.googlesource.com/third_party/rust",
"git_revision": "8d2c06d151972fefa3f0bbf04ace3beede737145"
}
},
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "third_party/rust",
"id": "8d2c06d151972fefa3f0bbf04ace3beede737145",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8892141329016090592"
},
{
"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"
}
}
[02:10:20.677] Scheduled build:
{
"id": "8726711266918239217",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "rust_toolchain.core.arm64-debug"
},
"createdBy": "project:fuchsia",
"createTime": "2025-01-04T02:10:20.255586128Z",
"updateTime": "2025-01-04T02:10:20.255586128Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "third_party/rust",
"id": "8d2c06d151972fefa3f0bbf04ace3beede737145",
"ref": "refs/heads/main"
}
}
}
[02:10:20.677] Task URL: https://cr-buildbucket.appspot.com/build/8726711266918239217
[02:10:20.677] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.arm64-debug:8892141329016090592:2:0) after 6m13s
[02:10:21.645] Received PubSub notification, asking Buildbucket for the build status
[02:10:21.671] Build status: SCHEDULED
[02:10:26.759] Received PubSub notification, asking Buildbucket for the build status
[02:10:27.003] Build status: STARTED
[02:16:33.698] Handling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.arm64-debug:8892141329016090592:2:0)
[02:16:33.723] Build status: STARTED
[02:16:33.723] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.arm64-debug:8892141329016090592:5:0) after 5m37s
[02:22:11.293] Handling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.arm64-debug:8892141329016090592:5:0)
[02:22:11.365] Build status: STARTED
[02:22:11.365] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.arm64-debug:8892141329016090592:6:0) after 4m54s
[02:27:05.731] Handling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.arm64-debug:8892141329016090592:6:0)
[02:27:05.754] Build status: STARTED
[02:27:05.754] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.arm64-debug:8892141329016090592:7:0) after 4m14s
[02:31:19.769] Handling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.arm64-debug:8892141329016090592:7:0)
[02:31:19.861] Build status: STARTED
[02:31:19.861] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.arm64-debug:8892141329016090592:8:0) after 8m40s
[02:39:59.887] Handling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.arm64-debug:8892141329016090592:8:0)
[02:39:59.912] Build status: STARTED
[02:39:59.912] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.arm64-debug:8892141329016090592:9:0) after 6m2s
[02:46:01.983] Handling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.arm64-debug:8892141329016090592:9:0)
[02:46:02.006] Build status: STARTED
[02:46:02.006] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.arm64-debug:8892141329016090592:10:0) after 1m30s
[02:47:32.048] Handling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.arm64-debug:8892141329016090592:10:0)
[02:47:32.077] Build status: STARTED
[02:47:32.077] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.arm64-debug:8892141329016090592:11:0) after 8m58s
[02:56:30.096] Handling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.arm64-debug:8892141329016090592:11:0)
[02:56:30.111] Build status: STARTED
[02:56:30.111] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.arm64-debug:8892141329016090592:12:0) after 1m23s
[02:57:53.132] Handling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.arm64-debug:8892141329016090592:12:0)
[02:57:53.150] Build status: STARTED
[02:57:53.150] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.arm64-debug:8892141329016090592:13:0) after 6m19s
[03:04:12.710] Handling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.arm64-debug:8892141329016090592:13:0)
[03:04:12.738] Build status: STARTED
[03:04:12.738] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.arm64-debug:8892141329016090592:14:0) after 3m31s
[03:07:43.777] Handling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.arm64-debug:8892141329016090592:14:0)
[03:07:43.791] Build status: STARTED
[03:07:43.791] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.arm64-debug:8892141329016090592:15:0) after 9m24s
[03:17:08.240] Handling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.arm64-debug:8892141329016090592:15:0)
[03:17:08.262] Build status: STARTED
[03:17:08.262] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.arm64-debug:8892141329016090592:16:0) after 6m14s
[03:23:22.283] Handling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.arm64-debug:8892141329016090592:16:0)
[03:23:22.314] Build status: STARTED
[03:23:22.314] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.arm64-debug:8892141329016090592:17:0) after 4m29s
[03:27:51.683] Handling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.arm64-debug:8892141329016090592:17:0)
[03:27:51.716] Build status: STARTED
[03:27:51.716] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.arm64-debug:8892141329016090592:18:0) after 3m45s
[03:31:36.803] Handling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.arm64-debug:8892141329016090592:18:0)
[03:31:36.819] Build status: STARTED
[03:31:36.819] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.arm64-debug:8892141329016090592:19:0) after 1m10s
[03:32:46.951] Handling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.arm64-debug:8892141329016090592:19:0)
[03:32:46.978] Build status: STARTED
[03:32:46.978] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.arm64-debug:8892141329016090592:20:0) after 4m46s
[03:37:33.162] Handling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.arm64-debug:8892141329016090592:20:0)
[03:37:33.188] Build status: STARTED
[03:37:33.188] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.arm64-debug:8892141329016090592:21:0) after 9m48s
[03:47:21.359] Handling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.arm64-debug:8892141329016090592:21:0)
[03:47:21.384] Build status: STARTED
[03:47:21.384] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.arm64-debug:8892141329016090592:22:0) after 5m12s
[03:52:33.549] Handling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.arm64-debug:8892141329016090592:22:0)
[03:52:33.563] Build status: STARTED
[03:52:33.563] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.arm64-debug:8892141329016090592:23:0) after 5m42s
[03:58:16.013] Handling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.arm64-debug:8892141329016090592:23:0)
[03:58:16.061] Build status: STARTED
[03:58:16.061] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.arm64-debug:8892141329016090592:24:0) after 4m42s
[04:02:58.189] Handling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.arm64-debug:8892141329016090592:24:0)
[04:02:58.217] Build status: STARTED
[04:02:58.217] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.arm64-debug:8892141329016090592:25:0) after 1m35s
[04:04:33.241] Handling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.arm64-debug:8892141329016090592:25:0)
[04:04:33.285] Build status: STARTED
[04:04:33.285] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.arm64-debug:8892141329016090592:26:0) after 4m14s
[04:08:47.306] Handling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.arm64-debug:8892141329016090592:26:0)
[04:08:47.325] Build status: STARTED
[04:08:47.325] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.arm64-debug:8892141329016090592:27:0) after 9m19s
[04:18:06.746] Handling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.arm64-debug:8892141329016090592:27:0)
[04:18:06.772] Build status: STARTED
[04:18:06.772] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.arm64-debug:8892141329016090592:28:0) after 6m27s
[04:24:33.797] Handling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.arm64-debug:8892141329016090592:28:0)
[04:24:33.812] Build status: STARTED
[04:24:33.812] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.arm64-debug:8892141329016090592:29:0) after 7m2s
[04:28:52.186] Received PubSub notification, asking Buildbucket for the build status
[04:28:52.205] Build:
{
"id": "8726711266918239217",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "rust_toolchain.core.arm64-debug"
},
"createdBy": "project:fuchsia",
"createTime": "2025-01-04T02:10:20.255586128Z",
"startTime": "2025-01-04T02:10:26.493232457Z",
"endTime": "2025-01-04T04:28:51.728688086Z",
"updateTime": "2025-01-04T04:28:51.728688086Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "third_party/rust",
"id": "8d2c06d151972fefa3f0bbf04ace3beede737145",
"ref": "refs/heads/main"
}
}
}
[04:28:52.205] Invocation finished in 2h18m33.335075607s with status SUCCEEDED