[02:57:06.109] New invocation is queued and will start shortly
[02:57:06.109] Triggered by user:tools-ci-builder@fuchsia-infra.iam.gserviceaccount.com
[02:57:07.182] Starting the invocation (attempt 1)
[02:57:07.207] Popped buildset tag "buildset:commit/gitiles/fuchsia.googlesource.com/third_party/rust/+/c2901f543577af99b9cb708f5c0d28525eb7f08f"
[02:57:07.207] Reconstructed gitiles commit from tags
[02:57:07.207] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[02:57:07.207] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[02:57:07.207] Buildbucket request:
{
"requestId": "8918864490508873712",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "rust_toolchain.core.x64-debug"
},
"properties": {
"$fuchsia/checkout": {
"gitiles_commit": {
"host": "fuchsia.googlesource.com",
"id": "0b565b823df39d097915345406ff1eda3025716b",
"project": "integration"
},
"rust_toolchain": {
"cas_digest": "ebd7c7b2d71fae31067c5470e7316f303aa6536d50aeb53e167fc7b70d082a1f/394",
"cas_instance": "projects/chromium-swarm/instances/default_instance"
}
},
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8918864490508873712",
"job": "fuchsia/rust_toolchain.core.x64-debug",
"triggers": [
{
"buildbucket": {
"properties": {
"$fuchsia/checkout": {
"gitiles_commit": {
"host": "fuchsia.googlesource.com",
"id": "0b565b823df39d097915345406ff1eda3025716b",
"project": "integration"
},
"rust_toolchain": {
"cas_digest": "ebd6ea013301d683d7b6d43876b6f409f81016dc6e05623ae07efc89b8591bde/394",
"cas_instance": "projects/chromium-swarm/instances/default_instance"
}
},
"rust_toolchain": {
"git_repository": "https://fuchsia.googlesource.com/third_party/rust",
"git_revision": "c2901f543577af99b9cb708f5c0d28525eb7f08f"
}
},
"tags": [
"buildset:commit/gitiles/fuchsia.googlesource.com/third_party/rust/+/c2901f543577af99b9cb708f5c0d28525eb7f08f",
"gitiles_ref:refs/heads/main",
"parent_buildername:rust-x64-linux-bootstrap",
"user_agent:recipe"
]
},
"id": "bde4f1e2-4df7-4c90-af59-ebd8a2f0ece6",
"title": "rust-x64-linux-bootstrap/0"
},
{
"buildbucket": {
"properties": {
"$fuchsia/checkout": {
"gitiles_commit": {
"host": "fuchsia.googlesource.com",
"id": "0b565b823df39d097915345406ff1eda3025716b",
"project": "integration"
},
"rust_toolchain": {
"cas_digest": "ebd7c7b2d71fae31067c5470e7316f303aa6536d50aeb53e167fc7b70d082a1f/394",
"cas_instance": "projects/chromium-swarm/instances/default_instance"
}
},
"rust_toolchain": {
"git_repository": "https://fuchsia.googlesource.com/third_party/rust",
"git_revision": "c2901f543577af99b9cb708f5c0d28525eb7f08f"
}
},
"tags": [
"buildset:commit/gitiles/fuchsia.googlesource.com/third_party/rust/+/c2901f543577af99b9cb708f5c0d28525eb7f08f",
"gitiles_ref:refs/heads/main",
"parent_buildername:rust-x64-linux",
"user_agent:recipe"
]
},
"id": "35ae232b-d994-47cf-8a03-9cf24720a208",
"title": "rust-x64-linux/0"
}
]
},
"rust_toolchain": {
"git_repository": "https://fuchsia.googlesource.com/third_party/rust",
"git_revision": "c2901f543577af99b9cb708f5c0d28525eb7f08f"
}
},
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "third_party/rust",
"id": "c2901f543577af99b9cb708f5c0d28525eb7f08f",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8918864490508873712"
},
{
"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"
}
}
[02:57:07.684] Scheduled build:
{
"id": "8753434428643865265",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "rust_toolchain.core.x64-debug"
},
"createdBy": "project:fuchsia",
"createTime": "2024-03-15T02:57:07.264466775Z",
"updateTime": "2024-03-15T02:57:07.264466775Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "third_party/rust",
"id": "c2901f543577af99b9cb708f5c0d28525eb7f08f",
"ref": "refs/heads/main"
}
}
}
[02:57:07.684] Task URL: https://cr-buildbucket.appspot.com/build/8753434428643865265
[02:57:07.684] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8918864490508873712:2:0) after 4m44s
[02:57:08.597] Received PubSub notification, asking Buildbucket for the build status
[02:57:08.644] Build status: STARTED
[02:57:09.707] Received PubSub notification, asking Buildbucket for the build status
[02:57:09.794] Build status: STARTED
[03:01:51.726] Handling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8918864490508873712:2:0)
[03:01:51.774] Build status: STARTED
[03:01:51.774] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8918864490508873712:5:0) after 5m1s
[03:06:52.865] Handling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8918864490508873712:5:0)
[03:06:53.043] Build status: STARTED
[03:06:53.044] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8918864490508873712:6:0) after 1m46s
[03:08:39.610] Handling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8918864490508873712:6:0)
[03:08:39.628] Build status: STARTED
[03:08:39.628] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8918864490508873712:7:0) after 8m36s
[03:17:16.159] Handling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8918864490508873712:7:0)
[03:17:16.176] Build status: STARTED
[03:17:16.177] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8918864490508873712:8:0) after 2m27s
[03:19:43.216] Handling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8918864490508873712:8:0)
[03:19:43.238] Build status: STARTED
[03:19:43.238] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8918864490508873712:9:0) after 4m41s
[03:24:24.367] Handling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8918864490508873712:9:0)
[03:24:24.387] Build status: STARTED
[03:24:24.387] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8918864490508873712:10:0) after 9m13s
[03:33:37.742] Handling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8918864490508873712:10:0)
[03:33:37.759] Build status: STARTED
[03:33:37.759] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8918864490508873712:11:0) after 5m23s
[03:39:00.945] Handling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8918864490508873712:11:0)
[03:39:00.965] Build status: STARTED
[03:39:00.965] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8918864490508873712:12:0) after 8m9s
[03:47:09.989] Handling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8918864490508873712:12:0)
[03:47:10.119] Build status: STARTED
[03:47:10.119] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8918864490508873712:13:0) after 3m41s
[03:50:51.090] Handling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8918864490508873712:13:0)
[03:50:51.143] Build status: STARTED
[03:50:51.143] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8918864490508873712:14:0) after 4m1s
[03:54:52.208] Handling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8918864490508873712:14:0)
[03:54:52.226] Build status: STARTED
[03:54:52.226] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8918864490508873712:15:0) after 5m40s
[04:00:32.243] Handling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8918864490508873712:15:0)
[04:00:32.282] Build status: STARTED
[04:00:32.282] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8918864490508873712:16:0) after 8m9s
[04:08:41.403] Handling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8918864490508873712:16:0)
[04:08:41.421] Build status: STARTED
[04:08:41.422] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8918864490508873712:17:0) after 6m16s
[04:14:57.837] Handling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8918864490508873712:17:0)
[04:14:57.859] Build status: STARTED
[04:14:57.859] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8918864490508873712:18:0) after 4m22s
[04:19:19.878] Handling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8918864490508873712:18:0)
[04:19:19.907] Build status: STARTED
[04:19:19.907] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8918864490508873712:19:0) after 3m43s
[04:23:02.992] Handling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8918864490508873712:19:0)
[04:23:03.014] Build status: STARTED
[04:23:03.014] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8918864490508873712:20:0) after 2m48s
[04:25:51.170] Handling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8918864490508873712:20:0)
[04:25:51.191] Build status: STARTED
[04:25:51.191] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8918864490508873712:21:0) after 3m16s
[04:29:07.211] Handling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8918864490508873712:21:0)
[04:29:07.231] Build status: STARTED
[04:29:07.231] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8918864490508873712:22:0) after 2m11s
[04:31:18.273] Handling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8918864490508873712:22:0)
[04:31:18.303] Build status: STARTED
[04:31:18.303] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8918864490508873712:23:0) after 4m39s
[04:35:57.362] Handling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8918864490508873712:23:0)
[04:35:57.387] Build status: STARTED
[04:35:57.387] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8918864490508873712:24:0) after 5m51s
[04:41:48.420] Handling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8918864490508873712:24:0)
[04:41:48.454] Build status: STARTED
[04:41:48.454] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8918864490508873712:25:0) after 7m30s
[04:45:51.654] Received PubSub notification, asking Buildbucket for the build status
[04:45:51.715] Build:
{
"id": "8753434428643865265",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "rust_toolchain.core.x64-debug"
},
"createdBy": "project:fuchsia",
"createTime": "2024-03-15T02:57:07.264466775Z",
"startTime": "2024-03-15T02:57:07.969956Z",
"endTime": "2024-03-15T04:45:49.281134Z",
"updateTime": "2024-03-15T04:45:49.281134Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "third_party/rust",
"id": "c2901f543577af99b9cb708f5c0d28525eb7f08f",
"ref": "refs/heads/main"
}
}
}
[04:45:51.715] Invocation finished in 1h48m45.613990726s with status SUCCEEDED