[17:25:17.198] New invocation is queued and will start shortly
[17:25:19.991] Starting the invocation (attempt 1)
[17:25:20.027] Popped buildset tag "buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/8c7550132f410766598ba88de6b7e7a2a4607f67"
[17:25:20.027] Popped gitiles commit info from properties and tags
[17:25:20.027] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[17:25:20.028] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[17:25:20.028] Buildbucket request:
{
"requestId": "8884564215748456288",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-mac-arm64"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8884564215748456288",
"job": "fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "71a977d0d611f3e9f6137a6b8a26b730b2886ce9"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@71a977d0d611f3e9f6137a6b8a26b730b2886ce9",
"title": "71a977d0d611f3e9f6137a6b8a26b730b2886ce9",
"url": "https://llvm.googlesource.com/llvm-project/+/71a977d0d611f3e9f6137a6b8a26b730b2886ce9"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "a983c3b209bf6602c0687251647535c7fa43a17a"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@a983c3b209bf6602c0687251647535c7fa43a17a",
"title": "a983c3b209bf6602c0687251647535c7fa43a17a",
"url": "https://llvm.googlesource.com/llvm-project/+/a983c3b209bf6602c0687251647535c7fa43a17a"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "f7f479b2a3ac4c242339896fe1012342dc1e56fc"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@f7f479b2a3ac4c242339896fe1012342dc1e56fc",
"title": "f7f479b2a3ac4c242339896fe1012342dc1e56fc",
"url": "https://llvm.googlesource.com/llvm-project/+/f7f479b2a3ac4c242339896fe1012342dc1e56fc"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "a33d789bb70e8b19840cacfc1980da883ae01ebd"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@a33d789bb70e8b19840cacfc1980da883ae01ebd",
"title": "a33d789bb70e8b19840cacfc1980da883ae01ebd",
"url": "https://llvm.googlesource.com/llvm-project/+/a33d789bb70e8b19840cacfc1980da883ae01ebd"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "6526cda5d865d55b1db5aa0faffb29448e5c6a23"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@6526cda5d865d55b1db5aa0faffb29448e5c6a23",
"title": "6526cda5d865d55b1db5aa0faffb29448e5c6a23",
"url": "https://llvm.googlesource.com/llvm-project/+/6526cda5d865d55b1db5aa0faffb29448e5c6a23"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "4abe47c6fc06e44792bc1b0dc58f3b453ae4fb80"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@4abe47c6fc06e44792bc1b0dc58f3b453ae4fb80",
"title": "4abe47c6fc06e44792bc1b0dc58f3b453ae4fb80",
"url": "https://llvm.googlesource.com/llvm-project/+/4abe47c6fc06e44792bc1b0dc58f3b453ae4fb80"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "ea8573aca5bf5a629bfb01113d74b36efd5c2a51"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@ea8573aca5bf5a629bfb01113d74b36efd5c2a51",
"title": "ea8573aca5bf5a629bfb01113d74b36efd5c2a51",
"url": "https://llvm.googlesource.com/llvm-project/+/ea8573aca5bf5a629bfb01113d74b36efd5c2a51"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "1b86867ab3ccf731863043718d53700535e0fb21"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@1b86867ab3ccf731863043718d53700535e0fb21",
"title": "1b86867ab3ccf731863043718d53700535e0fb21",
"url": "https://llvm.googlesource.com/llvm-project/+/1b86867ab3ccf731863043718d53700535e0fb21"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "688df34634a5e3d9423060442a47a01b185ef4e1"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@688df34634a5e3d9423060442a47a01b185ef4e1",
"title": "688df34634a5e3d9423060442a47a01b185ef4e1",
"url": "https://llvm.googlesource.com/llvm-project/+/688df34634a5e3d9423060442a47a01b185ef4e1"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "115a77df9d8475bc62bc22fe52d0d1c62d8111e5"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@115a77df9d8475bc62bc22fe52d0d1c62d8111e5",
"title": "115a77df9d8475bc62bc22fe52d0d1c62d8111e5",
"url": "https://llvm.googlesource.com/llvm-project/+/115a77df9d8475bc62bc22fe52d0d1c62d8111e5"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "277ab85d1ccf80750f5193495c0665808c2863de"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@277ab85d1ccf80750f5193495c0665808c2863de",
"title": "277ab85d1ccf80750f5193495c0665808c2863de",
"url": "https://llvm.googlesource.com/llvm-project/+/277ab85d1ccf80750f5193495c0665808c2863de"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "6b1acdb818dd158619c71546af1bf5e134cd7e03"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@6b1acdb818dd158619c71546af1bf5e134cd7e03",
"title": "6b1acdb818dd158619c71546af1bf5e134cd7e03",
"url": "https://llvm.googlesource.com/llvm-project/+/6b1acdb818dd158619c71546af1bf5e134cd7e03"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "827f2ad64394bdcafabc58133c4b8258f728763c"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@827f2ad64394bdcafabc58133c4b8258f728763c",
"title": "827f2ad64394bdcafabc58133c4b8258f728763c",
"url": "https://llvm.googlesource.com/llvm-project/+/827f2ad64394bdcafabc58133c4b8258f728763c"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "44e3735ac18407f23a4e1fea29192449dbe3d4de"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@44e3735ac18407f23a4e1fea29192449dbe3d4de",
"title": "44e3735ac18407f23a4e1fea29192449dbe3d4de",
"url": "https://llvm.googlesource.com/llvm-project/+/44e3735ac18407f23a4e1fea29192449dbe3d4de"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "133c1afa8e54d4e9599cb0d8aad843c03f0e63b9"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@133c1afa8e54d4e9599cb0d8aad843c03f0e63b9",
"title": "133c1afa8e54d4e9599cb0d8aad843c03f0e63b9",
"url": "https://llvm.googlesource.com/llvm-project/+/133c1afa8e54d4e9599cb0d8aad843c03f0e63b9"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "049f179606a4af3ea650d7049626d267e01b79e2"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@049f179606a4af3ea650d7049626d267e01b79e2",
"title": "049f179606a4af3ea650d7049626d267e01b79e2",
"url": "https://llvm.googlesource.com/llvm-project/+/049f179606a4af3ea650d7049626d267e01b79e2"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "8c7550132f410766598ba88de6b7e7a2a4607f67"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@8c7550132f410766598ba88de6b7e7a2a4607f67",
"title": "8c7550132f410766598ba88de6b7e7a2a4607f67",
"url": "https://llvm.googlesource.com/llvm-project/+/8c7550132f410766598ba88de6b7e7a2a4607f67"
}
]
}
},
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "8c7550132f410766598ba88de6b7e7a2a4607f67",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8884564215748456288"
},
{
"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"
}
}
[17:25:20.747] Scheduled build:
{
"id": "8719134152067951729",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-mac-arm64"
},
"createdBy": "project:fuchsia",
"createTime": "2025-03-28T17:25:20.080202533Z",
"updateTime": "2025-03-28T17:25:20.080202533Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "8c7550132f410766598ba88de6b7e7a2a4607f67",
"ref": "refs/heads/main"
}
}
}
[17:25:20.747] Task URL: https://cr-buildbucket.appspot.com/build/8719134152067951729
[17:25:20.747] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8884564215748456288:2:0) after 1m0s
[17:25:21.515] Received PubSub notification, asking Buildbucket for the build status
[17:25:21.552] Build status: SCHEDULED
[17:25:25.401] Received PubSub notification, asking Buildbucket for the build status
[17:25:25.426] Build status: STARTED
[17:26:20.772] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8884564215748456288:2:0)
[17:26:20.803] Build status: STARTED
[17:26:20.803] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8884564215748456288:5:0) after 9m33s
[17:35:53.838] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8884564215748456288:5:0)
[17:35:53.861] Build status: STARTED
[17:35:53.861] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8884564215748456288:6:0) after 7m29s
[17:43:22.890] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8884564215748456288:6:0)
[17:43:22.963] Build status: STARTED
[17:43:22.963] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8884564215748456288:7:0) after 4m11s
[17:47:33.991] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8884564215748456288:7:0)
[17:47:34.012] Build status: STARTED
[17:47:34.012] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8884564215748456288:8:0) after 6m39s
[17:54:13.019] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8884564215748456288:8:0)
[17:54:13.041] Build status: STARTED
[17:54:13.041] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8884564215748456288:9:0) after 2m4s
[17:56:17.056] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8884564215748456288:9:0)
[17:56:17.089] Build status: STARTED
[17:56:17.089] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8884564215748456288:10:0) after 8m51s
[18:05:08.165] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8884564215748456288:10:0)
[18:05:08.206] Build status: STARTED
[18:05:08.206] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8884564215748456288:11:0) after 6m10s
[18:11:18.227] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8884564215748456288:11:0)
[18:11:18.252] Build status: STARTED
[18:11:18.252] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8884564215748456288:12:0) after 3m58s
[18:15:16.269] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8884564215748456288:12:0)
[18:15:16.302] Build status: STARTED
[18:15:16.302] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8884564215748456288:13:0) after 3m9s
[18:18:25.322] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8884564215748456288:13:0)
[18:18:25.348] Build status: STARTED
[18:18:25.348] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8884564215748456288:14:0) after 7m11s
[18:25:36.375] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8884564215748456288:14:0)
[18:25:36.398] Build status: STARTED
[18:25:36.398] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8884564215748456288:15:0) after 5m49s
[18:31:25.503] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8884564215748456288:15:0)
[18:31:25.676] Build status: STARTED
[18:31:25.676] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8884564215748456288:16:0) after 5m3s
[18:36:28.755] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8884564215748456288:16:0)
[18:36:28.776] Build status: STARTED
[18:36:28.776] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8884564215748456288:17:0) after 7m27s
[18:43:55.829] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8884564215748456288:17:0)
[18:43:55.848] Build status: STARTED
[18:43:55.848] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8884564215748456288:18:0) after 2m27s
[18:46:22.892] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8884564215748456288:18:0)
[18:46:22.909] Build status: STARTED
[18:46:22.909] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8884564215748456288:19:0) after 2m36s
[18:48:59.079] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8884564215748456288:19:0)
[18:48:59.104] Build status: STARTED
[18:48:59.104] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8884564215748456288:20:0) after 8m35s
[18:57:34.113] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8884564215748456288:20:0)
[18:57:34.130] Build status: STARTED
[18:57:34.130] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8884564215748456288:21:0) after 8m9s
[19:05:43.257] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8884564215748456288:21:0)
[19:05:43.287] Build status: STARTED
[19:05:43.287] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8884564215748456288:22:0) after 2m7s
[19:07:50.308] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8884564215748456288:22:0)
[19:07:50.323] Build status: STARTED
[19:07:50.323] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8884564215748456288:23:0) after 9m14s
[19:13:31.514] Received PubSub notification, asking Buildbucket for the build status
[19:13:31.532] Build:
{
"id": "8719134152067951729",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-mac-arm64"
},
"createdBy": "project:fuchsia",
"createTime": "2025-03-28T17:25:20.080202533Z",
"startTime": "2025-03-28T17:25:25.202767359Z",
"endTime": "2025-03-28T19:13:31.101011651Z",
"updateTime": "2025-03-28T19:13:31.101011651Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "8c7550132f410766598ba88de6b7e7a2a4607f67",
"ref": "refs/heads/main"
}
}
}
[19:13:31.532] Invocation finished in 1h48m14.346041333s with status SUCCEEDED