[20:45:42.623] New invocation is queued and will start shortly
[20:45:42.623] Triggered by user:tools-ci-builder@fuchsia-infra.iam.gserviceaccount.com
[20:45:43.695] Starting the invocation (attempt 1)
[20:45:43.721] Popped buildset tag "buildset:commit/gitiles/fuchsia.googlesource.com/third_party/rust/+/0ca92de4733bf31262200c6d37e722f534cef4bc"
[20:45:43.721] Reconstructed gitiles commit from tags
[20:45:43.721] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[20:45:43.721] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[20:45:43.722] Buildbucket request:
{
"requestId": "8908469205307067744",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "rust_toolchain.core.x64-debug"
},
"properties": {
"$fuchsia/checkout": {
"gitiles_commit": {
"host": "fuchsia.googlesource.com",
"id": "2858f20f2e14d8b778d032d71214a5ea71459e5b",
"project": "integration"
},
"rust_toolchain": {
"cas_digest": "a8ec914c9e65f066df1140956ba3ba902b91d415cdf7882f5a38d527102c2c87/394",
"cas_instance": "projects/chromium-swarm/instances/default_instance"
}
},
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8908469205307067744",
"job": "fuchsia/rust_toolchain.core.x64-debug",
"triggers": [
{
"buildbucket": {
"properties": {
"$fuchsia/checkout": {
"gitiles_commit": {
"host": "fuchsia.googlesource.com",
"id": "2858f20f2e14d8b778d032d71214a5ea71459e5b",
"project": "integration"
},
"rust_toolchain": {
"cas_digest": "1e80c7c06f2a72f52a69f18b7e543ede94ffec9343799d53a7957fbae9166b64/394",
"cas_instance": "projects/chromium-swarm/instances/default_instance"
}
},
"rust_toolchain": {
"git_repository": "https://fuchsia.googlesource.com/third_party/rust",
"git_revision": "0ca92de4733bf31262200c6d37e722f534cef4bc"
}
},
"tags": [
"buildset:commit/gitiles/fuchsia.googlesource.com/third_party/rust/+/0ca92de4733bf31262200c6d37e722f534cef4bc",
"gitiles_ref:refs/heads/main",
"parent_buildername:rust-x64-linux-bootstrap",
"user_agent:recipe"
]
},
"id": "3f086b58-a0f8-42b5-80b5-0906ad55b462",
"title": "rust-x64-linux-bootstrap/0"
},
{
"buildbucket": {
"properties": {
"$fuchsia/checkout": {
"gitiles_commit": {
"host": "fuchsia.googlesource.com",
"id": "2858f20f2e14d8b778d032d71214a5ea71459e5b",
"project": "integration"
},
"rust_toolchain": {
"cas_digest": "a8ec914c9e65f066df1140956ba3ba902b91d415cdf7882f5a38d527102c2c87/394",
"cas_instance": "projects/chromium-swarm/instances/default_instance"
}
},
"rust_toolchain": {
"git_repository": "https://fuchsia.googlesource.com/third_party/rust",
"git_revision": "0ca92de4733bf31262200c6d37e722f534cef4bc"
}
},
"tags": [
"buildset:commit/gitiles/fuchsia.googlesource.com/third_party/rust/+/0ca92de4733bf31262200c6d37e722f534cef4bc",
"gitiles_ref:refs/heads/main",
"parent_buildername:rust-x64-linux",
"user_agent:recipe"
]
},
"id": "efa5c626-387f-4408-b2e4-288438501ef7",
"title": "rust-x64-linux/0"
}
]
},
"rust_toolchain": {
"git_repository": "https://fuchsia.googlesource.com/third_party/rust",
"git_revision": "0ca92de4733bf31262200c6d37e722f534cef4bc"
}
},
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "third_party/rust",
"id": "0ca92de4733bf31262200c6d37e722f534cef4bc",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8908469205307067744"
},
{
"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"
}
}
[20:45:44.327] Scheduled build:
{
"id": "8743039143350061297",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "rust_toolchain.core.x64-debug"
},
"createdBy": "project:fuchsia",
"createTime": "2024-07-07T20:45:43.860982861Z",
"updateTime": "2024-07-07T20:45:43.860982861Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "third_party/rust",
"id": "0ca92de4733bf31262200c6d37e722f534cef4bc",
"ref": "refs/heads/main"
}
}
}
[20:45:44.327] Task URL: https://cr-buildbucket.appspot.com/build/8743039143350061297
[20:45:44.327] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8908469205307067744:2:0) after 7m41s
[20:45:45.276] Received PubSub notification, asking Buildbucket for the build status
[20:45:45.306] Build status: SCHEDULED
[20:45:49.902] Received PubSub notification, asking Buildbucket for the build status
[20:45:49.922] Build status: STARTED
[20:53:25.350] Handling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8908469205307067744:2:0)
[20:53:25.537] Build status: STARTED
[20:53:25.537] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8908469205307067744:5:0) after 6m40s
[21:00:05.562] Handling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8908469205307067744:5:0)
[21:00:05.600] Build status: STARTED
[21:00:05.600] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8908469205307067744:6:0) after 7m35s
[21:07:40.817] Handling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8908469205307067744:6:0)
[21:07:40.842] Build status: STARTED
[21:07:40.842] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8908469205307067744:7:0) after 8m12s
[21:15:53.150] Handling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8908469205307067744:7:0)
[21:15:53.183] Build status: STARTED
[21:15:53.183] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8908469205307067744:8:0) after 7m44s
[21:23:37.213] Handling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8908469205307067744:8:0)
[21:23:37.347] Build status: STARTED
[21:23:37.347] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8908469205307067744:9:0) after 9m37s
[21:33:14.364] Handling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8908469205307067744:9:0)
[21:33:14.402] Build status: STARTED
[21:33:14.402] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8908469205307067744:10:0) after 3m30s
[21:36:44.617] Handling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8908469205307067744:10:0)
[21:36:44.636] Build status: STARTED
[21:36:44.636] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8908469205307067744:11:0) after 6m18s
[21:43:02.659] Handling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8908469205307067744:11:0)
[21:43:02.680] Build status: STARTED
[21:43:02.680] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8908469205307067744:12:0) after 9m27s
[21:52:29.732] Handling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8908469205307067744:12:0)
[21:52:29.750] Build status: STARTED
[21:52:29.750] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8908469205307067744:13:0) after 2m41s
[21:55:10.749] Handling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8908469205307067744:13:0)
[21:55:10.769] Build status: STARTED
[21:55:10.769] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8908469205307067744:14:0) after 8m22s
[22:03:33.101] Handling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8908469205307067744:14:0)
[22:03:33.120] Build status: STARTED
[22:03:33.120] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8908469205307067744:15:0) after 8m59s
[22:12:32.144] Handling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8908469205307067744:15:0)
[22:12:32.168] Build status: STARTED
[22:12:32.168] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8908469205307067744:16:0) after 6m12s
[22:18:44.186] Handling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8908469205307067744:16:0)
[22:18:44.209] Build status: STARTED
[22:18:44.209] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8908469205307067744:17:0) after 5m59s
[22:24:43.248] Handling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8908469205307067744:17:0)
[22:24:43.268] Build status: STARTED
[22:24:43.268] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8908469205307067744:18:0) after 5m58s
[22:30:41.351] Handling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8908469205307067744:18:0)
[22:30:41.373] Build status: STARTED
[22:30:41.373] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8908469205307067744:19:0) after 5m37s
[22:36:18.395] Handling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8908469205307067744:19:0)
[22:36:18.412] Build status: STARTED
[22:36:18.412] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8908469205307067744:20:0) after 4m47s
[22:38:46.366] Received PubSub notification, asking Buildbucket for the build status
[22:38:46.386] Build:
{
"id": "8743039143350061297",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "rust_toolchain.core.x64-debug"
},
"createdBy": "project:fuchsia",
"createTime": "2024-07-07T20:45:43.860982861Z",
"startTime": "2024-07-07T20:45:49.393642107Z",
"endTime": "2024-07-07T22:37:46.071460875Z",
"updateTime": "2024-07-07T22:37:46.071460875Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "third_party/rust",
"id": "0ca92de4733bf31262200c6d37e722f534cef4bc",
"ref": "refs/heads/main"
}
}
}
[22:38:46.386] Invocation finished in 1h53m3.776032128s with status SUCCEEDED