[18:38:17.822] New invocation is queued and will start shortly
[18:38:17.822] Triggered by user:tools-ci-builder@fuchsia-infra.iam.gserviceaccount.com
[18:38:18.921] Starting the invocation (attempt 1)
[18:38:18.957] Popped buildset tag "buildset:commit/gitiles/fuchsia.googlesource.com/third_party/rust/+/b6a23b853719c8c22c022993c9eb2871b09fc2b9"
[18:38:18.958] Reconstructed gitiles commit from tags
[18:38:18.958] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[18:38:18.958] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[18:38:18.966] Buildbucket request:
{
"requestId": "8920707811922604544",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "rust_toolchain.core.x64-debug"
},
"properties": {
"$fuchsia/checkout": {
"gitiles_commit": {
"host": "fuchsia.googlesource.com",
"id": "cf22571fa8fc62b7d2d9f1ff570a9a2ae3e934dd",
"project": "integration"
},
"rust_toolchain": {
"cas_digest": "1a5659f289bd8f4ad8fb89017541be6e2c6acd53d640024d1d666b4fe0a52fba/394",
"cas_instance": "projects/chromium-swarm/instances/default_instance"
}
},
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8920707811922604544",
"job": "fuchsia/rust_toolchain.core.x64-debug",
"triggers": [
{
"buildbucket": {
"properties": {
"$fuchsia/checkout": {
"gitiles_commit": {
"host": "fuchsia.googlesource.com",
"id": "cf22571fa8fc62b7d2d9f1ff570a9a2ae3e934dd",
"project": "integration"
},
"rust_toolchain": {
"cas_digest": "d7a5bd16c5a4b5b8146455ec08f61eafe90eb3e9f2a9235a152047d7e6f1b030/394",
"cas_instance": "projects/chromium-swarm/instances/default_instance"
}
},
"rust_toolchain": {
"git_repository": "https://fuchsia.googlesource.com/third_party/rust",
"git_revision": "b6a23b853719c8c22c022993c9eb2871b09fc2b9"
}
},
"tags": [
"buildset:commit/gitiles/fuchsia.googlesource.com/third_party/rust/+/b6a23b853719c8c22c022993c9eb2871b09fc2b9",
"gitiles_ref:refs/heads/main",
"parent_buildername:rust-x64-linux-bootstrap",
"user_agent:recipe"
]
},
"id": "67095085-8f31-41df-874d-881026b18382",
"title": "rust-x64-linux-bootstrap/0"
},
{
"buildbucket": {
"properties": {
"$fuchsia/checkout": {
"gitiles_commit": {
"host": "fuchsia.googlesource.com",
"id": "cf22571fa8fc62b7d2d9f1ff570a9a2ae3e934dd",
"project": "integration"
},
"rust_toolchain": {
"cas_digest": "1a5659f289bd8f4ad8fb89017541be6e2c6acd53d640024d1d666b4fe0a52fba/394",
"cas_instance": "projects/chromium-swarm/instances/default_instance"
}
},
"rust_toolchain": {
"git_repository": "https://fuchsia.googlesource.com/third_party/rust",
"git_revision": "b6a23b853719c8c22c022993c9eb2871b09fc2b9"
}
},
"tags": [
"buildset:commit/gitiles/fuchsia.googlesource.com/third_party/rust/+/b6a23b853719c8c22c022993c9eb2871b09fc2b9",
"gitiles_ref:refs/heads/main",
"parent_buildername:rust-x64-linux",
"user_agent:recipe"
]
},
"id": "5d488a23-e7e5-4d4f-993a-ed9613e6b908",
"title": "rust-x64-linux/0"
}
]
},
"rust_toolchain": {
"git_repository": "https://fuchsia.googlesource.com/third_party/rust",
"git_revision": "b6a23b853719c8c22c022993c9eb2871b09fc2b9"
}
},
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "third_party/rust",
"id": "b6a23b853719c8c22c022993c9eb2871b09fc2b9",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8920707811922604544"
},
{
"key": "scheduler_job_id",
"value": "fuchsia/rust_toolchain.core.x64-debug"
},
{
"key": "user_agent",
"value": "luci-scheduler"
},
{
"key": "parent_buildername",
"value": "rust-x64-linux"
},
{
"key": "user_agent",
"value": "recipe"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[18:38:19.436] Scheduled build:
{
"id": "8755277749993221841",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "rust_toolchain.core.x64-debug"
},
"createdBy": "project:fuchsia",
"createTime": "2024-02-23T18:38:19.036065906Z",
"updateTime": "2024-02-23T18:38:19.036065906Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "third_party/rust",
"id": "b6a23b853719c8c22c022993c9eb2871b09fc2b9",
"ref": "refs/heads/main"
}
}
}
[18:38:19.436] Task URL: https://cr-buildbucket.appspot.com/build/8755277749993221841
[18:38:19.436] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8920707811922604544:2:0) after 3m48s
[18:38:20.389] Received PubSub notification, asking Buildbucket for the build status
[18:38:20.417] Build status: SCHEDULED
[18:42:07.471] Handling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8920707811922604544:2:0)
[18:42:07.492] Build status: SCHEDULED
[18:42:07.492] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8920707811922604544:4:0) after 4m37s
[18:46:44.541] Handling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8920707811922604544:4:0)
[18:46:44.566] Build status: SCHEDULED
[18:46:44.566] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8920707811922604544:5:0) after 8m45s
[18:55:29.600] Handling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8920707811922604544:5:0)
[18:55:29.622] Build status: SCHEDULED
[18:55:29.622] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8920707811922604544:6:0) after 6m42s
[19:02:11.691] Handling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8920707811922604544:6:0)
[19:02:11.725] Build status: SCHEDULED
[19:02:11.725] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8920707811922604544:7:0) after 4m6s
[19:06:17.744] Handling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8920707811922604544:7:0)
[19:06:17.761] Build status: SCHEDULED
[19:06:17.761] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8920707811922604544:8:0) after 9m53s
[19:16:10.922] Handling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8920707811922604544:8:0)
[19:16:10.958] Build status: SCHEDULED
[19:16:10.958] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8920707811922604544:9:0) after 9m32s
[19:25:43.063] Handling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8920707811922604544:9:0)
[19:25:43.095] Build status: SCHEDULED
[19:25:43.095] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8920707811922604544:10:0) after 9m26s
[19:35:09.161] Handling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8920707811922604544:10:0)
[19:35:09.211] Build status: SCHEDULED
[19:35:09.211] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8920707811922604544:11:0) after 3m0s
[19:38:09.342] Handling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8920707811922604544:11:0)
[19:38:09.362] Build status: SCHEDULED
[19:38:09.362] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8920707811922604544:12:0) after 5m52s
[19:44:01.476] Handling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8920707811922604544:12:0)
[19:44:01.501] Build status: SCHEDULED
[19:44:01.501] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8920707811922604544:13:0) after 6m31s
[19:47:24.885] Received PubSub notification, asking Buildbucket for the build status
[19:47:24.932] Build status: STARTED
[19:50:32.513] Handling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8920707811922604544:13:0)
[19:50:32.535] Build status: STARTED
[19:50:32.535] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8920707811922604544:15:0) after 8m52s
[19:59:24.585] Handling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8920707811922604544:15:0)
[19:59:24.607] Build status: STARTED
[19:59:24.607] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8920707811922604544:16:0) after 1m2s
[20:00:26.638] Handling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8920707811922604544:16:0)
[20:00:26.726] Build status: STARTED
[20:00:26.726] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8920707811922604544:17:0) after 8m41s
[20:09:07.750] Handling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8920707811922604544:17:0)
[20:09:07.769] Build status: STARTED
[20:09:07.769] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8920707811922604544:18:0) after 3m9s
[20:12:16.794] Handling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8920707811922604544:18:0)
[20:12:16.814] Build status: STARTED
[20:12:16.814] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8920707811922604544:19:0) after 1m3s
[20:13:19.854] Handling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8920707811922604544:19:0)
[20:13:19.883] Build status: STARTED
[20:13:19.883] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8920707811922604544:20:0) after 7m55s
[20:21:15.015] Handling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8920707811922604544:20:0)
[20:21:15.064] Build status: STARTED
[20:21:15.064] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8920707811922604544:21:0) after 2m15s
[20:23:30.269] Handling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8920707811922604544:21:0)
[20:23:30.289] Build status: STARTED
[20:23:30.289] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8920707811922604544:22:0) after 9m12s
[20:32:42.375] Handling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8920707811922604544:22:0)
[20:32:42.397] Build status: STARTED
[20:32:42.397] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8920707811922604544:23:0) after 9m10s
[20:41:52.424] Handling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8920707811922604544:23:0)
[20:41:52.444] Build status: STARTED
[20:41:52.444] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8920707811922604544:24:0) after 2m20s
[20:44:12.656] Handling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8920707811922604544:24:0)
[20:44:12.676] Build status: STARTED
[20:44:12.676] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8920707811922604544:25:0) after 7m52s
[20:52:04.702] Handling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8920707811922604544:25:0)
[20:52:04.794] Build status: STARTED
[20:52:04.794] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8920707811922604544:26:0) after 5m43s
[20:57:47.817] Handling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8920707811922604544:26:0)
[20:57:47.848] Build status: STARTED
[20:57:47.848] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8920707811922604544:27:0) after 5m10s
[21:02:57.967] Handling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8920707811922604544:27:0)
[21:02:57.988] Build status: STARTED
[21:02:57.988] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8920707811922604544:28:0) after 7m59s
[21:10:57.057] Handling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8920707811922604544:28:0)
[21:10:57.083] Build status: STARTED
[21:10:57.084] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8920707811922604544:29:0) after 5m30s
[21:16:27.113] Handling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8920707811922604544:29:0)
[21:16:27.144] Build status: STARTED
[21:16:27.144] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8920707811922604544:30:0) after 2m11s
[21:18:38.176] Handling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8920707811922604544:30:0)
[21:18:38.201] Build status: STARTED
[21:18:38.201] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8920707811922604544:31:0) after 2m8s
[21:20:46.226] Handling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8920707811922604544:31:0)
[21:20:46.312] Build status: STARTED
[21:20:46.312] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8920707811922604544:32:0) after 9m16s
[21:30:02.335] Handling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8920707811922604544:32:0)
[21:30:02.360] Build status: STARTED
[21:30:02.360] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8920707811922604544:33:0) after 1m16s
[21:31:18.373] Handling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8920707811922604544:33:0)
[21:31:18.405] Build status: STARTED
[21:31:18.405] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8920707811922604544:34:0) after 4m23s
[21:33:42.455] Received PubSub notification, asking Buildbucket for the build status
[21:33:42.478] Build:
{
"id": "8755277749993221841",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "rust_toolchain.core.x64-debug"
},
"createdBy": "project:fuchsia",
"createTime": "2024-02-23T18:38:19.036065906Z",
"startTime": "2024-02-23T19:47:24.350909Z",
"endTime": "2024-02-23T21:33:41.390221Z",
"updateTime": "2024-02-23T21:33:41.390221Z",
"status": "FAILURE",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "third_party/rust",
"id": "b6a23b853719c8c22c022993c9eb2871b09fc2b9",
"ref": "refs/heads/main"
}
}
}
[21:33:42.478] Invocation finished in 2h55m24.665736211s with status FAILED