[14:05:04.731] New invocation is queued and will start shortly
[14:05:04.731] Triggered by user:tools-ci-builder@fuchsia-infra.iam.gserviceaccount.com
[14:05:05.816] Starting the invocation (attempt 1)
[14:05:05.849] Popped buildset tag "buildset:commit/gitiles/fuchsia.googlesource.com/third_party/rust/+/3942254d00bf95cd5920980f85ebea57a1e6ce2a"
[14:05:05.849] Reconstructed gitiles commit from tags
[14:05:05.849] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[14:05:05.850] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[14:05:05.851] Buildbucket request:
{
"requestId": "8906682471537545008",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "rust_toolchain.core.x64-debug"
},
"properties": {
"$fuchsia/checkout": {
"gitiles_commit": {
"host": "fuchsia.googlesource.com",
"id": "699a66e3980816e9e90cdb2e7cbbe5dcef634d76",
"project": "integration",
"ref": "refs/heads/releases/canary"
},
"rust_toolchain": {
"cas_digest": "77c8f3a281776b8176c654fdb9de4d3e652c59f0078cae63d1a4acad1d1f12a3/394",
"cas_instance": "projects/chromium-swarm/instances/default_instance"
}
},
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8906682471537545008",
"job": "fuchsia/rust_toolchain.core.x64-debug",
"triggers": [
{
"buildbucket": {
"properties": {
"$fuchsia/checkout": {
"gitiles_commit": {
"host": "fuchsia.googlesource.com",
"id": "699a66e3980816e9e90cdb2e7cbbe5dcef634d76",
"project": "integration",
"ref": "refs/heads/releases/canary"
},
"rust_toolchain": {
"cas_digest": "1da8b00ab6746ab091904a1ee301c6d592063e16f9f2f000c3a02560d2923a52/394",
"cas_instance": "projects/chromium-swarm/instances/default_instance"
}
},
"rust_toolchain": {
"git_repository": "https://fuchsia.googlesource.com/third_party/rust",
"git_revision": "3942254d00bf95cd5920980f85ebea57a1e6ce2a"
}
},
"tags": [
"buildset:commit/gitiles/fuchsia.googlesource.com/third_party/rust/+/3942254d00bf95cd5920980f85ebea57a1e6ce2a",
"gitiles_ref:refs/heads/main",
"parent_buildername:rust-x64-linux",
"user_agent:recipe"
]
},
"id": "98015a95-319d-4343-92d3-f4183caf9a4d",
"title": "rust-x64-linux/0"
},
{
"buildbucket": {
"properties": {
"$fuchsia/checkout": {
"gitiles_commit": {
"host": "fuchsia.googlesource.com",
"id": "699a66e3980816e9e90cdb2e7cbbe5dcef634d76",
"project": "integration",
"ref": "refs/heads/releases/canary"
},
"rust_toolchain": {
"cas_digest": "77c8f3a281776b8176c654fdb9de4d3e652c59f0078cae63d1a4acad1d1f12a3/394",
"cas_instance": "projects/chromium-swarm/instances/default_instance"
}
},
"rust_toolchain": {
"git_repository": "https://fuchsia.googlesource.com/third_party/rust",
"git_revision": "3942254d00bf95cd5920980f85ebea57a1e6ce2a"
}
},
"tags": [
"buildset:commit/gitiles/fuchsia.googlesource.com/third_party/rust/+/3942254d00bf95cd5920980f85ebea57a1e6ce2a",
"gitiles_ref:refs/heads/main",
"parent_buildername:rust-x64-linux-bootstrap",
"user_agent:recipe"
]
},
"id": "6deaac25-6d9c-48c8-9368-da2a02035725",
"title": "rust-x64-linux-bootstrap/0"
}
]
},
"rust_toolchain": {
"git_repository": "https://fuchsia.googlesource.com/third_party/rust",
"git_revision": "3942254d00bf95cd5920980f85ebea57a1e6ce2a"
}
},
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "third_party/rust",
"id": "3942254d00bf95cd5920980f85ebea57a1e6ce2a",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8906682471537545008"
},
{
"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"
}
}
[14:05:06.535] Scheduled build:
{
"id": "8741252409608456161",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "rust_toolchain.core.x64-debug"
},
"createdBy": "project:fuchsia",
"createTime": "2024-07-27T14:05:05.940118821Z",
"updateTime": "2024-07-27T14:05:05.940118821Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "third_party/rust",
"id": "3942254d00bf95cd5920980f85ebea57a1e6ce2a",
"ref": "refs/heads/main"
}
}
}
[14:05:06.535] Task URL: https://cr-buildbucket.appspot.com/build/8741252409608456161
[14:05:06.535] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8906682471537545008:2:0) after 9m7s
[14:05:06.946] Received PubSub notification, asking Buildbucket for the build status
[14:05:06.974] Build status: SCHEDULED
[14:05:12.320] Received PubSub notification, asking Buildbucket for the build status
[14:05:12.336] Build status: STARTED
[14:14:13.525] Handling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8906682471537545008:2:0)
[14:14:13.546] Build status: STARTED
[14:14:13.546] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8906682471537545008:5:0) after 1m13s
[14:15:26.640] Handling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8906682471537545008:5:0)
[14:15:26.681] Build status: STARTED
[14:15:26.681] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8906682471537545008:6:0) after 1m21s
[14:16:47.798] Handling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8906682471537545008:6:0)
[14:16:47.819] Build status: STARTED
[14:16:47.819] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8906682471537545008:7:0) after 2m25s
[14:19:12.822] Handling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8906682471537545008:7:0)
[14:19:12.854] Build status: STARTED
[14:19:12.854] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8906682471537545008:8:0) after 3m52s
[14:23:05.154] Handling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8906682471537545008:8:0)
[14:23:05.171] Build status: STARTED
[14:23:05.171] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8906682471537545008:9:0) after 8m3s
[14:31:08.193] Handling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8906682471537545008:9:0)
[14:31:08.215] Build status: STARTED
[14:31:08.215] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8906682471537545008:10:0) after 1m43s
[14:32:51.266] Handling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8906682471537545008:10:0)
[14:32:51.297] Build status: STARTED
[14:32:51.297] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8906682471537545008:11:0) after 7m28s
[14:40:19.399] Handling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8906682471537545008:11:0)
[14:40:19.441] Build status: STARTED
[14:40:19.441] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8906682471537545008:12:0) after 2m39s
[14:42:58.497] Handling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8906682471537545008:12:0)
[14:42:58.517] Build status: STARTED
[14:42:58.517] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8906682471537545008:13:0) after 5m56s
[14:48:55.052] Handling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8906682471537545008:13:0)
[14:48:55.130] Build status: STARTED
[14:48:55.130] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8906682471537545008:14:0) after 7m56s
[14:56:51.391] Handling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8906682471537545008:14:0)
[14:56:51.427] Build status: STARTED
[14:56:51.427] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8906682471537545008:15:0) after 9m52s
[15:06:43.556] Handling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8906682471537545008:15:0)
[15:06:43.574] Build status: STARTED
[15:06:43.575] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8906682471537545008:16:0) after 3m3s
[15:09:46.731] Handling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8906682471537545008:16:0)
[15:09:46.751] Build status: STARTED
[15:09:46.751] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8906682471537545008:17:0) after 6m52s
[15:16:38.970] Handling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8906682471537545008:17:0)
[15:16:38.991] Build status: STARTED
[15:16:38.991] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8906682471537545008:18:0) after 5m43s
[15:22:22.007] Handling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8906682471537545008:18:0)
[15:22:22.026] Build status: STARTED
[15:22:22.026] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8906682471537545008:19:0) after 1m21s
[15:23:43.047] Handling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8906682471537545008:19:0)
[15:23:43.082] Build status: STARTED
[15:23:43.082] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8906682471537545008:20:0) after 5m57s
[15:29:40.109] Handling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8906682471537545008:20:0)
[15:29:40.126] Build status: STARTED
[15:29:40.126] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8906682471537545008:21:0) after 3m20s
[15:33:00.322] Handling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8906682471537545008:21:0)
[15:33:00.349] Build status: STARTED
[15:33:00.349] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8906682471537545008:22:0) after 1m27s
[15:34:27.499] Handling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8906682471537545008:22:0)
[15:34:27.520] Build status: STARTED
[15:34:27.520] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8906682471537545008:23:0) after 9m8s
[15:43:35.718] Handling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8906682471537545008:23:0)
[15:43:35.738] Build status: STARTED
[15:43:35.738] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8906682471537545008:24:0) after 6m30s
[15:50:05.753] Handling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8906682471537545008:24:0)
[15:50:05.789] Build status: STARTED
[15:50:05.789] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8906682471537545008:25:0) after 9m22s
[15:59:27.901] Handling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8906682471537545008:25:0)
[15:59:27.922] Build status: STARTED
[15:59:27.922] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.x64-debug:8906682471537545008:26:0) after 6m44s
[16:02:28.457] Received PubSub notification, asking Buildbucket for the build status
[16:02:28.474] Build:
{
"id": "8741252409608456161",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "rust_toolchain.core.x64-debug"
},
"createdBy": "project:fuchsia",
"createTime": "2024-07-27T14:05:05.940118821Z",
"startTime": "2024-07-27T14:05:11.815872298Z",
"endTime": "2024-07-27T16:02:27.828487846Z",
"updateTime": "2024-07-27T16:02:27.828487846Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "third_party/rust",
"id": "3942254d00bf95cd5920980f85ebea57a1e6ce2a",
"ref": "refs/heads/main"
}
}
}
[16:02:28.474] Invocation finished in 1h57m23.757917422s with status SUCCEEDED