[03:12:53.658] New invocation is queued and will start shortly
[03:12:56.416] Starting the invocation (attempt 1)
[03:12:56.443] Popped buildset tag "buildset:commit/gitiles/fuchsia.googlesource.com/third_party/rust/+/b733736ea2feb7798c99cbb9a769bce74be108df"
[03:12:56.443] Popped gitiles commit info from properties and tags
[03:12:56.443] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[03:12:56.443] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[03:12:56.443] Buildbucket request:
{
"requestId": "8868129195747620080",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "rust_stage0_trigger"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8868129195747620080",
"job": "fuchsia/toolchain.ci-rust_stage0_trigger-49def413",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/third_party/rust",
"revision": "4fcafc9daad24e5811546896b80e4e18578bf9f3"
},
"id": "https://fuchsia.googlesource.com/third_party/rust/+/refs/heads/main@4fcafc9daad24e5811546896b80e4e18578bf9f3",
"title": "4fcafc9daad24e5811546896b80e4e18578bf9f3",
"url": "https://fuchsia.googlesource.com/third_party/rust/+/4fcafc9daad24e5811546896b80e4e18578bf9f3"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/third_party/rust",
"revision": "83532f8544e18dfc2025ab33e7c01fb27865667f"
},
"id": "https://fuchsia.googlesource.com/third_party/rust/+/refs/heads/main@83532f8544e18dfc2025ab33e7c01fb27865667f",
"title": "83532f8544e18dfc2025ab33e7c01fb27865667f",
"url": "https://fuchsia.googlesource.com/third_party/rust/+/83532f8544e18dfc2025ab33e7c01fb27865667f"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/third_party/rust",
"revision": "7a0adc08786df857e810c9f6a5a0cb6cae32659b"
},
"id": "https://fuchsia.googlesource.com/third_party/rust/+/refs/heads/main@7a0adc08786df857e810c9f6a5a0cb6cae32659b",
"title": "7a0adc08786df857e810c9f6a5a0cb6cae32659b",
"url": "https://fuchsia.googlesource.com/third_party/rust/+/7a0adc08786df857e810c9f6a5a0cb6cae32659b"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/third_party/rust",
"revision": "b733736ea2feb7798c99cbb9a769bce74be108df"
},
"id": "https://fuchsia.googlesource.com/third_party/rust/+/refs/heads/main@b733736ea2feb7798c99cbb9a769bce74be108df",
"title": "b733736ea2feb7798c99cbb9a769bce74be108df",
"url": "https://fuchsia.googlesource.com/third_party/rust/+/b733736ea2feb7798c99cbb9a769bce74be108df"
}
]
}
},
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "third_party/rust",
"id": "b733736ea2feb7798c99cbb9a769bce74be108df",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8868129195747620080"
},
{
"key": "scheduler_job_id",
"value": "fuchsia/toolchain.ci-rust_stage0_trigger-49def413"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[03:12:56.817] Scheduled build:
{
"id": "8702699132116107169",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "rust_stage0_trigger"
},
"createdBy": "project:fuchsia",
"createTime": "2025-09-26T03:12:56.497402346Z",
"updateTime": "2025-09-26T03:12:56.497402346Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "third_party/rust",
"id": "b733736ea2feb7798c99cbb9a769bce74be108df",
"ref": "refs/heads/main"
}
},
"canary": true
}
[03:12:56.817] Task URL: https://cr-buildbucket.appspot.com/build/8702699132116107169
[03:12:56.817] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_stage0_trigger-49def413:8868129195747620080:2:0) after 5m53s
[03:12:56.955] Received PubSub notification, asking Buildbucket for the build status
[03:12:56.980] Build status: SCHEDULED
[03:13:01.094] Received PubSub notification, asking Buildbucket for the build status
[03:13:01.111] Build status: STARTED
[03:18:49.831] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_stage0_trigger-49def413:8868129195747620080:2:0)
[03:18:49.899] Build status: STARTED
[03:18:49.899] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_stage0_trigger-49def413:8868129195747620080:5:0) after 6m18s
[03:25:07.913] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_stage0_trigger-49def413:8868129195747620080:5:0)
[03:25:07.937] Build status: STARTED
[03:25:07.937] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_stage0_trigger-49def413:8868129195747620080:6:0) after 1m45s
[03:26:52.952] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_stage0_trigger-49def413:8868129195747620080:6:0)
[03:26:52.969] Build status: STARTED
[03:26:52.969] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_stage0_trigger-49def413:8868129195747620080:7:0) after 5m27s
[03:32:19.985] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_stage0_trigger-49def413:8868129195747620080:7:0)
[03:32:20.002] Build status: STARTED
[03:32:20.002] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_stage0_trigger-49def413:8868129195747620080:8:0) after 6m36s
[03:38:56.035] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_stage0_trigger-49def413:8868129195747620080:8:0)
[03:38:56.054] Build status: STARTED
[03:38:56.054] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_stage0_trigger-49def413:8868129195747620080:9:0) after 3m38s
[03:42:34.118] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_stage0_trigger-49def413:8868129195747620080:9:0)
[03:42:34.156] Build status: STARTED
[03:42:34.156] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_stage0_trigger-49def413:8868129195747620080:10:0) after 2m44s
[03:45:18.224] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_stage0_trigger-49def413:8868129195747620080:10:0)
[03:45:18.266] Build status: STARTED
[03:45:18.266] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_stage0_trigger-49def413:8868129195747620080:11:0) after 1m49s
[03:47:07.288] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_stage0_trigger-49def413:8868129195747620080:11:0)
[03:47:07.324] Build status: STARTED
[03:47:07.324] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_stage0_trigger-49def413:8868129195747620080:12:0) after 8m34s
[03:55:41.407] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_stage0_trigger-49def413:8868129195747620080:12:0)
[03:55:41.444] Build status: STARTED
[03:55:41.444] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_stage0_trigger-49def413:8868129195747620080:13:0) after 2m30s
[03:58:11.456] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_stage0_trigger-49def413:8868129195747620080:13:0)
[03:58:11.476] Build status: STARTED
[03:58:11.476] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_stage0_trigger-49def413:8868129195747620080:14:0) after 5m1s
[04:03:12.784] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_stage0_trigger-49def413:8868129195747620080:14:0)
[04:03:12.806] Build status: STARTED
[04:03:12.806] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_stage0_trigger-49def413:8868129195747620080:15:0) after 1m42s
[04:04:54.824] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_stage0_trigger-49def413:8868129195747620080:15:0)
[04:04:54.852] Build status: STARTED
[04:04:54.852] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_stage0_trigger-49def413:8868129195747620080:16:0) after 4m7s
[04:09:01.955] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_stage0_trigger-49def413:8868129195747620080:16:0)
[04:09:02.050] Build status: STARTED
[04:09:02.050] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_stage0_trigger-49def413:8868129195747620080:17:0) after 3m44s
[04:12:46.114] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_stage0_trigger-49def413:8868129195747620080:17:0)
[04:12:46.135] Build status: STARTED
[04:12:46.135] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_stage0_trigger-49def413:8868129195747620080:18:0) after 1m36s
[04:14:22.201] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_stage0_trigger-49def413:8868129195747620080:18:0)
[04:14:22.220] Build status: STARTED
[04:14:22.220] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_stage0_trigger-49def413:8868129195747620080:19:0) after 9m36s
[04:23:58.236] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_stage0_trigger-49def413:8868129195747620080:19:0)
[04:23:58.254] Build status: STARTED
[04:23:58.254] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_stage0_trigger-49def413:8868129195747620080:20:0) after 6m20s
[04:30:18.272] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_stage0_trigger-49def413:8868129195747620080:20:0)
[04:30:18.304] Build status: STARTED
[04:30:18.304] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_stage0_trigger-49def413:8868129195747620080:21:0) after 8m54s
[04:39:12.274] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_stage0_trigger-49def413:8868129195747620080:21:0)
[04:39:12.398] Build status: STARTED
[04:39:12.398] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_stage0_trigger-49def413:8868129195747620080:22:0) after 2m23s
[04:41:35.414] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_stage0_trigger-49def413:8868129195747620080:22:0)
[04:41:35.433] Build status: STARTED
[04:41:35.433] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_stage0_trigger-49def413:8868129195747620080:23:0) after 5m33s
[04:47:08.485] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_stage0_trigger-49def413:8868129195747620080:23:0)
[04:47:08.513] Build status: STARTED
[04:47:08.513] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_stage0_trigger-49def413:8868129195747620080:24:0) after 6m23s
[04:53:31.578] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_stage0_trigger-49def413:8868129195747620080:24:0)
[04:53:31.607] Build status: STARTED
[04:53:31.607] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_stage0_trigger-49def413:8868129195747620080:25:0) after 7m6s
[05:00:37.623] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_stage0_trigger-49def413:8868129195747620080:25:0)
[05:00:37.644] Build status: STARTED
[05:00:37.644] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_stage0_trigger-49def413:8868129195747620080:26:0) after 2m51s
[05:03:28.711] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_stage0_trigger-49def413:8868129195747620080:26:0)
[05:03:28.780] Build status: STARTED
[05:03:28.780] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_stage0_trigger-49def413:8868129195747620080:27:0) after 2m1s
[05:05:29.804] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_stage0_trigger-49def413:8868129195747620080:27:0)
[05:05:29.828] Build status: STARTED
[05:05:29.828] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_stage0_trigger-49def413:8868129195747620080:28:0) after 7m21s
[05:12:50.828] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_stage0_trigger-49def413:8868129195747620080:28:0)
[05:12:50.843] Build status: STARTED
[05:12:50.843] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_stage0_trigger-49def413:8868129195747620080:29:0) after 6m44s
[05:19:34.861] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_stage0_trigger-49def413:8868129195747620080:29:0)
[05:19:34.879] Build status: STARTED
[05:19:34.879] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_stage0_trigger-49def413:8868129195747620080:30:0) after 7m51s
[05:27:25.959] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_stage0_trigger-49def413:8868129195747620080:30:0)
[05:27:25.976] Build status: STARTED
[05:27:25.976] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_stage0_trigger-49def413:8868129195747620080:31:0) after 1m52s
[05:29:18.042] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_stage0_trigger-49def413:8868129195747620080:31:0)
[05:29:18.062] Build status: STARTED
[05:29:18.062] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_stage0_trigger-49def413:8868129195747620080:32:0) after 3m41s
[05:32:59.160] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_stage0_trigger-49def413:8868129195747620080:32:0)
[05:32:59.245] Build status: STARTED
[05:32:59.245] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_stage0_trigger-49def413:8868129195747620080:33:0) after 5m47s
[05:38:46.211] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_stage0_trigger-49def413:8868129195747620080:33:0)
[05:38:46.245] Build status: STARTED
[05:38:46.245] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_stage0_trigger-49def413:8868129195747620080:34:0) after 5m48s
[05:44:34.261] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_stage0_trigger-49def413:8868129195747620080:34:0)
[05:44:34.291] Build status: STARTED
[05:44:34.291] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_stage0_trigger-49def413:8868129195747620080:35:0) after 9m1s
[05:53:35.339] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_stage0_trigger-49def413:8868129195747620080:35:0)
[05:53:35.357] Build status: STARTED
[05:53:35.357] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_stage0_trigger-49def413:8868129195747620080:36:0) after 9m39s
[06:03:14.374] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_stage0_trigger-49def413:8868129195747620080:36:0)
[06:03:14.393] Build status: STARTED
[06:03:14.393] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_stage0_trigger-49def413:8868129195747620080:37:0) after 9m3s
[06:12:17.579] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_stage0_trigger-49def413:8868129195747620080:37:0)
[06:12:17.597] Build status: STARTED
[06:12:17.597] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_stage0_trigger-49def413:8868129195747620080:38:0) after 7m47s
[06:20:04.646] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_stage0_trigger-49def413:8868129195747620080:38:0)
[06:20:04.674] Build status: STARTED
[06:20:04.674] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_stage0_trigger-49def413:8868129195747620080:39:0) after 1m50s
[06:21:54.698] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_stage0_trigger-49def413:8868129195747620080:39:0)
[06:21:54.727] Build status: STARTED
[06:21:54.727] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_stage0_trigger-49def413:8868129195747620080:40:0) after 3m18s
[06:25:12.741] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_stage0_trigger-49def413:8868129195747620080:40:0)
[06:25:12.757] Build status: STARTED
[06:25:12.757] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_stage0_trigger-49def413:8868129195747620080:41:0) after 3m35s
[06:26:54.168] Received PubSub notification, asking Buildbucket for the build status
[06:26:54.202] Build:
{
"id": "8702699132116107169",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "rust_stage0_trigger"
},
"createdBy": "project:fuchsia",
"createTime": "2025-09-26T03:12:56.497402346Z",
"startTime": "2025-09-26T03:13:00.801161920Z",
"endTime": "2025-09-26T06:26:44.134814803Z",
"updateTime": "2025-09-26T06:26:44.134814803Z",
"status": "FAILURE",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "third_party/rust",
"id": "b733736ea2feb7798c99cbb9a769bce74be108df",
"ref": "refs/heads/main"
}
},
"canary": true
}
[06:26:54.203] Invocation finished in 3h14m0.551812853s with status FAILED