[13:48:52.560] New invocation is queued and will start shortly
[13:48:53.881] Starting the invocation (attempt 1)
[13:48:53.913] Popped buildset tag "buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/53b48301eb3bb4aba63678e9b5eb7cbea7745e34"
[13:48:53.913] Popped gitiles commit info from properties and tags
[13:48:53.913] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[13:48:53.913] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[13:48:53.913] Buildbucket request:
{
"requestId": "8884577831130557888",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-mac-arm64"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8884577831130557888",
"job": "fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "7f103ad537a64cd47dc49c661ad0245ea3ae2fdc"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@7f103ad537a64cd47dc49c661ad0245ea3ae2fdc",
"title": "7f103ad537a64cd47dc49c661ad0245ea3ae2fdc",
"url": "https://llvm.googlesource.com/llvm-project/+/7f103ad537a64cd47dc49c661ad0245ea3ae2fdc"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "f76254d9b2a68e0021d93e682744e4240a2368b9"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@f76254d9b2a68e0021d93e682744e4240a2368b9",
"title": "f76254d9b2a68e0021d93e682744e4240a2368b9",
"url": "https://llvm.googlesource.com/llvm-project/+/f76254d9b2a68e0021d93e682744e4240a2368b9"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "4cdcf3b19302d8f337b5607d6b9df170f577dc70"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@4cdcf3b19302d8f337b5607d6b9df170f577dc70",
"title": "4cdcf3b19302d8f337b5607d6b9df170f577dc70",
"url": "https://llvm.googlesource.com/llvm-project/+/4cdcf3b19302d8f337b5607d6b9df170f577dc70"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "c4bc1b1d8177961c50c7a197bfb97b5226e749ff"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@c4bc1b1d8177961c50c7a197bfb97b5226e749ff",
"title": "c4bc1b1d8177961c50c7a197bfb97b5226e749ff",
"url": "https://llvm.googlesource.com/llvm-project/+/c4bc1b1d8177961c50c7a197bfb97b5226e749ff"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "772173f54868eef6e1a4d40ab93b0ee6c04b1aca"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@772173f54868eef6e1a4d40ab93b0ee6c04b1aca",
"title": "772173f54868eef6e1a4d40ab93b0ee6c04b1aca",
"url": "https://llvm.googlesource.com/llvm-project/+/772173f54868eef6e1a4d40ab93b0ee6c04b1aca"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "212a48b4daf3101871ba6e7c47cf103df66a5e56"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@212a48b4daf3101871ba6e7c47cf103df66a5e56",
"title": "212a48b4daf3101871ba6e7c47cf103df66a5e56",
"url": "https://llvm.googlesource.com/llvm-project/+/212a48b4daf3101871ba6e7c47cf103df66a5e56"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "a481452cd88acc180f82dd5631257c8954ed7812"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@a481452cd88acc180f82dd5631257c8954ed7812",
"title": "a481452cd88acc180f82dd5631257c8954ed7812",
"url": "https://llvm.googlesource.com/llvm-project/+/a481452cd88acc180f82dd5631257c8954ed7812"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "33cd00f8c82d5df45b1dfd59310929a4d315fd8e"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@33cd00f8c82d5df45b1dfd59310929a4d315fd8e",
"title": "33cd00f8c82d5df45b1dfd59310929a4d315fd8e",
"url": "https://llvm.googlesource.com/llvm-project/+/33cd00f8c82d5df45b1dfd59310929a4d315fd8e"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "4abff4d7b2b49f343da68f32ffdae2914ba8ae7f"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@4abff4d7b2b49f343da68f32ffdae2914ba8ae7f",
"title": "4abff4d7b2b49f343da68f32ffdae2914ba8ae7f",
"url": "https://llvm.googlesource.com/llvm-project/+/4abff4d7b2b49f343da68f32ffdae2914ba8ae7f"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "316bb89c942c1a1cf61d3e673030f82d6f0b8acf"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@316bb89c942c1a1cf61d3e673030f82d6f0b8acf",
"title": "316bb89c942c1a1cf61d3e673030f82d6f0b8acf",
"url": "https://llvm.googlesource.com/llvm-project/+/316bb89c942c1a1cf61d3e673030f82d6f0b8acf"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "ecdbd26ba4b6017200b7773d41a270aa1fa2bd71"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@ecdbd26ba4b6017200b7773d41a270aa1fa2bd71",
"title": "ecdbd26ba4b6017200b7773d41a270aa1fa2bd71",
"url": "https://llvm.googlesource.com/llvm-project/+/ecdbd26ba4b6017200b7773d41a270aa1fa2bd71"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "d6dcd985c03bec4b77872be00a81d92454fedc32"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@d6dcd985c03bec4b77872be00a81d92454fedc32",
"title": "d6dcd985c03bec4b77872be00a81d92454fedc32",
"url": "https://llvm.googlesource.com/llvm-project/+/d6dcd985c03bec4b77872be00a81d92454fedc32"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "53b48301eb3bb4aba63678e9b5eb7cbea7745e34"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@53b48301eb3bb4aba63678e9b5eb7cbea7745e34",
"title": "53b48301eb3bb4aba63678e9b5eb7cbea7745e34",
"url": "https://llvm.googlesource.com/llvm-project/+/53b48301eb3bb4aba63678e9b5eb7cbea7745e34"
}
]
}
},
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "53b48301eb3bb4aba63678e9b5eb7cbea7745e34",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8884577831130557888"
},
{
"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"
}
}
[13:48:54.335] Scheduled build:
{
"id": "8719147768981765553",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-mac-arm64"
},
"createdBy": "project:fuchsia",
"createTime": "2025-03-28T13:48:53.979709545Z",
"updateTime": "2025-03-28T13:48:53.979709545Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "53b48301eb3bb4aba63678e9b5eb7cbea7745e34",
"ref": "refs/heads/main"
}
}
}
[13:48:54.335] Task URL: https://cr-buildbucket.appspot.com/build/8719147768981765553
[13:48:54.336] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8884577831130557888:2:0) after 8m57s
[13:48:55.400] Received PubSub notification, asking Buildbucket for the build status
[13:48:55.423] Build status: SCHEDULED
[13:48:59.107] Received PubSub notification, asking Buildbucket for the build status
[13:48:59.166] Build status: STARTED
[13:57:51.420] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8884577831130557888:2:0)
[13:57:51.515] Build status: STARTED
[13:57:51.515] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8884577831130557888:5:0) after 3m25s
[14:01:16.569] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8884577831130557888:5:0)
[14:01:16.609] Build status: STARTED
[14:01:16.609] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8884577831130557888:6:0) after 8m15s
[14:09:31.629] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8884577831130557888:6:0)
[14:09:31.652] Build status: STARTED
[14:09:31.652] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8884577831130557888:7:0) after 8m49s
[14:18:20.670] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8884577831130557888:7:0)
[14:18:20.697] Build status: STARTED
[14:18:20.697] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8884577831130557888:8:0) after 4m57s
[14:23:17.728] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8884577831130557888:8:0)
[14:23:17.764] Build status: STARTED
[14:23:17.764] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8884577831130557888:9:0) after 5m16s
[14:28:33.828] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8884577831130557888:9:0)
[14:28:33.854] Build status: STARTED
[14:28:33.854] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8884577831130557888:10:0) after 8m23s
[14:36:56.874] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8884577831130557888:10:0)
[14:36:56.904] Build status: STARTED
[14:36:56.904] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8884577831130557888:11:0) after 1m18s
[14:38:15.003] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8884577831130557888:11:0)
[14:38:15.149] Build status: STARTED
[14:38:15.149] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8884577831130557888:12:0) after 6m2s
[14:44:17.227] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8884577831130557888:12:0)
[14:44:17.343] Build status: STARTED
[14:44:17.343] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8884577831130557888:13:0) after 2m43s
[14:47:00.368] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8884577831130557888:13:0)
[14:47:00.391] Build status: STARTED
[14:47:00.391] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8884577831130557888:14:0) after 8m17s
[14:55:17.483] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8884577831130557888:14:0)
[14:55:17.519] Build status: STARTED
[14:55:17.519] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8884577831130557888:15:0) after 7m55s
[15:03:12.560] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8884577831130557888:15:0)
[15:03:12.590] Build status: STARTED
[15:03:12.590] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8884577831130557888:16:0) after 2m24s
[15:05:36.616] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8884577831130557888:16:0)
[15:05:36.639] Build status: STARTED
[15:05:36.639] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8884577831130557888:17:0) after 1m26s
[15:07:02.665] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8884577831130557888:17:0)
[15:07:02.693] Build status: STARTED
[15:07:02.693] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8884577831130557888:18:0) after 4m50s
[15:11:52.721] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8884577831130557888:18:0)
[15:11:52.750] Build status: STARTED
[15:11:52.750] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8884577831130557888:19:0) after 8m59s
[15:20:51.941] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8884577831130557888:19:0)
[15:20:51.959] Build status: STARTED
[15:20:51.959] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8884577831130557888:20:0) after 6m32s
[15:27:23.980] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8884577831130557888:20:0)
[15:27:24.001] Build status: STARTED
[15:27:24.001] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8884577831130557888:21:0) after 4m59s
[15:32:23.031] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8884577831130557888:21:0)
[15:32:23.063] Build status: STARTED
[15:32:23.063] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8884577831130557888:22:0) after 9m36s
[15:36:59.959] Received PubSub notification, asking Buildbucket for the build status
[15:37:00.019] Build:
{
"id": "8719147768981765553",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-mac-arm64"
},
"createdBy": "project:fuchsia",
"createTime": "2025-03-28T13:48:53.979709545Z",
"startTime": "2025-03-28T13:48:58.749484621Z",
"endTime": "2025-03-28T15:36:59.659620701Z",
"updateTime": "2025-03-28T15:36:59.659620701Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "53b48301eb3bb4aba63678e9b5eb7cbea7745e34",
"ref": "refs/heads/main"
}
}
}
[15:37:00.019] Invocation finished in 1h48m7.472774111s with status SUCCEEDED