[19:30:32.202] New invocation is queued and will start shortly
[19:30:32.202] Triggered by user:tools-ci-builder@fuchsia-infra.iam.gserviceaccount.com
[19:30:33.427] Starting the invocation (attempt 1)
[19:30:33.453] Popped buildset tag "buildset:commit/gitiles/fuchsia.googlesource.com/third_party/rust/+/30f74ff0dc4d66debc8b50724c446f817e5f75f4"
[19:30:33.453] Reconstructed gitiles commit from tags
[19:30:33.453] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[19:30:33.453] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[19:30:33.453] Buildbucket request:
{
"requestId": "8918892585956581616",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "rust_toolchain.core.x64-debug"
},
"properties": {
"$fuchsia/checkout": {
"gitiles_commit": {
"host": "fuchsia.googlesource.com",
"id": "ca83b8a87ca3754f13d26962b51225ec57656c47",
"project": "integration"
},
"rust_toolchain": {
"cas_digest": "bb7f78efb3859e3098aff631a49117f16d2e6d3c47b828c74e90a0c0efe8a2e5/394",
"cas_instance": "projects/chromium-swarm/instances/default_instance"
}
},
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8918892585956581616",
"job": "fuchsia/rust_toolchain.core.x64-debug",
"triggers": [
{
"buildbucket": {
"properties": {
"$fuchsia/checkout": {
"gitiles_commit": {
"host": "fuchsia.googlesource.com",
"id": "ca83b8a87ca3754f13d26962b51225ec57656c47",
"project": "integration"
},
"rust_toolchain": {
"cas_digest": "bb7f78efb3859e3098aff631a49117f16d2e6d3c47b828c74e90a0c0efe8a2e5/394",
"cas_instance": "projects/chromium-swarm/instances/default_instance"
}
},
"rust_toolchain": {
"git_repository": "https://fuchsia.googlesource.com/third_party/rust",
"git_revision": "30f74ff0dc4d66debc8b50724c446f817e5f75f4"
}
},
"tags": [
"buildset:commit/gitiles/fuchsia.googlesource.com/third_party/rust/+/30f74ff0dc4d66debc8b50724c446f817e5f75f4",
"gitiles_ref:refs/heads/main",
"parent_buildername:rust-x64-linux",
"user_agent:recipe"
]
},
"id": "91ef1e25-a622-4cbe-8c60-aec032af7e7d",
"title": "rust-x64-linux/0"
}
]
},
"rust_toolchain": {
"git_repository": "https://fuchsia.googlesource.com/third_party/rust",
"git_revision": "30f74ff0dc4d66debc8b50724c446f817e5f75f4"
}
},
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "third_party/rust",
"id": "30f74ff0dc4d66debc8b50724c446f817e5f75f4",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8918892585956581616"
},
{
"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"
}
}
[19:30:33.923] Scheduled build:
{
"id": "8753462523924270001",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "rust_toolchain.core.x64-debug"
},
"createdBy": "project:fuchsia",
"createTime": "2024-03-14T19:30:33.516216783Z",
"updateTime": "2024-03-14T19:30:33.516216783Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "third_party/rust",
"id": "30f74ff0dc4d66debc8b50724c446f817e5f75f4",
"ref": "refs/heads/main"
}
}
}
[19:30:33.923] Task URL: https://cr-buildbucket.appspot.com/build/8753462523924270001
[19:30:33.923] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8918892585956581616:2:0) after 1m32s
[19:30:34.212] Received PubSub notification, asking Buildbucket for the build status
[19:30:34.248] Build status: SCHEDULED
[19:30:38.959] Received PubSub notification, asking Buildbucket for the build status
[19:30:38.990] Build status: STARTED
[19:32:05.958] Handling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8918892585956581616:2:0)
[19:32:05.975] Build status: STARTED
[19:32:05.975] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8918892585956581616:5:0) after 7m27s
[19:39:33.096] Handling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8918892585956581616:5:0)
[19:39:33.119] Build status: STARTED
[19:39:33.119] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8918892585956581616:6:0) after 9m17s
[19:48:50.139] Handling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8918892585956581616:6:0)
[19:48:50.169] Build status: STARTED
[19:48:50.169] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8918892585956581616:7:0) after 5m11s
[19:54:01.185] Handling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8918892585956581616:7:0)
[19:54:01.282] Build status: STARTED
[19:54:01.282] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8918892585956581616:8:0) after 7m8s
[20:01:09.320] Handling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8918892585956581616:8:0)
[20:01:09.339] Build status: STARTED
[20:01:09.339] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8918892585956581616:9:0) after 2m30s
[20:03:39.497] Handling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8918892585956581616:9:0)
[20:03:39.518] Build status: STARTED
[20:03:39.518] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8918892585956581616:10:0) after 6m33s
[20:10:12.578] Handling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8918892585956581616:10:0)
[20:10:12.607] Build status: STARTED
[20:10:12.607] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8918892585956581616:11:0) after 8m17s
[20:18:29.629] Handling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8918892585956581616:11:0)
[20:18:29.665] Build status: STARTED
[20:18:29.665] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8918892585956581616:12:0) after 7m0s
[20:25:29.784] Handling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8918892585956581616:12:0)
[20:25:29.804] Build status: STARTED
[20:25:29.804] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8918892585956581616:13:0) after 2m43s
[20:28:12.883] Handling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8918892585956581616:13:0)
[20:28:12.916] Build status: STARTED
[20:28:12.917] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8918892585956581616:14:0) after 6m32s
[20:34:44.936] Handling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8918892585956581616:14:0)
[20:34:44.954] Build status: STARTED
[20:34:44.954] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8918892585956581616:15:0) after 7m15s
[20:41:59.965] Handling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8918892585956581616:15:0)
[20:41:59.992] Build status: STARTED
[20:41:59.992] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8918892585956581616:16:0) after 8m45s
[20:50:45.048] Handling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8918892585956581616:16:0)
[20:50:45.072] Build status: STARTED
[20:50:45.072] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8918892585956581616:17:0) after 1m41s
[20:52:26.155] Handling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8918892585956581616:17:0)
[20:52:26.259] Build status: STARTED
[20:52:26.259] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8918892585956581616:18:0) after 8m40s
[21:01:06.277] Handling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8918892585956581616:18:0)
[21:01:06.299] Build status: STARTED
[21:01:06.299] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8918892585956581616:19:0) after 1m51s
[21:02:57.321] Handling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8918892585956581616:19:0)
[21:02:57.351] Build status: STARTED
[21:02:57.351] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8918892585956581616:20:0) after 3m52s
[21:06:49.376] Handling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8918892585956581616:20:0)
[21:06:49.408] Build status: STARTED
[21:06:49.408] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8918892585956581616:21:0) after 9m28s
[21:16:17.425] Handling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8918892585956581616:21:0)
[21:16:17.453] Build status: STARTED
[21:16:17.453] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8918892585956581616:22:0) after 9m55s
[21:17:52.092] Received PubSub notification, asking Buildbucket for the build status
[21:17:52.120] Build:
{
"id": "8753462523924270001",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "rust_toolchain.core.x64-debug"
},
"createdBy": "project:fuchsia",
"createTime": "2024-03-14T19:30:33.516216783Z",
"startTime": "2024-03-14T19:30:38.272592Z",
"endTime": "2024-03-14T21:17:50.563924Z",
"updateTime": "2024-03-14T21:17:50.563924Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "third_party/rust",
"id": "30f74ff0dc4d66debc8b50724c446f817e5f75f4",
"ref": "refs/heads/main"
}
}
}
[21:17:52.120] Invocation finished in 1h47m19.92490597s with status SUCCEEDED