[02:54:52.968] New invocation is queued and will start shortly
[02:54:52.968] Triggered by user:tools-ci-builder@fuchsia-infra.iam.gserviceaccount.com
[02:54:54.126] Starting the invocation (attempt 1)
[02:54:54.152] Popped buildset tag "buildset:commit/gitiles/fuchsia.googlesource.com/third_party/rust/+/67d09736ea4be93216e5e2c37c68a38d7bf99968"
[02:54:54.152] Reconstructed gitiles commit from tags
[02:54:54.152] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[02:54:54.152] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[02:54:54.152] Buildbucket request:
{
"requestId": "8904822100331162992",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "rust_toolchain.core.x64-debug"
},
"properties": {
"$fuchsia/checkout": {
"gitiles_commit": {
"host": "fuchsia.googlesource.com",
"id": "de448aa2420b3798242732d406905a2a152d9620",
"project": "integration",
"ref": "refs/heads/releases/canary"
},
"rust_toolchain": {
"cas_digest": "38baff2f9220429aa39c7349cb5d9603739d682d21c39d7f4501a7c9ce8825b3/394",
"cas_instance": "projects/chromium-swarm/instances/default_instance"
}
},
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8904822100331162992",
"job": "fuchsia/rust_toolchain.core.x64-debug",
"triggers": [
{
"buildbucket": {
"properties": {
"$fuchsia/checkout": {
"gitiles_commit": {
"host": "fuchsia.googlesource.com",
"id": "de448aa2420b3798242732d406905a2a152d9620",
"project": "integration",
"ref": "refs/heads/releases/canary"
},
"rust_toolchain": {
"cas_digest": "6e58c2863817089ff71dd0278dbcd99fabe546ce0da5168b3ef036f2505ada37/394",
"cas_instance": "projects/chromium-swarm/instances/default_instance"
}
},
"rust_toolchain": {
"git_repository": "https://fuchsia.googlesource.com/third_party/rust",
"git_revision": "67d09736ea4be93216e5e2c37c68a38d7bf99968"
}
},
"tags": [
"buildset:commit/gitiles/fuchsia.googlesource.com/third_party/rust/+/67d09736ea4be93216e5e2c37c68a38d7bf99968",
"gitiles_ref:refs/heads/main",
"parent_buildername:rust-x64-linux-bootstrap",
"user_agent:recipe"
]
},
"id": "8b44e5c6-8aa4-4554-89ad-11225fe53aa2",
"title": "rust-x64-linux-bootstrap/0"
},
{
"buildbucket": {
"properties": {
"$fuchsia/checkout": {
"gitiles_commit": {
"host": "fuchsia.googlesource.com",
"id": "de448aa2420b3798242732d406905a2a152d9620",
"project": "integration",
"ref": "refs/heads/releases/canary"
},
"rust_toolchain": {
"cas_digest": "38baff2f9220429aa39c7349cb5d9603739d682d21c39d7f4501a7c9ce8825b3/394",
"cas_instance": "projects/chromium-swarm/instances/default_instance"
}
},
"rust_toolchain": {
"git_repository": "https://fuchsia.googlesource.com/third_party/rust",
"git_revision": "67d09736ea4be93216e5e2c37c68a38d7bf99968"
}
},
"tags": [
"buildset:commit/gitiles/fuchsia.googlesource.com/third_party/rust/+/67d09736ea4be93216e5e2c37c68a38d7bf99968",
"gitiles_ref:refs/heads/main",
"parent_buildername:rust-x64-linux",
"user_agent:recipe"
]
},
"id": "2410de23-f0cf-4eaa-a879-16e6f798f6b7",
"title": "rust-x64-linux/0"
}
]
},
"rust_toolchain": {
"git_repository": "https://fuchsia.googlesource.com/third_party/rust",
"git_revision": "67d09736ea4be93216e5e2c37c68a38d7bf99968"
}
},
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "third_party/rust",
"id": "67d09736ea4be93216e5e2c37c68a38d7bf99968",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8904822100331162992"
},
{
"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:54:54.556] Scheduled build:
{
"id": "8739392038358221441",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "rust_toolchain.core.x64-debug"
},
"createdBy": "project:fuchsia",
"createTime": "2024-08-17T02:54:54.220263943Z",
"updateTime": "2024-08-17T02:54:54.220263943Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "third_party/rust",
"id": "67d09736ea4be93216e5e2c37c68a38d7bf99968",
"ref": "refs/heads/main"
}
}
}
[02:54:54.556] Task URL: https://cr-buildbucket.appspot.com/build/8739392038358221441
[02:54:54.556] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8904822100331162992:2:0) after 6m19s
[02:54:55.520] Received PubSub notification, asking Buildbucket for the build status
[02:54:55.538] Build status: SCHEDULED
[02:55:00.024] Received PubSub notification, asking Buildbucket for the build status
[02:55:00.049] Build status: STARTED
[03:01:13.569] Handling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8904822100331162992:2:0)
[03:01:13.589] Build status: STARTED
[03:01:13.589] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8904822100331162992:5:0) after 2m30s
[03:03:43.742] Handling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8904822100331162992:5:0)
[03:03:43.765] Build status: STARTED
[03:03:43.765] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8904822100331162992:6:0) after 3m41s
[03:07:24.857] Handling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8904822100331162992:6:0)
[03:07:24.880] Build status: STARTED
[03:07:24.880] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8904822100331162992:7:0) after 1m18s
[03:08:42.910] Handling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8904822100331162992:7:0)
[03:08:42.944] Build status: STARTED
[03:08:42.944] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8904822100331162992:8:0) after 9m55s
[03:18:38.362] Handling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8904822100331162992:8:0)
[03:18:38.446] Build status: STARTED
[03:18:38.446] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8904822100331162992:9:0) after 1m43s
[03:20:21.461] Handling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8904822100331162992:9:0)
[03:20:21.502] Build status: STARTED
[03:20:21.502] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8904822100331162992:10:0) after 1m36s
[03:21:57.518] Handling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8904822100331162992:10:0)
[03:21:57.538] Build status: STARTED
[03:21:57.538] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8904822100331162992:11:0) after 7m34s
[03:29:31.561] Handling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8904822100331162992:11:0)
[03:29:31.582] Build status: STARTED
[03:29:31.582] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8904822100331162992:12:0) after 9m55s
[03:39:26.742] Handling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8904822100331162992:12:0)
[03:39:26.769] Build status: STARTED
[03:39:26.769] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8904822100331162992:13:0) after 4m33s
[03:43:59.822] Handling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8904822100331162992:13:0)
[03:43:59.840] Build status: STARTED
[03:43:59.840] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8904822100331162992:14:0) after 5m48s
[03:49:47.861] Handling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8904822100331162992:14:0)
[03:49:47.886] Build status: STARTED
[03:49:47.886] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8904822100331162992:15:0) after 9m56s
[03:59:44.039] Handling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8904822100331162992:15:0)
[03:59:44.066] Build status: STARTED
[03:59:44.066] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8904822100331162992:16:0) after 9m7s
[04:08:51.093] Handling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8904822100331162992:16:0)
[04:08:51.119] Build status: STARTED
[04:08:51.119] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8904822100331162992:17:0) after 2m22s
[04:11:13.135] Handling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8904822100331162992:17:0)
[04:11:13.157] Build status: STARTED
[04:11:13.157] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8904822100331162992:18:0) after 8m53s
[04:20:06.175] Handling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8904822100331162992:18:0)
[04:20:06.199] Build status: STARTED
[04:20:06.199] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8904822100331162992:19:0) after 3m45s
[04:23:51.328] Handling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8904822100331162992:19:0)
[04:23:51.352] Build status: STARTED
[04:23:51.352] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8904822100331162992:20:0) after 6m16s
[04:30:07.376] Handling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8904822100331162992:20:0)
[04:30:07.394] Build status: STARTED
[04:30:07.394] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8904822100331162992:21:0) after 3m38s
[04:33:45.443] Handling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8904822100331162992:21:0)
[04:33:45.461] Build status: STARTED
[04:33:45.461] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8904822100331162992:22:0) after 7m59s
[04:41:44.480] Handling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8904822100331162992:22:0)
[04:41:44.498] Build status: STARTED
[04:41:44.498] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8904822100331162992:23:0) after 5m36s
[04:47:20.515] Handling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8904822100331162992:23:0)
[04:47:20.535] Build status: STARTED
[04:47:20.535] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8904822100331162992:24:0) after 1m25s
[04:48:45.652] Handling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8904822100331162992:24:0)
[04:48:45.675] Build status: STARTED
[04:48:45.675] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8904822100331162992:25:0) after 3m57s
[04:49:41.199] Received PubSub notification, asking Buildbucket for the build status
[04:49:41.214] Build:
{
"id": "8739392038358221441",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "rust_toolchain.core.x64-debug"
},
"createdBy": "project:fuchsia",
"createTime": "2024-08-17T02:54:54.220263943Z",
"startTime": "2024-08-17T02:54:59.810049348Z",
"endTime": "2024-08-17T04:49:40.760054989Z",
"updateTime": "2024-08-17T04:49:40.760054989Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "third_party/rust",
"id": "67d09736ea4be93216e5e2c37c68a38d7bf99968",
"ref": "refs/heads/main"
}
}
}
[04:49:41.215] Invocation finished in 1h54m48.259656021s with status SUCCEEDED