[00:26:00.667] New invocation is queued and will start shortly
[00:26:00.667] Triggered by user:tools-ci-builder@fuchsia-infra.iam.gserviceaccount.com
[00:26:01.760] Starting the invocation (attempt 1)
[00:26:01.784] Popped buildset tag "buildset:commit/gitiles/fuchsia.googlesource.com/third_party/rust/+/6067b36314ab5eb2eb47cecc464545ba58e1ad24"
[00:26:01.784] Reconstructed gitiles commit from tags
[00:26:01.784] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[00:26:01.784] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[00:26:01.784] Buildbucket request:
{
"requestId": "8890879533699262688",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "rust_toolchain.core.arm64-debug"
},
"properties": {
"$fuchsia/checkout": {
"gitiles_commit": {
"host": "fuchsia.googlesource.com",
"id": "8b15b4f02a0edaf7e7cc24058daa2099320b0b0e",
"project": "integration",
"ref": "refs/heads/releases/canary"
},
"rust_toolchain": {
"cas_digest": "7b6b8b169e285a655bca3b0866f6efe9ffdf37daaec2518117754e665a355221/394",
"cas_instance": "projects/chromium-swarm/instances/default_instance"
}
},
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8890879533699262688",
"job": "fuchsia/rust_toolchain.core.arm64-debug",
"triggers": [
{
"buildbucket": {
"properties": {
"$fuchsia/checkout": {
"gitiles_commit": {
"host": "fuchsia.googlesource.com",
"id": "8b15b4f02a0edaf7e7cc24058daa2099320b0b0e",
"project": "integration",
"ref": "refs/heads/releases/canary"
},
"rust_toolchain": {
"cas_digest": "7b6b8b169e285a655bca3b0866f6efe9ffdf37daaec2518117754e665a355221/394",
"cas_instance": "projects/chromium-swarm/instances/default_instance"
}
},
"rust_toolchain": {
"git_repository": "https://fuchsia.googlesource.com/third_party/rust",
"git_revision": "6067b36314ab5eb2eb47cecc464545ba58e1ad24"
}
},
"tags": [
"buildset:commit/gitiles/fuchsia.googlesource.com/third_party/rust/+/6067b36314ab5eb2eb47cecc464545ba58e1ad24",
"gitiles_ref:refs/heads/main",
"parent_buildername:rust-x64-linux-bootstrap",
"user_agent:recipe"
]
},
"id": "db315de6-fb5e-4354-89c9-f644c4c6f8f1",
"title": "rust-x64-linux-bootstrap/0"
}
]
},
"rust_toolchain": {
"git_repository": "https://fuchsia.googlesource.com/third_party/rust",
"git_revision": "6067b36314ab5eb2eb47cecc464545ba58e1ad24"
}
},
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "third_party/rust",
"id": "6067b36314ab5eb2eb47cecc464545ba58e1ad24",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8890879533699262688"
},
{
"key": "scheduler_job_id",
"value": "fuchsia/rust_toolchain.core.arm64-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"
}
}
[00:26:02.183] Scheduled build:
{
"id": "8725449471808992113",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "rust_toolchain.core.arm64-debug"
},
"createdBy": "project:fuchsia",
"createTime": "2025-01-18T00:26:01.843635319Z",
"updateTime": "2025-01-18T00:26:01.843635319Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "third_party/rust",
"id": "6067b36314ab5eb2eb47cecc464545ba58e1ad24",
"ref": "refs/heads/main"
}
}
}
[00:26:02.183] Task URL: https://cr-buildbucket.appspot.com/build/8725449471808992113
[00:26:02.183] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.arm64-debug:8890879533699262688:2:0) after 7m10s
[00:26:02.303] Received PubSub notification, asking Buildbucket for the build status
[00:26:02.325] Build status: SCHEDULED
[00:26:08.176] Received PubSub notification, asking Buildbucket for the build status
[00:26:08.288] Build status: STARTED
[00:33:12.211] Handling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.arm64-debug:8890879533699262688:2:0)
[00:33:12.254] Build status: STARTED
[00:33:12.254] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.arm64-debug:8890879533699262688:5:0) after 4m18s
[00:37:30.300] Handling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.arm64-debug:8890879533699262688:5:0)
[00:37:30.333] Build status: STARTED
[00:37:30.333] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.arm64-debug:8890879533699262688:6:0) after 1m33s
[00:39:03.360] Handling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.arm64-debug:8890879533699262688:6:0)
[00:39:03.390] Build status: STARTED
[00:39:03.390] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.arm64-debug:8890879533699262688:7:0) after 8m27s
[00:47:30.412] Handling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.arm64-debug:8890879533699262688:7:0)
[00:47:30.458] Build status: STARTED
[00:47:30.458] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.arm64-debug:8890879533699262688:8:0) after 5m39s
[00:53:09.483] Handling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.arm64-debug:8890879533699262688:8:0)
[00:53:09.499] Build status: STARTED
[00:53:09.499] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.arm64-debug:8890879533699262688:9:0) after 3m2s
[00:56:11.530] Handling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.arm64-debug:8890879533699262688:9:0)
[00:56:11.557] Build status: STARTED
[00:56:11.557] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.arm64-debug:8890879533699262688:10:0) after 7m20s
[01:03:31.557] Handling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.arm64-debug:8890879533699262688:10:0)
[01:03:31.585] Build status: STARTED
[01:03:31.585] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.arm64-debug:8890879533699262688:11:0) after 7m35s
[01:11:06.603] Handling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.arm64-debug:8890879533699262688:11:0)
[01:11:06.618] Build status: STARTED
[01:11:06.618] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.arm64-debug:8890879533699262688:12:0) after 5m15s
[01:16:21.641] Handling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.arm64-debug:8890879533699262688:12:0)
[01:16:21.655] Build status: STARTED
[01:16:21.655] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.arm64-debug:8890879533699262688:13:0) after 1m27s
[01:17:48.667] Handling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.arm64-debug:8890879533699262688:13:0)
[01:17:48.698] Build status: STARTED
[01:17:48.698] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.arm64-debug:8890879533699262688:14:0) after 4m46s
[01:22:34.744] Handling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.arm64-debug:8890879533699262688:14:0)
[01:22:34.765] Build status: STARTED
[01:22:34.765] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.arm64-debug:8890879533699262688:15:0) after 9m5s
[01:31:39.780] Handling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.arm64-debug:8890879533699262688:15:0)
[01:31:39.799] Build status: STARTED
[01:31:39.799] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.arm64-debug:8890879533699262688:16:0) after 8m0s
[01:39:39.818] Handling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.arm64-debug:8890879533699262688:16:0)
[01:39:39.890] Build status: STARTED
[01:39:39.890] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.arm64-debug:8890879533699262688:17:0) after 8m36s
[01:48:16.434] Handling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.arm64-debug:8890879533699262688:17:0)
[01:48:16.454] Build status: STARTED
[01:48:16.454] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.arm64-debug:8890879533699262688:18:0) after 2m18s
[01:50:34.476] Handling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.arm64-debug:8890879533699262688:18:0)
[01:50:34.493] Build status: STARTED
[01:50:34.493] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.arm64-debug:8890879533699262688:19:0) after 1m27s
[01:52:01.517] Handling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.arm64-debug:8890879533699262688:19:0)
[01:52:01.539] Build status: STARTED
[01:52:01.539] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.arm64-debug:8890879533699262688:20:0) after 5m15s
[01:57:16.861] Handling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.arm64-debug:8890879533699262688:20:0)
[01:57:16.938] Build status: STARTED
[01:57:16.938] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.arm64-debug:8890879533699262688:21:0) after 5m4s
[02:02:21.151] Handling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.arm64-debug:8890879533699262688:21:0)
[02:02:21.172] Build status: STARTED
[02:02:21.172] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.arm64-debug:8890879533699262688:22:0) after 8m53s
[02:11:14.516] Handling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.arm64-debug:8890879533699262688:22:0)
[02:11:14.541] Build status: STARTED
[02:11:14.541] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.arm64-debug:8890879533699262688:23:0) after 3m7s
[02:14:22.049] Handling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.arm64-debug:8890879533699262688:23:0)
[02:14:22.068] Build status: STARTED
[02:14:22.068] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.arm64-debug:8890879533699262688:24:0) after 1m43s
[02:16:05.093] Handling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.arm64-debug:8890879533699262688:24:0)
[02:16:05.120] Build status: STARTED
[02:16:05.120] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.arm64-debug:8890879533699262688:25:0) after 1m38s
[02:17:43.145] Handling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.arm64-debug:8890879533699262688:25:0)
[02:17:43.214] Build status: STARTED
[02:17:43.214] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.arm64-debug:8890879533699262688:26:0) after 5m48s
[02:23:31.233] Handling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.arm64-debug:8890879533699262688:26:0)
[02:23:31.260] Build status: STARTED
[02:23:31.260] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.arm64-debug:8890879533699262688:27:0) after 3m24s
[02:26:55.348] Handling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.arm64-debug:8890879533699262688:27:0)
[02:26:55.370] Build status: STARTED
[02:26:55.370] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.arm64-debug:8890879533699262688:28:0) after 6m48s
[02:33:43.418] Handling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.arm64-debug:8890879533699262688:28:0)
[02:33:43.435] Build status: STARTED
[02:33:43.435] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_toolchain.core.arm64-debug:8890879533699262688:29:0) after 9m5s
[02:41:23.450] Received PubSub notification, asking Buildbucket for the build status
[02:41:23.469] Build:
{
"id": "8725449471808992113",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "rust_toolchain.core.arm64-debug"
},
"createdBy": "project:fuchsia",
"createTime": "2025-01-18T00:26:01.843635319Z",
"startTime": "2025-01-18T00:26:07.676301843Z",
"endTime": "2025-01-18T02:41:08.769261914Z",
"updateTime": "2025-01-18T02:41:08.769261914Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "third_party/rust",
"id": "6067b36314ab5eb2eb47cecc464545ba58e1ad24",
"ref": "refs/heads/main"
}
}
}
[02:41:23.469] Invocation finished in 2h15m22.811880029s with status SUCCEEDED