[09:13:58.266] New invocation is queued and will start shortly
[09:13:59.405] Starting the invocation (attempt 1)
[09:13:59.432] Popped buildset tag "buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/22576e2ccec60af6d27d8fd95ad3ca721b914815"
[09:13:59.432] Popped gitiles commit info from properties and tags
[09:13:59.432] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[09:13:59.432] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[09:13:59.432] Buildbucket request:
{
"requestId": "8880155875288781456",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-mac-arm64"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8880155875288781456",
"job": "fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "1c2c02c8cbb6949c06fe26a72200ccfb37ac8c96"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@1c2c02c8cbb6949c06fe26a72200ccfb37ac8c96",
"title": "1c2c02c8cbb6949c06fe26a72200ccfb37ac8c96",
"url": "https://llvm.googlesource.com/llvm-project/+/1c2c02c8cbb6949c06fe26a72200ccfb37ac8c96"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "bf92b127d2637948f53d11a187e865aa10e2e74c"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@bf92b127d2637948f53d11a187e865aa10e2e74c",
"title": "bf92b127d2637948f53d11a187e865aa10e2e74c",
"url": "https://llvm.googlesource.com/llvm-project/+/bf92b127d2637948f53d11a187e865aa10e2e74c"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "eb4fde9a4e7e43947be9116563f5307f745bc541"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@eb4fde9a4e7e43947be9116563f5307f745bc541",
"title": "eb4fde9a4e7e43947be9116563f5307f745bc541",
"url": "https://llvm.googlesource.com/llvm-project/+/eb4fde9a4e7e43947be9116563f5307f745bc541"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "39fa5b31c5e603ef96f5130913c86c821b2f0620"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@39fa5b31c5e603ef96f5130913c86c821b2f0620",
"title": "39fa5b31c5e603ef96f5130913c86c821b2f0620",
"url": "https://llvm.googlesource.com/llvm-project/+/39fa5b31c5e603ef96f5130913c86c821b2f0620"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "bb5566aac2f236d49c74ce3c53b5c832f4d9a22b"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@bb5566aac2f236d49c74ce3c53b5c832f4d9a22b",
"title": "bb5566aac2f236d49c74ce3c53b5c832f4d9a22b",
"url": "https://llvm.googlesource.com/llvm-project/+/bb5566aac2f236d49c74ce3c53b5c832f4d9a22b"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "82a9cb358b4977e06179419b472a5b7657e55963"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@82a9cb358b4977e06179419b472a5b7657e55963",
"title": "82a9cb358b4977e06179419b472a5b7657e55963",
"url": "https://llvm.googlesource.com/llvm-project/+/82a9cb358b4977e06179419b472a5b7657e55963"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "c2045f24eab06960e0418d7d82856407b19156ad"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@c2045f24eab06960e0418d7d82856407b19156ad",
"title": "c2045f24eab06960e0418d7d82856407b19156ad",
"url": "https://llvm.googlesource.com/llvm-project/+/c2045f24eab06960e0418d7d82856407b19156ad"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "fd85ffb4c43be80c179145a382d78a7c9ca3c1b7"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@fd85ffb4c43be80c179145a382d78a7c9ca3c1b7",
"title": "fd85ffb4c43be80c179145a382d78a7c9ca3c1b7",
"url": "https://llvm.googlesource.com/llvm-project/+/fd85ffb4c43be80c179145a382d78a7c9ca3c1b7"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "858649ad0e2bd4c24d4e577094707a53acfe6ade"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@858649ad0e2bd4c24d4e577094707a53acfe6ade",
"title": "858649ad0e2bd4c24d4e577094707a53acfe6ade",
"url": "https://llvm.googlesource.com/llvm-project/+/858649ad0e2bd4c24d4e577094707a53acfe6ade"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "3aaf44f95de24339d73c0093576a4a3cc42404ad"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@3aaf44f95de24339d73c0093576a4a3cc42404ad",
"title": "3aaf44f95de24339d73c0093576a4a3cc42404ad",
"url": "https://llvm.googlesource.com/llvm-project/+/3aaf44f95de24339d73c0093576a4a3cc42404ad"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "5e7bc5e080fb393c3ddb954fa9fd3714284f72c2"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@5e7bc5e080fb393c3ddb954fa9fd3714284f72c2",
"title": "5e7bc5e080fb393c3ddb954fa9fd3714284f72c2",
"url": "https://llvm.googlesource.com/llvm-project/+/5e7bc5e080fb393c3ddb954fa9fd3714284f72c2"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "aacebaeab5448b4ef614aa8aca52ca210e451f79"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@aacebaeab5448b4ef614aa8aca52ca210e451f79",
"title": "aacebaeab5448b4ef614aa8aca52ca210e451f79",
"url": "https://llvm.googlesource.com/llvm-project/+/aacebaeab5448b4ef614aa8aca52ca210e451f79"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "22576e2ccec60af6d27d8fd95ad3ca721b914815"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@22576e2ccec60af6d27d8fd95ad3ca721b914815",
"title": "22576e2ccec60af6d27d8fd95ad3ca721b914815",
"url": "https://llvm.googlesource.com/llvm-project/+/22576e2ccec60af6d27d8fd95ad3ca721b914815"
}
]
}
},
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "22576e2ccec60af6d27d8fd95ad3ca721b914815",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8880155875288781456"
},
{
"key": "scheduler_job_id",
"value": "fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[09:13:59.942] Scheduled build:
{
"id": "8714725813353176337",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-mac-arm64"
},
"createdBy": "project:fuchsia",
"createTime": "2025-05-16T09:13:59.490901993Z",
"updateTime": "2025-05-16T09:13:59.490901993Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "22576e2ccec60af6d27d8fd95ad3ca721b914815",
"ref": "refs/heads/main"
}
}
}
[09:13:59.942] Task URL: https://cr-buildbucket.appspot.com/build/8714725813353176337
[09:13:59.942] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8880155875288781456:2:0) after 2m44s
[09:14:02.114] Received PubSub notification, asking Buildbucket for the build status
[09:14:02.251] Build status: SCHEDULED
[09:14:05.102] Received PubSub notification, asking Buildbucket for the build status
[09:14:05.122] Build status: STARTED
[09:16:44.051] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8880155875288781456:2:0)
[09:16:44.083] Build status: STARTED
[09:16:44.083] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8880155875288781456:5:0) after 9m56s
[09:26:40.570] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8880155875288781456:5:0)
[09:26:40.602] Build status: STARTED
[09:26:40.602] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8880155875288781456:6:0) after 9m42s
[09:36:22.730] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8880155875288781456:6:0)
[09:36:22.760] Build status: STARTED
[09:36:22.760] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8880155875288781456:7:0) after 5m15s
[09:41:37.898] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8880155875288781456:7:0)
[09:41:37.936] Build status: STARTED
[09:41:37.936] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8880155875288781456:8:0) after 4m41s
[09:46:18.950] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8880155875288781456:8:0)
[09:46:19.001] Build status: STARTED
[09:46:19.001] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8880155875288781456:9:0) after 9m5s
[09:55:24.031] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8880155875288781456:9:0)
[09:55:24.056] Build status: STARTED
[09:55:24.056] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8880155875288781456:10:0) after 5m33s
[10:00:57.489] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8880155875288781456:10:0)
[10:00:57.511] Build status: STARTED
[10:00:57.511] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8880155875288781456:11:0) after 2m4s
[10:03:01.805] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8880155875288781456:11:0)
[10:03:01.828] Build status: STARTED
[10:03:01.828] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8880155875288781456:12:0) after 8m16s
[10:11:18.292] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8880155875288781456:12:0)
[10:11:18.315] Build status: STARTED
[10:11:18.315] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8880155875288781456:13:0) after 6m18s
[10:17:36.302] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8880155875288781456:13:0)
[10:17:36.327] Build status: STARTED
[10:17:36.327] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8880155875288781456:14:0) after 1m57s
[10:19:33.355] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8880155875288781456:14:0)
[10:19:33.375] Build status: STARTED
[10:19:33.375] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8880155875288781456:15:0) after 1m38s
[10:21:11.488] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8880155875288781456:15:0)
[10:21:11.513] Build status: STARTED
[10:21:11.513] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8880155875288781456:16:0) after 4m7s
[10:25:18.534] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8880155875288781456:16:0)
[10:25:18.553] Build status: STARTED
[10:25:18.553] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8880155875288781456:17:0) after 5m46s
[10:31:04.578] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8880155875288781456:17:0)
[10:31:04.594] Build status: STARTED
[10:31:04.594] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8880155875288781456:18:0) after 9m46s
[10:40:50.615] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8880155875288781456:18:0)
[10:40:50.631] Build status: STARTED
[10:40:50.631] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8880155875288781456:19:0) after 8m30s
[10:49:20.700] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8880155875288781456:19:0)
[10:49:20.724] Build status: STARTED
[10:49:20.724] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8880155875288781456:20:0) after 5m25s
[10:54:45.911] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8880155875288781456:20:0)
[10:54:45.934] Build status: STARTED
[10:54:45.934] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8880155875288781456:21:0) after 6m37s
[11:01:23.042] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8880155875288781456:21:0)
[11:01:23.062] Build status: STARTED
[11:01:23.062] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8880155875288781456:22:0) after 9m24s
[11:10:47.136] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8880155875288781456:22:0)
[11:10:47.171] Build status: STARTED
[11:10:47.171] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8880155875288781456:23:0) after 2m34s
[11:13:07.151] Received PubSub notification, asking Buildbucket for the build status
[11:13:07.173] Build:
{
"id": "8714725813353176337",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-mac-arm64"
},
"createdBy": "project:fuchsia",
"createTime": "2025-05-16T09:13:59.490901993Z",
"startTime": "2025-05-16T09:14:04.166019938Z",
"endTime": "2025-05-16T11:13:06.752098633Z",
"updateTime": "2025-05-16T11:13:06.752098633Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "22576e2ccec60af6d27d8fd95ad3ca721b914815",
"ref": "refs/heads/main"
}
}
}
[11:13:07.173] Invocation finished in 1h59m8.911957823s with status SUCCEEDED