[13:22:02.389] New invocation is queued and will start shortly
[13:22:02.389] Triggered by user:tools-ci-builder@fuchsia-infra.iam.gserviceaccount.com
[13:22:03.542] Starting the invocation (attempt 1)
[13:22:03.576] Popped buildset tag "buildset:commit/gitiles/fuchsia.googlesource.com/third_party/rust/+/ecda83b30f0f68cf5692855dddc0bc38ee8863fc"
[13:22:03.576] Reconstructed gitiles commit from tags
[13:22:03.576] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[13:22:03.577] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[13:22:03.577] Buildbucket request:
{
"requestId": "8890649516266847408",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "rust_toolchain.core.x64-debug"
},
"properties": {
"$fuchsia/checkout": {
"gitiles_commit": {
"host": "fuchsia.googlesource.com",
"id": "d901bb1c40c0720b00e796630bc92295410428f5",
"project": "integration",
"ref": "refs/heads/releases/canary"
},
"rust_toolchain": {
"cas_digest": "245e2450dabb5a41fe73adf72a9a46f722e2b142fe204c046d63ee8ae8b71368/394",
"cas_instance": "projects/chromium-swarm/instances/default_instance"
}
},
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8890649516266847408",
"job": "fuchsia/rust_toolchain.core.x64-debug",
"triggers": [
{
"buildbucket": {
"properties": {
"$fuchsia/checkout": {
"gitiles_commit": {
"host": "fuchsia.googlesource.com",
"id": "d901bb1c40c0720b00e796630bc92295410428f5",
"project": "integration",
"ref": "refs/heads/releases/canary"
},
"rust_toolchain": {
"cas_digest": "245e2450dabb5a41fe73adf72a9a46f722e2b142fe204c046d63ee8ae8b71368/394",
"cas_instance": "projects/chromium-swarm/instances/default_instance"
}
},
"rust_toolchain": {
"git_repository": "https://fuchsia.googlesource.com/third_party/rust",
"git_revision": "ecda83b30f0f68cf5692855dddc0bc38ee8863fc"
}
},
"tags": [
"buildset:commit/gitiles/fuchsia.googlesource.com/third_party/rust/+/ecda83b30f0f68cf5692855dddc0bc38ee8863fc",
"gitiles_ref:refs/heads/main",
"parent_buildername:rust-x64-linux-bootstrap",
"user_agent:recipe"
]
},
"id": "3b20516f-1e4f-40ef-8c8f-a1217f019f44",
"title": "rust-x64-linux-bootstrap/0"
}
]
},
"rust_toolchain": {
"git_repository": "https://fuchsia.googlesource.com/third_party/rust",
"git_revision": "ecda83b30f0f68cf5692855dddc0bc38ee8863fc"
}
},
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "third_party/rust",
"id": "ecda83b30f0f68cf5692855dddc0bc38ee8863fc",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8890649516266847408"
},
{
"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"
}
}
[13:22:04.042] Scheduled build:
{
"id": "8725219454284542369",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "rust_toolchain.core.x64-debug"
},
"createdBy": "project:fuchsia",
"createTime": "2025-01-20T13:22:03.648167274Z",
"updateTime": "2025-01-20T13:22:03.648167274Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "third_party/rust",
"id": "ecda83b30f0f68cf5692855dddc0bc38ee8863fc",
"ref": "refs/heads/main"
}
}
}
[13:22:04.042] Task URL: https://cr-buildbucket.appspot.com/build/8725219454284542369
[13:22:04.043] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8890649516266847408:2:0) after 7m11s
[13:22:05.026] Received PubSub notification, asking Buildbucket for the build status
[13:22:05.054] Build status: SCHEDULED
[13:22:10.318] Received PubSub notification, asking Buildbucket for the build status
[13:22:10.343] Build status: STARTED
[13:29:15.528] Handling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8890649516266847408:2:0)
[13:29:15.560] Build status: STARTED
[13:29:15.560] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8890649516266847408:5:0) after 5m26s
[13:34:41.580] Handling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8890649516266847408:5:0)
[13:34:41.615] Build status: STARTED
[13:34:41.615] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8890649516266847408:6:0) after 1m3s
[13:35:44.738] Handling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8890649516266847408:6:0)
[13:35:44.759] Build status: STARTED
[13:35:44.759] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8890649516266847408:7:0) after 1m11s
[13:36:55.967] Handling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8890649516266847408:7:0)
[13:36:55.985] Build status: STARTED
[13:36:55.985] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8890649516266847408:8:0) after 6m7s
[13:43:03.056] Handling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8890649516266847408:8:0)
[13:43:03.074] Build status: STARTED
[13:43:03.074] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8890649516266847408:9:0) after 3m42s
[13:46:45.239] Handling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8890649516266847408:9:0)
[13:46:45.257] Build status: STARTED
[13:46:45.258] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8890649516266847408:10:0) after 7m57s
[13:54:42.479] Handling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8890649516266847408:10:0)
[13:54:42.499] Build status: STARTED
[13:54:42.499] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8890649516266847408:11:0) after 2m18s
[13:57:00.837] Handling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8890649516266847408:11:0)
[13:57:00.854] Build status: STARTED
[13:57:00.854] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8890649516266847408:12:0) after 6m18s
[14:03:18.956] Handling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8890649516266847408:12:0)
[14:03:18.978] Build status: STARTED
[14:03:18.978] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8890649516266847408:13:0) after 3m9s
[14:06:28.007] Handling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8890649516266847408:13:0)
[14:06:28.032] Build status: STARTED
[14:06:28.032] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8890649516266847408:14:0) after 6m27s
[14:12:55.034] Handling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8890649516266847408:14:0)
[14:12:55.060] Build status: STARTED
[14:12:55.060] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8890649516266847408:15:0) after 7m8s
[14:20:03.120] Handling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8890649516266847408:15:0)
[14:20:03.139] Build status: STARTED
[14:20:03.139] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8890649516266847408:16:0) after 1m59s
[14:22:02.212] Handling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8890649516266847408:16:0)
[14:22:02.287] Build status: STARTED
[14:22:02.287] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8890649516266847408:17:0) after 6m54s
[14:28:56.507] Handling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8890649516266847408:17:0)
[14:28:56.524] Build status: STARTED
[14:28:56.524] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8890649516266847408:18:0) after 7m21s
[14:36:17.592] Handling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8890649516266847408:18:0)
[14:36:17.624] Build status: STARTED
[14:36:17.624] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8890649516266847408:19:0) after 7m21s
[14:43:38.776] Handling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8890649516266847408:19:0)
[14:43:38.798] Build status: STARTED
[14:43:38.798] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8890649516266847408:20:0) after 1m43s
[14:45:21.899] Handling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8890649516266847408:20:0)
[14:45:21.919] Build status: STARTED
[14:45:21.919] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8890649516266847408:21:0) after 5m59s
[14:51:20.952] Handling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8890649516266847408:21:0)
[14:51:20.972] Build status: STARTED
[14:51:20.972] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8890649516266847408:22:0) after 4m12s
[14:55:33.019] Handling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8890649516266847408:22:0)
[14:55:33.045] Build status: STARTED
[14:55:33.046] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8890649516266847408:23:0) after 2m30s
[14:58:03.141] Handling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8890649516266847408:23:0)
[14:58:03.161] Build status: STARTED
[14:58:03.161] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8890649516266847408:24:0) after 1m45s
[14:59:48.331] Handling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8890649516266847408:24:0)
[14:59:48.352] Build status: STARTED
[14:59:48.352] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8890649516266847408:25:0) after 8m43s
[15:08:31.431] Handling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8890649516266847408:25:0)
[15:08:31.453] Build status: STARTED
[15:08:31.454] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8890649516266847408:26:0) after 6m6s
[15:14:37.657] Handling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8890649516266847408:26:0)
[15:14:37.678] Build status: STARTED
[15:14:37.678] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8890649516266847408:27:0) after 2m34s
[15:14:59.841] Received PubSub notification, asking Buildbucket for the build status
[15:14:59.859] Build:
{
"id": "8725219454284542369",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "rust_toolchain.core.x64-debug"
},
"createdBy": "project:fuchsia",
"createTime": "2025-01-20T13:22:03.648167274Z",
"startTime": "2025-01-20T13:22:10.051587850Z",
"endTime": "2025-01-20T15:14:59.336357195Z",
"updateTime": "2025-01-20T15:14:59.336357195Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "third_party/rust",
"id": "ecda83b30f0f68cf5692855dddc0bc38ee8863fc",
"ref": "refs/heads/main"
}
}
}
[15:14:59.859] Invocation finished in 1h52m57.48587106s with status SUCCEEDED