[11:37:04.790] New invocation is queued and will start shortly
[11:37:04.790] Triggered by user:tools-ci-builder@fuchsia-infra.iam.gserviceaccount.com
[11:37:06.047] Starting the invocation (attempt 1)
[11:37:06.079] Popped buildset tag "buildset:commit/gitiles/fuchsia.googlesource.com/third_party/rust/+/a772336fb3fbd1fe4493077fcfe04e0221296a99"
[11:37:06.079] Reconstructed gitiles commit from tags
[11:37:06.079] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[11:37:06.080] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[11:37:06.080] Buildbucket request:
{
"requestId": "8901437158778463648",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "rust_toolchain.core.x64-debug"
},
"properties": {
"$fuchsia/checkout": {
"gitiles_commit": {
"host": "fuchsia.googlesource.com",
"id": "9d94b8bd532e3ecb6bb5513b55ed4120eef367ac",
"project": "integration",
"ref": "refs/heads/releases/canary"
},
"rust_toolchain": {
"cas_digest": "15bd5b36eb10af48c75705a1ab49752e6032e6310b89cb0bae3f12176c572cdd/394",
"cas_instance": "projects/chromium-swarm/instances/default_instance"
}
},
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8901437158778463648",
"job": "fuchsia/rust_toolchain.core.x64-debug",
"triggers": [
{
"buildbucket": {
"properties": {
"$fuchsia/checkout": {
"gitiles_commit": {
"host": "fuchsia.googlesource.com",
"id": "9d94b8bd532e3ecb6bb5513b55ed4120eef367ac",
"project": "integration",
"ref": "refs/heads/releases/canary"
},
"rust_toolchain": {
"cas_digest": "15bd5b36eb10af48c75705a1ab49752e6032e6310b89cb0bae3f12176c572cdd/394",
"cas_instance": "projects/chromium-swarm/instances/default_instance"
}
},
"rust_toolchain": {
"git_repository": "https://fuchsia.googlesource.com/third_party/rust",
"git_revision": "a772336fb3fbd1fe4493077fcfe04e0221296a99"
}
},
"tags": [
"buildset:commit/gitiles/fuchsia.googlesource.com/third_party/rust/+/a772336fb3fbd1fe4493077fcfe04e0221296a99",
"gitiles_ref:refs/heads/main",
"parent_buildername:rust-x64-linux-bootstrap",
"user_agent:recipe"
]
},
"id": "c10d847f-31d4-4105-9200-4dc147856f8d",
"title": "rust-x64-linux-bootstrap/0"
}
]
},
"rust_toolchain": {
"git_repository": "https://fuchsia.googlesource.com/third_party/rust",
"git_revision": "a772336fb3fbd1fe4493077fcfe04e0221296a99"
}
},
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "third_party/rust",
"id": "a772336fb3fbd1fe4493077fcfe04e0221296a99",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8901437158778463648"
},
{
"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"
}
}
[11:37:06.515] Scheduled build:
{
"id": "8736007096697385041",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "rust_toolchain.core.x64-debug"
},
"createdBy": "project:fuchsia",
"createTime": "2024-09-23T11:37:06.144394325Z",
"updateTime": "2024-09-23T11:37:06.144394325Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "third_party/rust",
"id": "a772336fb3fbd1fe4493077fcfe04e0221296a99",
"ref": "refs/heads/main"
}
}
}
[11:37:06.515] Task URL: https://cr-buildbucket.appspot.com/build/8736007096697385041
[11:37:06.515] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8901437158778463648:2:0) after 1m16s
[11:37:07.440] Received PubSub notification, asking Buildbucket for the build status
[11:37:07.462] Build status: SCHEDULED
[11:37:13.361] Received PubSub notification, asking Buildbucket for the build status
[11:37:13.380] Build status: STARTED
[11:38:22.532] Handling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8901437158778463648:2:0)
[11:38:22.556] Build status: STARTED
[11:38:22.557] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8901437158778463648:5:0) after 8m26s
[11:46:48.593] Handling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8901437158778463648:5:0)
[11:46:48.613] Build status: STARTED
[11:46:48.613] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8901437158778463648:6:0) after 3m24s
[11:50:12.634] Handling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8901437158778463648:6:0)
[11:50:12.659] Build status: STARTED
[11:50:12.659] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8901437158778463648:7:0) after 7m38s
[11:57:50.693] Handling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8901437158778463648:7:0)
[11:57:50.738] Build status: STARTED
[11:57:50.738] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8901437158778463648:8:0) after 4m54s
[12:02:44.743] Handling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8901437158778463648:8:0)
[12:02:44.762] Build status: STARTED
[12:02:44.762] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8901437158778463648:9:0) after 6m16s
[12:09:00.792] Handling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8901437158778463648:9:0)
[12:09:00.808] Build status: STARTED
[12:09:00.808] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8901437158778463648:10:0) after 5m19s
[12:14:19.826] Handling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8901437158778463648:10:0)
[12:14:19.853] Build status: STARTED
[12:14:19.853] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8901437158778463648:11:0) after 3m35s
[12:17:54.949] Handling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8901437158778463648:11:0)
[12:17:54.972] Build status: STARTED
[12:17:54.972] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8901437158778463648:12:0) after 7m22s
[12:25:17.240] Handling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8901437158778463648:12:0)
[12:25:17.261] Build status: STARTED
[12:25:17.261] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8901437158778463648:13:0) after 9m23s
[12:34:40.348] Handling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8901437158778463648:13:0)
[12:34:40.364] Build status: STARTED
[12:34:40.364] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8901437158778463648:14:0) after 5m18s
[12:39:58.415] Handling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8901437158778463648:14:0)
[12:39:58.436] Build status: STARTED
[12:39:58.436] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8901437158778463648:15:0) after 5m27s
[12:45:25.458] Handling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8901437158778463648:15:0)
[12:45:25.475] Build status: STARTED
[12:45:25.475] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8901437158778463648:16:0) after 4m56s
[12:50:21.545] Handling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8901437158778463648:16:0)
[12:50:21.572] Build status: STARTED
[12:50:21.572] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8901437158778463648:17:0) after 9m2s
[12:59:23.590] Handling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8901437158778463648:17:0)
[12:59:23.609] Build status: STARTED
[12:59:23.609] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8901437158778463648:18:0) after 4m35s
[13:03:58.827] Handling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8901437158778463648:18:0)
[13:03:58.891] Build status: STARTED
[13:03:58.891] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8901437158778463648:19:0) after 9m8s
[13:13:07.405] Handling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8901437158778463648:19:0)
[13:13:07.423] Build status: STARTED
[13:13:07.423] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8901437158778463648:20:0) after 5m3s
[13:18:10.543] Handling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8901437158778463648:20:0)
[13:18:10.569] Build status: STARTED
[13:18:10.569] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8901437158778463648:21:0) after 4m24s
[13:22:34.700] Handling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8901437158778463648:21:0)
[13:22:34.719] Build status: STARTED
[13:22:34.719] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8901437158778463648:22:0) after 4m22s
[13:26:56.736] Handling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8901437158778463648:22:0)
[13:26:56.753] Build status: STARTED
[13:26:56.753] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8901437158778463648:23:0) after 5m4s
[13:32:00.730] Handling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8901437158778463648:23:0)
[13:32:00.751] Build status: STARTED
[13:32:00.751] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8901437158778463648:24:0) after 7m9s
[13:39:09.771] Handling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8901437158778463648:24:0)
[13:39:09.795] Build status: STARTED
[13:39:09.795] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8901437158778463648:25:0) after 4m30s
[13:43:39.814] Handling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8901437158778463648:25:0)
[13:43:39.867] Build status: STARTED
[13:43:39.867] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8901437158778463648:26:0) after 6m51s
[13:50:30.884] Handling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8901437158778463648:26:0)
[13:50:30.913] Build status: STARTED
[13:50:30.913] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8901437158778463648:27:0) after 3m9s
[13:53:39.964] Handling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8901437158778463648:27:0)
[13:53:40.060] Build status: STARTED
[13:53:40.060] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8901437158778463648:28:0) after 9m28s
[14:03:08.563] Handling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8901437158778463648:28:0)
[14:03:08.636] Build status: STARTED
[14:03:08.636] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8901437158778463648:29:0) after 4m31s
[14:07:39.960] Handling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8901437158778463648:29:0)
[14:07:39.995] Build status: STARTED
[14:07:39.995] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8901437158778463648:30:0) after 9m27s
[14:17:07.119] Handling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8901437158778463648:30:0)
[14:17:07.142] Build status: STARTED
[14:17:07.142] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8901437158778463648:31:0) after 3m24s
[14:20:31.312] Handling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8901437158778463648:31:0)
[14:20:31.406] Build status: STARTED
[14:20:31.407] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8901437158778463648:32:0) after 7m24s
[14:27:32.184] Received PubSub notification, asking Buildbucket for the build status
[14:27:32.208] Build:
{
"id": "8736007096697385041",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "rust_toolchain.core.x64-debug"
},
"createdBy": "project:fuchsia",
"createTime": "2024-09-23T11:37:06.144394325Z",
"startTime": "2024-09-23T11:37:13.174646861Z",
"endTime": "2024-09-23T14:27:31.801492366Z",
"updateTime": "2024-09-23T14:27:31.801492366Z",
"status": "INFRA_FAILURE",
"statusDetails": {
"timeout": {
}
},
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "third_party/rust",
"id": "a772336fb3fbd1fe4493077fcfe04e0221296a99",
"ref": "refs/heads/main"
}
}
}
[14:27:32.208] Invocation finished in 2h50m27.431407982s with status FAILED