[06:22:33.006] New invocation is queued and will start shortly
[06:22:34.177] Starting the invocation (attempt 1)
[06:22:34.207] Popped buildset tag "buildset:commit/gitiles/fuchsia.googlesource.com/third_party/rust/+/8417f8311fcb596030768a817e1e4eacb214b78e"
[06:22:34.207] Popped gitiles commit info from properties and tags
[06:22:34.207] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[06:22:34.207] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[06:22:34.208] Buildbucket request:
{
"requestId": "8892034862772544512",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "rust-arm64-mac"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8892034862772544512",
"job": "fuchsia/rust-arm64-mac-49def413",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/third_party/rust",
"revision": "891041fbc994648f3ab771e9e9147a9fddc6006f"
},
"id": "https://fuchsia.googlesource.com/third_party/rust/+/refs/heads/main@891041fbc994648f3ab771e9e9147a9fddc6006f",
"title": "891041fbc994648f3ab771e9e9147a9fddc6006f",
"url": "https://fuchsia.googlesource.com/third_party/rust/+/891041fbc994648f3ab771e9e9147a9fddc6006f"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/third_party/rust",
"revision": "4a5e76a70e3d33b0eb4a233f60de5578b22bfba5"
},
"id": "https://fuchsia.googlesource.com/third_party/rust/+/refs/heads/main@4a5e76a70e3d33b0eb4a233f60de5578b22bfba5",
"title": "4a5e76a70e3d33b0eb4a233f60de5578b22bfba5",
"url": "https://fuchsia.googlesource.com/third_party/rust/+/4a5e76a70e3d33b0eb4a233f60de5578b22bfba5"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/third_party/rust",
"revision": "2389daab1b16e75216390063a1c97fccc3e0d2af"
},
"id": "https://fuchsia.googlesource.com/third_party/rust/+/refs/heads/main@2389daab1b16e75216390063a1c97fccc3e0d2af",
"title": "2389daab1b16e75216390063a1c97fccc3e0d2af",
"url": "https://fuchsia.googlesource.com/third_party/rust/+/2389daab1b16e75216390063a1c97fccc3e0d2af"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/third_party/rust",
"revision": "33b0606041a4d73d320c5cf5f7a3deeb87429daf"
},
"id": "https://fuchsia.googlesource.com/third_party/rust/+/refs/heads/main@33b0606041a4d73d320c5cf5f7a3deeb87429daf",
"title": "33b0606041a4d73d320c5cf5f7a3deeb87429daf",
"url": "https://fuchsia.googlesource.com/third_party/rust/+/33b0606041a4d73d320c5cf5f7a3deeb87429daf"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/third_party/rust",
"revision": "3d871b3ced0af12a84e3d17060399ca1af8d7bc1"
},
"id": "https://fuchsia.googlesource.com/third_party/rust/+/refs/heads/main@3d871b3ced0af12a84e3d17060399ca1af8d7bc1",
"title": "3d871b3ced0af12a84e3d17060399ca1af8d7bc1",
"url": "https://fuchsia.googlesource.com/third_party/rust/+/3d871b3ced0af12a84e3d17060399ca1af8d7bc1"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/third_party/rust",
"revision": "1ed0ea459dc5456ebcedb798cc88671014cf0f68"
},
"id": "https://fuchsia.googlesource.com/third_party/rust/+/refs/heads/main@1ed0ea459dc5456ebcedb798cc88671014cf0f68",
"title": "1ed0ea459dc5456ebcedb798cc88671014cf0f68",
"url": "https://fuchsia.googlesource.com/third_party/rust/+/1ed0ea459dc5456ebcedb798cc88671014cf0f68"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/third_party/rust",
"revision": "e30369fcb4ecef988f90ccbb1e9162c29f3b4542"
},
"id": "https://fuchsia.googlesource.com/third_party/rust/+/refs/heads/main@e30369fcb4ecef988f90ccbb1e9162c29f3b4542",
"title": "e30369fcb4ecef988f90ccbb1e9162c29f3b4542",
"url": "https://fuchsia.googlesource.com/third_party/rust/+/e30369fcb4ecef988f90ccbb1e9162c29f3b4542"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/third_party/rust",
"revision": "78e681ac7409425f036f5fb61c75510fc839478b"
},
"id": "https://fuchsia.googlesource.com/third_party/rust/+/refs/heads/main@78e681ac7409425f036f5fb61c75510fc839478b",
"title": "78e681ac7409425f036f5fb61c75510fc839478b",
"url": "https://fuchsia.googlesource.com/third_party/rust/+/78e681ac7409425f036f5fb61c75510fc839478b"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/third_party/rust",
"revision": "dcb8be8934a3e3f2ba6f15612d482c0945bedd5f"
},
"id": "https://fuchsia.googlesource.com/third_party/rust/+/refs/heads/main@dcb8be8934a3e3f2ba6f15612d482c0945bedd5f",
"title": "dcb8be8934a3e3f2ba6f15612d482c0945bedd5f",
"url": "https://fuchsia.googlesource.com/third_party/rust/+/dcb8be8934a3e3f2ba6f15612d482c0945bedd5f"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/third_party/rust",
"revision": "5be6c9bc12d68d9f8e29b881cfffb6ba9442c519"
},
"id": "https://fuchsia.googlesource.com/third_party/rust/+/refs/heads/main@5be6c9bc12d68d9f8e29b881cfffb6ba9442c519",
"title": "5be6c9bc12d68d9f8e29b881cfffb6ba9442c519",
"url": "https://fuchsia.googlesource.com/third_party/rust/+/5be6c9bc12d68d9f8e29b881cfffb6ba9442c519"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/third_party/rust",
"revision": "bfd7ac17f95952d445ff64e91fc36813c2ea33f9"
},
"id": "https://fuchsia.googlesource.com/third_party/rust/+/refs/heads/main@bfd7ac17f95952d445ff64e91fc36813c2ea33f9",
"title": "bfd7ac17f95952d445ff64e91fc36813c2ea33f9",
"url": "https://fuchsia.googlesource.com/third_party/rust/+/bfd7ac17f95952d445ff64e91fc36813c2ea33f9"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/third_party/rust",
"revision": "8417f8311fcb596030768a817e1e4eacb214b78e"
},
"id": "https://fuchsia.googlesource.com/third_party/rust/+/refs/heads/main@8417f8311fcb596030768a817e1e4eacb214b78e",
"title": "8417f8311fcb596030768a817e1e4eacb214b78e",
"url": "https://fuchsia.googlesource.com/third_party/rust/+/8417f8311fcb596030768a817e1e4eacb214b78e"
}
]
}
},
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "third_party/rust",
"id": "8417f8311fcb596030768a817e1e4eacb214b78e",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8892034862772544512"
},
{
"key": "scheduler_job_id",
"value": "fuchsia/rust-arm64-mac-49def413"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[06:22:34.571] Scheduled build:
{
"id": "8726604800793939521",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "rust-arm64-mac"
},
"createdBy": "project:fuchsia",
"createTime": "2025-01-05T06:22:34.263729059Z",
"updateTime": "2025-01-05T06:22:34.263729059Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "third_party/rust",
"id": "8417f8311fcb596030768a817e1e4eacb214b78e",
"ref": "refs/heads/main"
}
}
}
[06:22:34.571] Task URL: https://cr-buildbucket.appspot.com/build/8726604800793939521
[06:22:34.572] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust-arm64-mac-49def413:8892034862772544512:2:0) after 2m12s
[06:22:34.714] Received PubSub notification, asking Buildbucket for the build status
[06:22:34.800] Build status: SCHEDULED
[06:22:38.144] Received PubSub notification, asking Buildbucket for the build status
[06:22:38.166] Build status: STARTED
[06:24:46.596] Handling timer "check-buildbucket-build-status" (fuchsia/rust-arm64-mac-49def413:8892034862772544512:2:0)
[06:24:46.613] Build status: STARTED
[06:24:46.614] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust-arm64-mac-49def413:8892034862772544512:5:0) after 9m31s
[06:34:17.640] Handling timer "check-buildbucket-build-status" (fuchsia/rust-arm64-mac-49def413:8892034862772544512:5:0)
[06:34:17.657] Build status: STARTED
[06:34:17.657] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust-arm64-mac-49def413:8892034862772544512:6:0) after 8m4s
[06:42:21.682] Handling timer "check-buildbucket-build-status" (fuchsia/rust-arm64-mac-49def413:8892034862772544512:6:0)
[06:42:21.801] Build status: STARTED
[06:42:21.801] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust-arm64-mac-49def413:8892034862772544512:7:0) after 6m50s
[06:49:11.823] Handling timer "check-buildbucket-build-status" (fuchsia/rust-arm64-mac-49def413:8892034862772544512:7:0)
[06:49:11.852] Build status: STARTED
[06:49:11.852] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust-arm64-mac-49def413:8892034862772544512:8:0) after 6m30s
[06:55:41.877] Handling timer "check-buildbucket-build-status" (fuchsia/rust-arm64-mac-49def413:8892034862772544512:8:0)
[06:55:41.903] Build status: STARTED
[06:55:41.903] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust-arm64-mac-49def413:8892034862772544512:9:0) after 5m5s
[07:00:46.981] Handling timer "check-buildbucket-build-status" (fuchsia/rust-arm64-mac-49def413:8892034862772544512:9:0)
[07:00:47.004] Build status: STARTED
[07:00:47.004] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust-arm64-mac-49def413:8892034862772544512:10:0) after 9m25s
[07:10:12.244] Handling timer "check-buildbucket-build-status" (fuchsia/rust-arm64-mac-49def413:8892034862772544512:10:0)
[07:10:12.298] Build status: STARTED
[07:10:12.298] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust-arm64-mac-49def413:8892034862772544512:11:0) after 5m3s
[07:14:03.133] Received PubSub notification, asking Buildbucket for the build status
[07:14:03.169] Build:
{
"id": "8726604800793939521",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "rust-arm64-mac"
},
"createdBy": "project:fuchsia",
"createTime": "2025-01-05T06:22:34.263729059Z",
"startTime": "2025-01-05T06:22:37.938701773Z",
"endTime": "2025-01-05T07:13:56.695297245Z",
"updateTime": "2025-01-05T07:13:56.695297245Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "third_party/rust",
"id": "8417f8311fcb596030768a817e1e4eacb214b78e",
"ref": "refs/heads/main"
}
}
}
[07:14:03.169] Invocation finished in 51m30.177062202s with status SUCCEEDED