[03:04:07.387] New invocation is queued and will start shortly
[03:04:07.387] Triggered by user:tools-ci-builder@fuchsia-infra.iam.gserviceaccount.com
[03:04:08.758] Starting the invocation (attempt 1)
[03:04:08.784] Popped buildset tag "buildset:commit/gitiles/fuchsia.googlesource.com/third_party/rust/+/1aedc9640cd740976f49480c4efefe0c0311fbb9"
[03:04:08.784] Reconstructed gitiles commit from tags
[03:04:08.784] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[03:04:08.786] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[03:04:08.787] Buildbucket request:
{
"requestId": "8917414497310796048",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "rust_toolchain.core.x64-debug"
},
"properties": {
"$fuchsia/checkout": {
"gitiles_commit": {
"host": "fuchsia.googlesource.com",
"id": "01f1245077c6d7162dd2802c3429f82f227e7f0b",
"project": "integration"
},
"rust_toolchain": {
"cas_digest": "1740f0721958882c96fcc0a7d52e8804bd2c9f58345a126181d4b3a592ac1a32/394",
"cas_instance": "projects/chromium-swarm/instances/default_instance"
}
},
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8917414497310796048",
"job": "fuchsia/rust_toolchain.core.x64-debug",
"triggers": [
{
"buildbucket": {
"properties": {
"$fuchsia/checkout": {
"gitiles_commit": {
"host": "fuchsia.googlesource.com",
"id": "01f1245077c6d7162dd2802c3429f82f227e7f0b",
"project": "integration"
},
"rust_toolchain": {
"cas_digest": "2c73b9c48d112d0c52d38b266176a98c31abdd7d71e84ce82e6975c32c712976/394",
"cas_instance": "projects/chromium-swarm/instances/default_instance"
}
},
"rust_toolchain": {
"git_repository": "https://fuchsia.googlesource.com/third_party/rust",
"git_revision": "1aedc9640cd740976f49480c4efefe0c0311fbb9"
}
},
"tags": [
"buildset:commit/gitiles/fuchsia.googlesource.com/third_party/rust/+/1aedc9640cd740976f49480c4efefe0c0311fbb9",
"gitiles_ref:refs/heads/main",
"parent_buildername:rust-x64-linux-bootstrap",
"user_agent:recipe"
]
},
"id": "b8f4c7f6-4a69-48c6-baaa-9ea4799be4eb",
"title": "rust-x64-linux-bootstrap/0"
},
{
"buildbucket": {
"properties": {
"$fuchsia/checkout": {
"gitiles_commit": {
"host": "fuchsia.googlesource.com",
"id": "01f1245077c6d7162dd2802c3429f82f227e7f0b",
"project": "integration"
},
"rust_toolchain": {
"cas_digest": "1740f0721958882c96fcc0a7d52e8804bd2c9f58345a126181d4b3a592ac1a32/394",
"cas_instance": "projects/chromium-swarm/instances/default_instance"
}
},
"rust_toolchain": {
"git_repository": "https://fuchsia.googlesource.com/third_party/rust",
"git_revision": "1aedc9640cd740976f49480c4efefe0c0311fbb9"
}
},
"tags": [
"buildset:commit/gitiles/fuchsia.googlesource.com/third_party/rust/+/1aedc9640cd740976f49480c4efefe0c0311fbb9",
"gitiles_ref:refs/heads/main",
"parent_buildername:rust-x64-linux",
"user_agent:recipe"
]
},
"id": "b1e877ce-aeb5-4e11-8260-8be5a4cbbfab",
"title": "rust-x64-linux/0"
}
]
},
"rust_toolchain": {
"git_repository": "https://fuchsia.googlesource.com/third_party/rust",
"git_revision": "1aedc9640cd740976f49480c4efefe0c0311fbb9"
}
},
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "third_party/rust",
"id": "1aedc9640cd740976f49480c4efefe0c0311fbb9",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8917414497310796048"
},
{
"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"
}
}
[03:04:09.272] Scheduled build:
{
"id": "8751984435088454033",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "rust_toolchain.core.x64-debug"
},
"createdBy": "project:fuchsia",
"createTime": "2024-03-31T03:04:08.876837007Z",
"updateTime": "2024-03-31T03:04:08.876837007Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "third_party/rust",
"id": "1aedc9640cd740976f49480c4efefe0c0311fbb9",
"ref": "refs/heads/main"
}
}
}
[03:04:09.273] Task URL: https://cr-buildbucket.appspot.com/build/8751984435088454033
[03:04:09.273] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8917414497310796048:2:0) after 7m2s
[03:04:09.417] Received PubSub notification, asking Buildbucket for the build status
[03:04:09.495] Build status: SCHEDULED
[03:04:10.656] Received PubSub notification, asking Buildbucket for the build status
[03:04:10.681] Build status: STARTED
[03:11:11.291] Handling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8917414497310796048:2:0)
[03:11:11.320] Build status: STARTED
[03:11:11.320] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8917414497310796048:5:0) after 6m51s
[03:18:02.306] Handling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8917414497310796048:5:0)
[03:18:02.336] Build status: STARTED
[03:18:02.336] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8917414497310796048:6:0) after 1m5s
[03:19:07.546] Handling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8917414497310796048:6:0)
[03:19:07.571] Build status: STARTED
[03:19:07.571] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8917414497310796048:7:0) after 2m56s
[03:22:03.637] Handling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8917414497310796048:7:0)
[03:22:03.669] Build status: STARTED
[03:22:03.669] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8917414497310796048:8:0) after 8m3s
[03:30:06.725] Handling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8917414497310796048:8:0)
[03:30:06.746] Build status: STARTED
[03:30:06.746] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8917414497310796048:9:0) after 5m50s
[03:35:56.807] Handling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8917414497310796048:9:0)
[03:35:56.827] Build status: STARTED
[03:35:56.827] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8917414497310796048:10:0) after 1m23s
[03:37:19.849] Handling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8917414497310796048:10:0)
[03:37:19.868] Build status: STARTED
[03:37:19.868] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8917414497310796048:11:0) after 6m30s
[03:43:50.109] Handling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8917414497310796048:11:0)
[03:43:50.190] Build status: STARTED
[03:43:50.191] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8917414497310796048:12:0) after 5m34s
[03:49:24.436] Handling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8917414497310796048:12:0)
[03:49:24.465] Build status: STARTED
[03:49:24.465] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8917414497310796048:13:0) after 7m18s
[03:56:42.700] Handling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8917414497310796048:13:0)
[03:56:42.906] Build status: STARTED
[03:56:42.906] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8917414497310796048:14:0) after 6m5s
[04:02:47.960] Handling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8917414497310796048:14:0)
[04:02:48.002] Build status: STARTED
[04:02:48.002] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8917414497310796048:15:0) after 7m28s
[04:10:16.029] Handling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8917414497310796048:15:0)
[04:10:16.081] Build status: STARTED
[04:10:16.081] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8917414497310796048:16:0) after 6m51s
[04:17:07.197] Handling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8917414497310796048:16:0)
[04:17:07.219] Build status: STARTED
[04:17:07.219] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8917414497310796048:17:0) after 2m20s
[04:19:27.419] Handling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8917414497310796048:17:0)
[04:19:27.439] Build status: STARTED
[04:19:27.439] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8917414497310796048:18:0) after 1m55s
[04:21:22.460] Handling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8917414497310796048:18:0)
[04:21:22.484] Build status: STARTED
[04:21:22.484] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8917414497310796048:19:0) after 5m57s
[04:27:19.535] Handling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8917414497310796048:19:0)
[04:27:19.568] Build status: STARTED
[04:27:19.568] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8917414497310796048:20:0) after 4m51s
[04:32:10.618] Handling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8917414497310796048:20:0)
[04:32:10.703] Build status: STARTED
[04:32:10.703] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8917414497310796048:21:0) after 1m23s
[04:33:33.982] Handling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8917414497310796048:21:0)
[04:33:34.003] Build status: STARTED
[04:33:34.003] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8917414497310796048:22:0) after 9m53s
[04:43:27.131] Handling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8917414497310796048:22:0)
[04:43:27.203] Build status: STARTED
[04:43:27.203] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8917414497310796048:23:0) after 8m15s
[04:51:42.241] Handling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8917414497310796048:23:0)
[04:51:42.260] Build status: STARTED
[04:51:42.260] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8917414497310796048:24:0) after 9m14s
[04:52:35.026] Received PubSub notification, asking Buildbucket for the build status
[04:52:35.045] Build:
{
"id": "8751984435088454033",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "rust_toolchain.core.x64-debug"
},
"createdBy": "project:fuchsia",
"createTime": "2024-03-31T03:04:08.876837007Z",
"startTime": "2024-03-31T03:04:09.831546Z",
"endTime": "2024-03-31T04:52:34.317388Z",
"updateTime": "2024-03-31T04:52:34.317388Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "third_party/rust",
"id": "1aedc9640cd740976f49480c4efefe0c0311fbb9",
"ref": "refs/heads/main"
}
}
}
[04:52:35.045] Invocation finished in 1h48m27.67204165s with status SUCCEEDED