[15:22:32.510] New invocation is queued and will start shortly
[15:22:33.595] Starting the invocation (attempt 1)
[15:22:33.618] Popped buildset tag "buildset:commit/gitiles/fuchsia.googlesource.com/third_party/rust/+/6d5caf3a4a358c80f09ba51d71db0dbc41381992"
[15:22:33.618] Popped gitiles commit info from properties and tags
[15:22:33.618] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[15:22:33.618] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[15:22:33.618] Buildbucket request:
{
"requestId": "8869895229629524528",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "rust-linux-x64"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8869895229629524528",
"job": "fuchsia/toolchain.ci-rust-linux-x64-49def413",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/third_party/rust",
"revision": "fa6986ebe749bc59d569e3f75d0b5764f2601d78"
},
"id": "https://fuchsia.googlesource.com/third_party/rust/+/refs/heads/main@fa6986ebe749bc59d569e3f75d0b5764f2601d78",
"title": "fa6986ebe749bc59d569e3f75d0b5764f2601d78",
"url": "https://fuchsia.googlesource.com/third_party/rust/+/fa6986ebe749bc59d569e3f75d0b5764f2601d78"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/third_party/rust",
"revision": "17b27d8e6c7ecce909d3b0bd072378c7a0854d78"
},
"id": "https://fuchsia.googlesource.com/third_party/rust/+/refs/heads/main@17b27d8e6c7ecce909d3b0bd072378c7a0854d78",
"title": "17b27d8e6c7ecce909d3b0bd072378c7a0854d78",
"url": "https://fuchsia.googlesource.com/third_party/rust/+/17b27d8e6c7ecce909d3b0bd072378c7a0854d78"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/third_party/rust",
"revision": "267d3c85088ebea128ef4b88435ceda937f306cd"
},
"id": "https://fuchsia.googlesource.com/third_party/rust/+/refs/heads/main@267d3c85088ebea128ef4b88435ceda937f306cd",
"title": "267d3c85088ebea128ef4b88435ceda937f306cd",
"url": "https://fuchsia.googlesource.com/third_party/rust/+/267d3c85088ebea128ef4b88435ceda937f306cd"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/third_party/rust",
"revision": "d224d3a8fa3c5299892d892664bc128fd3fe6571"
},
"id": "https://fuchsia.googlesource.com/third_party/rust/+/refs/heads/main@d224d3a8fa3c5299892d892664bc128fd3fe6571",
"title": "d224d3a8fa3c5299892d892664bc128fd3fe6571",
"url": "https://fuchsia.googlesource.com/third_party/rust/+/d224d3a8fa3c5299892d892664bc128fd3fe6571"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/third_party/rust",
"revision": "5f372fe7d18efd9770d0f9b23895a049c28dcc41"
},
"id": "https://fuchsia.googlesource.com/third_party/rust/+/refs/heads/main@5f372fe7d18efd9770d0f9b23895a049c28dcc41",
"title": "5f372fe7d18efd9770d0f9b23895a049c28dcc41",
"url": "https://fuchsia.googlesource.com/third_party/rust/+/5f372fe7d18efd9770d0f9b23895a049c28dcc41"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/third_party/rust",
"revision": "d5e61216a74efede682f88c65a9fe59769848c76"
},
"id": "https://fuchsia.googlesource.com/third_party/rust/+/refs/heads/main@d5e61216a74efede682f88c65a9fe59769848c76",
"title": "d5e61216a74efede682f88c65a9fe59769848c76",
"url": "https://fuchsia.googlesource.com/third_party/rust/+/d5e61216a74efede682f88c65a9fe59769848c76"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/third_party/rust",
"revision": "312a1240a3cde43ca16e5275457688e47d7bccd8"
},
"id": "https://fuchsia.googlesource.com/third_party/rust/+/refs/heads/main@312a1240a3cde43ca16e5275457688e47d7bccd8",
"title": "312a1240a3cde43ca16e5275457688e47d7bccd8",
"url": "https://fuchsia.googlesource.com/third_party/rust/+/312a1240a3cde43ca16e5275457688e47d7bccd8"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/third_party/rust",
"revision": "9fc8374c2c4b9b04820999153d9b66f7a3df4ce0"
},
"id": "https://fuchsia.googlesource.com/third_party/rust/+/refs/heads/main@9fc8374c2c4b9b04820999153d9b66f7a3df4ce0",
"title": "9fc8374c2c4b9b04820999153d9b66f7a3df4ce0",
"url": "https://fuchsia.googlesource.com/third_party/rust/+/9fc8374c2c4b9b04820999153d9b66f7a3df4ce0"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/third_party/rust",
"revision": "020edbe4cf41aef407ac57eeb90c9a244c55d103"
},
"id": "https://fuchsia.googlesource.com/third_party/rust/+/refs/heads/main@020edbe4cf41aef407ac57eeb90c9a244c55d103",
"title": "020edbe4cf41aef407ac57eeb90c9a244c55d103",
"url": "https://fuchsia.googlesource.com/third_party/rust/+/020edbe4cf41aef407ac57eeb90c9a244c55d103"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/third_party/rust",
"revision": "bc0dfaa048e0549d7d8b275bc240ba4862925307"
},
"id": "https://fuchsia.googlesource.com/third_party/rust/+/refs/heads/main@bc0dfaa048e0549d7d8b275bc240ba4862925307",
"title": "bc0dfaa048e0549d7d8b275bc240ba4862925307",
"url": "https://fuchsia.googlesource.com/third_party/rust/+/bc0dfaa048e0549d7d8b275bc240ba4862925307"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/third_party/rust",
"revision": "a0c5e6b0413db76778ca84f6ba195e3b36d8d233"
},
"id": "https://fuchsia.googlesource.com/third_party/rust/+/refs/heads/main@a0c5e6b0413db76778ca84f6ba195e3b36d8d233",
"title": "a0c5e6b0413db76778ca84f6ba195e3b36d8d233",
"url": "https://fuchsia.googlesource.com/third_party/rust/+/a0c5e6b0413db76778ca84f6ba195e3b36d8d233"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/third_party/rust",
"revision": "8fe82a0e9ed29112be7f15ceeedb4f11d0c06410"
},
"id": "https://fuchsia.googlesource.com/third_party/rust/+/refs/heads/main@8fe82a0e9ed29112be7f15ceeedb4f11d0c06410",
"title": "8fe82a0e9ed29112be7f15ceeedb4f11d0c06410",
"url": "https://fuchsia.googlesource.com/third_party/rust/+/8fe82a0e9ed29112be7f15ceeedb4f11d0c06410"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/third_party/rust",
"revision": "6f5fad5dad91744d3a34ce84b485f4662fbd415b"
},
"id": "https://fuchsia.googlesource.com/third_party/rust/+/refs/heads/main@6f5fad5dad91744d3a34ce84b485f4662fbd415b",
"title": "6f5fad5dad91744d3a34ce84b485f4662fbd415b",
"url": "https://fuchsia.googlesource.com/third_party/rust/+/6f5fad5dad91744d3a34ce84b485f4662fbd415b"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/third_party/rust",
"revision": "6d5caf3a4a358c80f09ba51d71db0dbc41381992"
},
"id": "https://fuchsia.googlesource.com/third_party/rust/+/refs/heads/main@6d5caf3a4a358c80f09ba51d71db0dbc41381992",
"title": "6d5caf3a4a358c80f09ba51d71db0dbc41381992",
"url": "https://fuchsia.googlesource.com/third_party/rust/+/6d5caf3a4a358c80f09ba51d71db0dbc41381992"
}
]
}
},
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "third_party/rust",
"id": "6d5caf3a4a358c80f09ba51d71db0dbc41381992",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8869895229629524528"
},
{
"key": "scheduler_job_id",
"value": "fuchsia/toolchain.ci-rust-linux-x64-49def413"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[15:22:33.995] Scheduled build:
{
"id": "8704465167742338097",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "rust-linux-x64"
},
"createdBy": "project:fuchsia",
"createTime": "2025-09-06T15:22:33.679498390Z",
"updateTime": "2025-09-06T15:22:33.679498390Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "third_party/rust",
"id": "6d5caf3a4a358c80f09ba51d71db0dbc41381992",
"ref": "refs/heads/main"
}
}
}
[15:22:33.995] Task URL: https://cr-buildbucket.appspot.com/build/8704465167742338097
[15:22:33.995] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust-linux-x64-49def413:8869895229629524528:2:0) after 3m49s
[15:22:34.987] Received PubSub notification, asking Buildbucket for the build status
[15:22:35.031] Build status: SCHEDULED
[15:22:38.147] Received PubSub notification, asking Buildbucket for the build status
[15:22:38.164] Build status: STARTED
[15:26:23.048] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust-linux-x64-49def413:8869895229629524528:2:0)
[15:26:23.071] Build status: STARTED
[15:26:23.071] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust-linux-x64-49def413:8869895229629524528:5:0) after 1m11s
[15:27:34.087] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust-linux-x64-49def413:8869895229629524528:5:0)
[15:27:34.187] Build status: STARTED
[15:27:34.187] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust-linux-x64-49def413:8869895229629524528:6:0) after 4m30s
[15:32:04.202] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust-linux-x64-49def413:8869895229629524528:6:0)
[15:32:04.235] Build status: STARTED
[15:32:04.235] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust-linux-x64-49def413:8869895229629524528:7:0) after 4m25s
[15:36:29.240] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust-linux-x64-49def413:8869895229629524528:7:0)
[15:36:29.297] Build status: STARTED
[15:36:29.297] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust-linux-x64-49def413:8869895229629524528:8:0) after 9m0s
[15:45:29.319] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust-linux-x64-49def413:8869895229629524528:8:0)
[15:45:29.399] Build status: STARTED
[15:45:29.399] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust-linux-x64-49def413:8869895229629524528:9:0) after 6m30s
[15:51:59.497] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust-linux-x64-49def413:8869895229629524528:9:0)
[15:51:59.526] Build status: STARTED
[15:51:59.526] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust-linux-x64-49def413:8869895229629524528:10:0) after 2m58s
[15:54:57.621] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust-linux-x64-49def413:8869895229629524528:10:0)
[15:54:57.665] Build status: STARTED
[15:54:57.665] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust-linux-x64-49def413:8869895229629524528:11:0) after 6m18s
[16:01:16.020] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust-linux-x64-49def413:8869895229629524528:11:0)
[16:01:16.035] Build status: STARTED
[16:01:16.035] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust-linux-x64-49def413:8869895229629524528:12:0) after 1m14s
[16:02:30.114] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust-linux-x64-49def413:8869895229629524528:12:0)
[16:02:30.132] Build status: STARTED
[16:02:30.132] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust-linux-x64-49def413:8869895229629524528:13:0) after 1m17s
[16:03:47.283] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust-linux-x64-49def413:8869895229629524528:13:0)
[16:03:47.300] Build status: STARTED
[16:03:47.300] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust-linux-x64-49def413:8869895229629524528:14:0) after 6m29s
[16:05:00.196] Received PubSub notification, asking Buildbucket for the build status
[16:05:00.211] Build:
{
"id": "8704465167742338097",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "rust-linux-x64"
},
"createdBy": "project:fuchsia",
"createTime": "2025-09-06T15:22:33.679498390Z",
"startTime": "2025-09-06T15:22:36.309589417Z",
"endTime": "2025-09-06T16:04:58.885370470Z",
"updateTime": "2025-09-06T16:04:58.885370470Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "third_party/rust",
"id": "6d5caf3a4a358c80f09ba51d71db0dbc41381992",
"ref": "refs/heads/main"
}
}
}
[16:05:00.211] Invocation finished in 42m27.715170403s with status SUCCEEDED