[23:20:39.730] New invocation is queued and will start shortly
[23:20:39.730] Triggered by user:tools-ci-builder@fuchsia-infra.iam.gserviceaccount.com
[23:20:40.772] Starting the invocation (attempt 1)
[23:20:40.797] Popped buildset tag "buildset:commit/gitiles/fuchsia.googlesource.com/third_party/rust/+/4adafcf40aa6064d2bbcb44bc1a50b3b1e86e5e0"
[23:20:40.797] Reconstructed gitiles commit from tags
[23:20:40.797] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[23:20:40.798] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[23:20:40.799] Buildbucket request:
{
"requestId": "8897134835781946864",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "rust_toolchain.core.arm64-debug"
},
"properties": {
"$fuchsia/checkout": {
"gitiles_commit": {
"host": "fuchsia.googlesource.com",
"id": "c6ee86ade5e5f3569edfc6b554e8362e022c37b0",
"project": "integration",
"ref": "refs/heads/releases/canary"
},
"rust_toolchain": {
"cas_digest": "2d31177d85ad0b82661648bccced4b1d4fdb367e88e49eb5d003f4f9136e072b/394",
"cas_instance": "projects/chromium-swarm/instances/default_instance"
}
},
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8897134835781946864",
"job": "fuchsia/rust_toolchain.core.arm64-debug",
"triggers": [
{
"buildbucket": {
"properties": {
"$fuchsia/checkout": {
"gitiles_commit": {
"host": "fuchsia.googlesource.com",
"id": "c6ee86ade5e5f3569edfc6b554e8362e022c37b0",
"project": "integration",
"ref": "refs/heads/releases/canary"
},
"rust_toolchain": {
"cas_digest": "bd67c7d15b470174c26512e021530031a3a7fccadada5da7791133ab1351588c/394",
"cas_instance": "projects/chromium-swarm/instances/default_instance"
}
},
"rust_toolchain": {
"git_repository": "https://fuchsia.googlesource.com/third_party/rust",
"git_revision": "4adafcf40aa6064d2bbcb44bc1a50b3b1e86e5e0"
}
},
"tags": [
"buildset:commit/gitiles/fuchsia.googlesource.com/third_party/rust/+/4adafcf40aa6064d2bbcb44bc1a50b3b1e86e5e0",
"gitiles_ref:refs/heads/main",
"parent_buildername:rust-x64-linux-bootstrap",
"user_agent:recipe"
]
},
"id": "7f5934ac-ac16-4de8-b549-72da5ae2b88e",
"title": "rust-x64-linux-bootstrap/0"
},
{
"buildbucket": {
"properties": {
"$fuchsia/checkout": {
"gitiles_commit": {
"host": "fuchsia.googlesource.com",
"id": "c6ee86ade5e5f3569edfc6b554e8362e022c37b0",
"project": "integration",
"ref": "refs/heads/releases/canary"
},
"rust_toolchain": {
"cas_digest": "2d31177d85ad0b82661648bccced4b1d4fdb367e88e49eb5d003f4f9136e072b/394",
"cas_instance": "projects/chromium-swarm/instances/default_instance"
}
},
"rust_toolchain": {
"git_repository": "https://fuchsia.googlesource.com/third_party/rust",
"git_revision": "4adafcf40aa6064d2bbcb44bc1a50b3b1e86e5e0"
}
},
"tags": [
"buildset:commit/gitiles/fuchsia.googlesource.com/third_party/rust/+/4adafcf40aa6064d2bbcb44bc1a50b3b1e86e5e0",
"gitiles_ref:refs/heads/main",
"parent_buildername:rust-x64-linux",
"user_agent:recipe"
]
},
"id": "bfd4a80d-f40c-42c0-999d-556379193e32",
"title": "rust-x64-linux/0"
}
]
},
"rust_toolchain": {
"git_repository": "https://fuchsia.googlesource.com/third_party/rust",
"git_revision": "4adafcf40aa6064d2bbcb44bc1a50b3b1e86e5e0"
}
},
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "third_party/rust",
"id": "4adafcf40aa6064d2bbcb44bc1a50b3b1e86e5e0",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8897134835781946864"
},
{
"key": "scheduler_job_id",
"value": "fuchsia/rust_toolchain.core.arm64-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"
}
}
[23:20:41.243] Scheduled build:
{
"id": "8731704773946731585",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "rust_toolchain.core.arm64-debug"
},
"createdBy": "project:fuchsia",
"createTime": "2024-11-09T23:20:40.853827412Z",
"updateTime": "2024-11-09T23:20:40.853827412Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "third_party/rust",
"id": "4adafcf40aa6064d2bbcb44bc1a50b3b1e86e5e0",
"ref": "refs/heads/main"
}
}
}
[23:20:41.243] Task URL: https://cr-buildbucket.appspot.com/build/8731704773946731585
[23:20:41.243] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.arm64-debug:8897134835781946864:2:0) after 9m49s
[23:20:42.206] Received PubSub notification, asking Buildbucket for the build status
[23:20:42.229] Build status: SCHEDULED
[23:20:47.123] Received PubSub notification, asking Buildbucket for the build status
[23:20:47.140] Build status: STARTED
[23:30:30.240] Handling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.arm64-debug:8897134835781946864:2:0)
[23:30:30.390] Build status: STARTED
[23:30:30.390] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.arm64-debug:8897134835781946864:5:0) after 5m8s
[23:35:38.406] Handling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.arm64-debug:8897134835781946864:5:0)
[23:35:38.559] Build status: STARTED
[23:35:38.559] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.arm64-debug:8897134835781946864:6:0) after 5m26s
[23:41:04.657] Handling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.arm64-debug:8897134835781946864:6:0)
[23:41:04.680] Build status: STARTED
[23:41:04.680] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.arm64-debug:8897134835781946864:7:0) after 7m57s
[23:49:01.697] Handling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.arm64-debug:8897134835781946864:7:0)
[23:49:01.718] Build status: STARTED
[23:49:01.718] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.arm64-debug:8897134835781946864:8:0) after 5m11s
[23:54:12.737] Handling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.arm64-debug:8897134835781946864:8:0)
[23:54:12.753] Build status: STARTED
[23:54:12.754] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.arm64-debug:8897134835781946864:9:0) after 5m3s
[23:59:15.770] Handling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.arm64-debug:8897134835781946864:9:0)
[23:59:15.793] Build status: STARTED
[23:59:15.793] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.arm64-debug:8897134835781946864:10:0) after 7m38s
[00:06:53.808] Handling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.arm64-debug:8897134835781946864:10:0)
[00:06:53.834] Build status: STARTED
[00:06:53.834] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.arm64-debug:8897134835781946864:11:0) after 7m18s
[00:14:11.886] Handling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.arm64-debug:8897134835781946864:11:0)
[00:14:11.905] Build status: STARTED
[00:14:11.905] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.arm64-debug:8897134835781946864:12:0) after 1m17s
[00:15:28.941] Handling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.arm64-debug:8897134835781946864:12:0)
[00:15:29.199] Build status: STARTED
[00:15:29.199] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.arm64-debug:8897134835781946864:13:0) after 8m15s
[00:23:44.248] Handling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.arm64-debug:8897134835781946864:13:0)
[00:23:44.273] Build status: STARTED
[00:23:44.273] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.arm64-debug:8897134835781946864:14:0) after 7m22s
[00:31:06.288] Handling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.arm64-debug:8897134835781946864:14:0)
[00:31:06.311] Build status: STARTED
[00:31:06.311] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.arm64-debug:8897134835781946864:15:0) after 7m53s
[00:38:59.386] Handling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.arm64-debug:8897134835781946864:15:0)
[00:38:59.475] Build status: STARTED
[00:38:59.475] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.arm64-debug:8897134835781946864:16:0) after 8m17s
[00:47:16.495] Handling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.arm64-debug:8897134835781946864:16:0)
[00:47:16.513] Build status: STARTED
[00:47:16.513] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.arm64-debug:8897134835781946864:17:0) after 5m40s
[00:52:56.528] Handling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.arm64-debug:8897134835781946864:17:0)
[00:52:56.549] Build status: STARTED
[00:52:56.549] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.arm64-debug:8897134835781946864:18:0) after 8m36s
[01:01:32.659] Handling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.arm64-debug:8897134835781946864:18:0)
[01:01:32.680] Build status: STARTED
[01:01:32.680] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.arm64-debug:8897134835781946864:19:0) after 7m29s
[01:09:01.805] Handling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.arm64-debug:8897134835781946864:19:0)
[01:09:01.829] Build status: STARTED
[01:09:01.829] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.arm64-debug:8897134835781946864:20:0) after 4m25s
[01:13:26.888] Handling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.arm64-debug:8897134835781946864:20:0)
[01:13:26.910] Build status: STARTED
[01:13:26.910] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.arm64-debug:8897134835781946864:21:0) after 6m17s
[01:19:43.932] Handling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.arm64-debug:8897134835781946864:21:0)
[01:19:43.949] Build status: STARTED
[01:19:43.949] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.arm64-debug:8897134835781946864:22:0) after 5m46s
[01:25:30.066] Handling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.arm64-debug:8897134835781946864:22:0)
[01:25:30.082] Build status: STARTED
[01:25:30.082] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.arm64-debug:8897134835781946864:23:0) after 4m43s
[01:30:13.156] Handling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.arm64-debug:8897134835781946864:23:0)
[01:30:13.170] Build status: STARTED
[01:30:13.170] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.arm64-debug:8897134835781946864:24:0) after 3m12s
[01:33:25.272] Handling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.arm64-debug:8897134835781946864:24:0)
[01:33:25.292] Build status: STARTED
[01:33:25.292] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.arm64-debug:8897134835781946864:25:0) after 1m28s
[01:34:53.340] Handling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.arm64-debug:8897134835781946864:25:0)
[01:34:53.357] Build status: STARTED
[01:34:53.357] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.arm64-debug:8897134835781946864:26:0) after 9m13s
[01:42:32.729] Received PubSub notification, asking Buildbucket for the build status
[01:42:32.750] Build:
{
"id": "8731704773946731585",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "rust_toolchain.core.arm64-debug"
},
"createdBy": "project:fuchsia",
"createTime": "2024-11-09T23:20:40.853827412Z",
"startTime": "2024-11-09T23:20:46.895911867Z",
"endTime": "2024-11-10T01:42:26.431033940Z",
"updateTime": "2024-11-10T01:42:26.431033940Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "third_party/rust",
"id": "4adafcf40aa6064d2bbcb44bc1a50b3b1e86e5e0",
"ref": "refs/heads/main"
}
}
}
[01:42:32.750] Invocation finished in 2h21m53.030856385s with status SUCCEEDED