[20:07:53.540] New invocation is queued and will start shortly
[20:07:56.310] Starting the invocation (attempt 1)
[20:07:56.342] Popped buildset tag "buildset:commit/gitiles/fuchsia.googlesource.com/third_party/rust/+/f7b5e5471b79a556dfd758a25265a777fbdad7ac"
[20:07:56.342] Popped gitiles commit info from properties and tags
[20:07:56.342] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[20:07:56.343] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[20:07:56.343] Buildbucket request:
{
"requestId": "8899140097073256176",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "rust_test-x64-linux"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8899140097073256176",
"job": "fuchsia/rust_test-x64-linux-49def413",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/third_party/rust",
"revision": "e569c5c92f09007ef593fd897336b337c34fa5c0"
},
"id": "https://fuchsia.googlesource.com/third_party/rust/+/refs/heads/main@e569c5c92f09007ef593fd897336b337c34fa5c0",
"title": "e569c5c92f09007ef593fd897336b337c34fa5c0",
"url": "https://fuchsia.googlesource.com/third_party/rust/+/e569c5c92f09007ef593fd897336b337c34fa5c0"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/third_party/rust",
"revision": "781bff049905d325bb877935978f1bce8ea6af86"
},
"id": "https://fuchsia.googlesource.com/third_party/rust/+/refs/heads/main@781bff049905d325bb877935978f1bce8ea6af86",
"title": "781bff049905d325bb877935978f1bce8ea6af86",
"url": "https://fuchsia.googlesource.com/third_party/rust/+/781bff049905d325bb877935978f1bce8ea6af86"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/third_party/rust",
"revision": "21a020881da6e7bbf3851971e1ec39f844616436"
},
"id": "https://fuchsia.googlesource.com/third_party/rust/+/refs/heads/main@21a020881da6e7bbf3851971e1ec39f844616436",
"title": "21a020881da6e7bbf3851971e1ec39f844616436",
"url": "https://fuchsia.googlesource.com/third_party/rust/+/21a020881da6e7bbf3851971e1ec39f844616436"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/third_party/rust",
"revision": "932e9f01b1f60370b3ffcb370cdbf3b62ac2e718"
},
"id": "https://fuchsia.googlesource.com/third_party/rust/+/refs/heads/main@932e9f01b1f60370b3ffcb370cdbf3b62ac2e718",
"title": "932e9f01b1f60370b3ffcb370cdbf3b62ac2e718",
"url": "https://fuchsia.googlesource.com/third_party/rust/+/932e9f01b1f60370b3ffcb370cdbf3b62ac2e718"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/third_party/rust",
"revision": "c4c62a5591bdaa061ef6bab7fc18b29ff02a00c4"
},
"id": "https://fuchsia.googlesource.com/third_party/rust/+/refs/heads/main@c4c62a5591bdaa061ef6bab7fc18b29ff02a00c4",
"title": "c4c62a5591bdaa061ef6bab7fc18b29ff02a00c4",
"url": "https://fuchsia.googlesource.com/third_party/rust/+/c4c62a5591bdaa061ef6bab7fc18b29ff02a00c4"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/third_party/rust",
"revision": "3f8d87beda3f615f1df19504f908fbe9e5824b83"
},
"id": "https://fuchsia.googlesource.com/third_party/rust/+/refs/heads/main@3f8d87beda3f615f1df19504f908fbe9e5824b83",
"title": "3f8d87beda3f615f1df19504f908fbe9e5824b83",
"url": "https://fuchsia.googlesource.com/third_party/rust/+/3f8d87beda3f615f1df19504f908fbe9e5824b83"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/third_party/rust",
"revision": "554097678a990255d580078e9d7f6b1d81d78752"
},
"id": "https://fuchsia.googlesource.com/third_party/rust/+/refs/heads/main@554097678a990255d580078e9d7f6b1d81d78752",
"title": "554097678a990255d580078e9d7f6b1d81d78752",
"url": "https://fuchsia.googlesource.com/third_party/rust/+/554097678a990255d580078e9d7f6b1d81d78752"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/third_party/rust",
"revision": "39af44dae986e91c8c7ea1a994781e8fb7fb6751"
},
"id": "https://fuchsia.googlesource.com/third_party/rust/+/refs/heads/main@39af44dae986e91c8c7ea1a994781e8fb7fb6751",
"title": "39af44dae986e91c8c7ea1a994781e8fb7fb6751",
"url": "https://fuchsia.googlesource.com/third_party/rust/+/39af44dae986e91c8c7ea1a994781e8fb7fb6751"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/third_party/rust",
"revision": "765e8c75b0b3dcfd9bb4de67c5a199d4c58f2db5"
},
"id": "https://fuchsia.googlesource.com/third_party/rust/+/refs/heads/main@765e8c75b0b3dcfd9bb4de67c5a199d4c58f2db5",
"title": "765e8c75b0b3dcfd9bb4de67c5a199d4c58f2db5",
"url": "https://fuchsia.googlesource.com/third_party/rust/+/765e8c75b0b3dcfd9bb4de67c5a199d4c58f2db5"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/third_party/rust",
"revision": "43e50932f2f885281871dd91d454a3cd3571ec61"
},
"id": "https://fuchsia.googlesource.com/third_party/rust/+/refs/heads/main@43e50932f2f885281871dd91d454a3cd3571ec61",
"title": "43e50932f2f885281871dd91d454a3cd3571ec61",
"url": "https://fuchsia.googlesource.com/third_party/rust/+/43e50932f2f885281871dd91d454a3cd3571ec61"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/third_party/rust",
"revision": "f7b5e5471b79a556dfd758a25265a777fbdad7ac"
},
"id": "https://fuchsia.googlesource.com/third_party/rust/+/refs/heads/main@f7b5e5471b79a556dfd758a25265a777fbdad7ac",
"title": "f7b5e5471b79a556dfd758a25265a777fbdad7ac",
"url": "https://fuchsia.googlesource.com/third_party/rust/+/f7b5e5471b79a556dfd758a25265a777fbdad7ac"
}
]
}
},
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "third_party/rust",
"id": "f7b5e5471b79a556dfd758a25265a777fbdad7ac",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8899140097073256176"
},
{
"key": "scheduler_job_id",
"value": "fuchsia/rust_test-x64-linux-49def413"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[20:07:56.777] Scheduled build:
{
"id": "8733710033410364257",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "rust_test-x64-linux"
},
"createdBy": "project:fuchsia",
"createTime": "2024-10-18T20:07:56.404597625Z",
"updateTime": "2024-10-18T20:07:56.404597625Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "third_party/rust",
"id": "f7b5e5471b79a556dfd758a25265a777fbdad7ac",
"ref": "refs/heads/main"
}
}
}
[20:07:56.777] Task URL: https://cr-buildbucket.appspot.com/build/8733710033410364257
[20:07:56.777] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_test-x64-linux-49def413:8899140097073256176:2:0) after 6m26s
[20:07:57.855] Received PubSub notification, asking Buildbucket for the build status
[20:07:57.872] Build status: SCHEDULED
[20:13:04.563] Received PubSub notification, asking Buildbucket for the build status
[20:13:04.591] Build status: STARTED
[20:14:22.754] Handling timer "check-buildbucket-build-status" (fuchsia/rust_test-x64-linux-49def413:8899140097073256176:2:0)
[20:14:22.783] Build status: STARTED
[20:14:22.783] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_test-x64-linux-49def413:8899140097073256176:5:0) after 9m9s
[20:23:31.806] Handling timer "check-buildbucket-build-status" (fuchsia/rust_test-x64-linux-49def413:8899140097073256176:5:0)
[20:23:31.823] Build status: STARTED
[20:23:31.823] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_test-x64-linux-49def413:8899140097073256176:6:0) after 3m43s
[20:27:14.845] Handling timer "check-buildbucket-build-status" (fuchsia/rust_test-x64-linux-49def413:8899140097073256176:6:0)
[20:27:14.870] Build status: STARTED
[20:27:14.870] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_test-x64-linux-49def413:8899140097073256176:7:0) after 5m16s
[20:32:30.907] Handling timer "check-buildbucket-build-status" (fuchsia/rust_test-x64-linux-49def413:8899140097073256176:7:0)
[20:32:30.934] Build status: STARTED
[20:32:30.934] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_test-x64-linux-49def413:8899140097073256176:8:0) after 1m38s
[20:34:08.957] Handling timer "check-buildbucket-build-status" (fuchsia/rust_test-x64-linux-49def413:8899140097073256176:8:0)
[20:34:08.974] Build status: STARTED
[20:34:08.974] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_test-x64-linux-49def413:8899140097073256176:9:0) after 2m30s
[20:36:39.047] Handling timer "check-buildbucket-build-status" (fuchsia/rust_test-x64-linux-49def413:8899140097073256176:9:0)
[20:36:39.065] Build status: STARTED
[20:36:39.065] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_test-x64-linux-49def413:8899140097073256176:10:0) after 1m23s
[20:38:02.116] Handling timer "check-buildbucket-build-status" (fuchsia/rust_test-x64-linux-49def413:8899140097073256176:10:0)
[20:38:02.134] Build status: STARTED
[20:38:02.134] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_test-x64-linux-49def413:8899140097073256176:11:0) after 6m13s
[20:44:15.217] Handling timer "check-buildbucket-build-status" (fuchsia/rust_test-x64-linux-49def413:8899140097073256176:11:0)
[20:44:15.235] Build status: STARTED
[20:44:15.235] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_test-x64-linux-49def413:8899140097073256176:12:0) after 5m21s
[20:49:36.254] Handling timer "check-buildbucket-build-status" (fuchsia/rust_test-x64-linux-49def413:8899140097073256176:12:0)
[20:49:36.279] Build status: STARTED
[20:49:36.279] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_test-x64-linux-49def413:8899140097073256176:13:0) after 3m4s
[20:52:40.341] Handling timer "check-buildbucket-build-status" (fuchsia/rust_test-x64-linux-49def413:8899140097073256176:13:0)
[20:52:40.359] Build status: STARTED
[20:52:40.359] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_test-x64-linux-49def413:8899140097073256176:14:0) after 2m24s
[20:55:04.376] Handling timer "check-buildbucket-build-status" (fuchsia/rust_test-x64-linux-49def413:8899140097073256176:14:0)
[20:55:04.395] Build status: STARTED
[20:55:04.395] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_test-x64-linux-49def413:8899140097073256176:15:0) after 6m36s
[21:01:40.413] Handling timer "check-buildbucket-build-status" (fuchsia/rust_test-x64-linux-49def413:8899140097073256176:15:0)
[21:01:40.434] Build status: STARTED
[21:01:40.435] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_test-x64-linux-49def413:8899140097073256176:16:0) after 9m1s
[21:10:41.454] Handling timer "check-buildbucket-build-status" (fuchsia/rust_test-x64-linux-49def413:8899140097073256176:16:0)
[21:10:41.474] Build status: STARTED
[21:10:41.474] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_test-x64-linux-49def413:8899140097073256176:17:0) after 5m14s
[21:15:55.572] Handling timer "check-buildbucket-build-status" (fuchsia/rust_test-x64-linux-49def413:8899140097073256176:17:0)
[21:15:55.592] Build status: STARTED
[21:15:55.593] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_test-x64-linux-49def413:8899140097073256176:18:0) after 3m22s
[21:19:17.610] Handling timer "check-buildbucket-build-status" (fuchsia/rust_test-x64-linux-49def413:8899140097073256176:18:0)
[21:19:17.631] Build status: STARTED
[21:19:17.631] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_test-x64-linux-49def413:8899140097073256176:19:0) after 7m17s
[21:21:07.016] Received PubSub notification, asking Buildbucket for the build status
[21:21:07.037] Build:
{
"id": "8733710033410364257",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "rust_test-x64-linux"
},
"createdBy": "project:fuchsia",
"createTime": "2024-10-18T20:07:56.404597625Z",
"startTime": "2024-10-18T20:13:04.313796485Z",
"endTime": "2024-10-18T21:21:06.740328158Z",
"updateTime": "2024-10-18T21:21:06.740328158Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "third_party/rust",
"id": "f7b5e5471b79a556dfd758a25265a777fbdad7ac",
"ref": "refs/heads/main"
}
}
}
[21:21:07.037] Invocation finished in 1h13m13.509093915s with status SUCCEEDED