[16:57:22.732] New invocation is queued and will start shortly
[16:57:25.219] Starting the invocation (attempt 1)
[16:57:25.250] Popped buildset tag "buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/3a573dcdc88d4571496dc26e514c5708e1e2c786"
[16:57:25.250] Popped gitiles commit info from properties and tags
[16:57:25.250] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[16:57:25.250] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[16:57:25.250] Buildbucket request:
{
"requestId": "8894350443917828800",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-mac-x64"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8894350443917828800",
"job": "fuchsia/toolchain.ci-clang-mac-x64-40be1bb5",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "3654f1baa66f524c89e40ab24e18e594e56363e9"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@3654f1baa66f524c89e40ab24e18e594e56363e9",
"title": "3654f1baa66f524c89e40ab24e18e594e56363e9",
"url": "https://llvm.googlesource.com/llvm-project/+/3654f1baa66f524c89e40ab24e18e594e56363e9"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "f28e52274c83d5ccd03455ef98a3758916998be9"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@f28e52274c83d5ccd03455ef98a3758916998be9",
"title": "f28e52274c83d5ccd03455ef98a3758916998be9",
"url": "https://llvm.googlesource.com/llvm-project/+/f28e52274c83d5ccd03455ef98a3758916998be9"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "f31099ce581d33fdb64e35fee4b56d0a1145cab1"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@f31099ce581d33fdb64e35fee4b56d0a1145cab1",
"title": "f31099ce581d33fdb64e35fee4b56d0a1145cab1",
"url": "https://llvm.googlesource.com/llvm-project/+/f31099ce581d33fdb64e35fee4b56d0a1145cab1"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "4d06623b28ab373cd5438fda6c79cf62fc53ace0"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@4d06623b28ab373cd5438fda6c79cf62fc53ace0",
"title": "4d06623b28ab373cd5438fda6c79cf62fc53ace0",
"url": "https://llvm.googlesource.com/llvm-project/+/4d06623b28ab373cd5438fda6c79cf62fc53ace0"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "ed91843d435d0cd2c39ebb1a50f2907c621f07ed"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@ed91843d435d0cd2c39ebb1a50f2907c621f07ed",
"title": "ed91843d435d0cd2c39ebb1a50f2907c621f07ed",
"url": "https://llvm.googlesource.com/llvm-project/+/ed91843d435d0cd2c39ebb1a50f2907c621f07ed"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "4f933277a53d61f7df42e70ec8ec465652019f7f"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@4f933277a53d61f7df42e70ec8ec465652019f7f",
"title": "4f933277a53d61f7df42e70ec8ec465652019f7f",
"url": "https://llvm.googlesource.com/llvm-project/+/4f933277a53d61f7df42e70ec8ec465652019f7f"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "444e53f675ff490a3023d48e1b809486513e3fd3"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@444e53f675ff490a3023d48e1b809486513e3fd3",
"title": "444e53f675ff490a3023d48e1b809486513e3fd3",
"url": "https://llvm.googlesource.com/llvm-project/+/444e53f675ff490a3023d48e1b809486513e3fd3"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "5a0d73b1da880e475e8187e8962b574174bdd0a9"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@5a0d73b1da880e475e8187e8962b574174bdd0a9",
"title": "5a0d73b1da880e475e8187e8962b574174bdd0a9",
"url": "https://llvm.googlesource.com/llvm-project/+/5a0d73b1da880e475e8187e8962b574174bdd0a9"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "708a478d6739aea20a8834cea45490f05b07ca10"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@708a478d6739aea20a8834cea45490f05b07ca10",
"title": "708a478d6739aea20a8834cea45490f05b07ca10",
"url": "https://llvm.googlesource.com/llvm-project/+/708a478d6739aea20a8834cea45490f05b07ca10"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "74486dcf418648023318a5ad03dd48ba5dc11381"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@74486dcf418648023318a5ad03dd48ba5dc11381",
"title": "74486dcf418648023318a5ad03dd48ba5dc11381",
"url": "https://llvm.googlesource.com/llvm-project/+/74486dcf418648023318a5ad03dd48ba5dc11381"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "3a573dcdc88d4571496dc26e514c5708e1e2c786"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@3a573dcdc88d4571496dc26e514c5708e1e2c786",
"title": "3a573dcdc88d4571496dc26e514c5708e1e2c786",
"url": "https://llvm.googlesource.com/llvm-project/+/3a573dcdc88d4571496dc26e514c5708e1e2c786"
}
]
}
},
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "3a573dcdc88d4571496dc26e514c5708e1e2c786",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8894350443917828800"
},
{
"key": "scheduler_job_id",
"value": "fuchsia/toolchain.ci-clang-mac-x64-40be1bb5"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[16:57:25.677] Scheduled build:
{
"id": "8728920380550282161",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-mac-x64"
},
"createdBy": "project:fuchsia",
"createTime": "2024-12-10T16:57:25.322019453Z",
"updateTime": "2024-12-10T16:57:25.322019453Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "3a573dcdc88d4571496dc26e514c5708e1e2c786",
"ref": "refs/heads/main"
}
}
}
[16:57:25.677] Task URL: https://cr-buildbucket.appspot.com/build/8728920380550282161
[16:57:25.677] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8894350443917828800:2:0) after 2m19s
[16:57:26.045] Received PubSub notification, asking Buildbucket for the build status
[16:57:26.079] Build status: SCHEDULED
[16:59:44.667] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8894350443917828800:2:0)
[16:59:44.699] Build status: SCHEDULED
[16:59:44.699] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8894350443917828800:4:0) after 2m43s
[17:02:27.754] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8894350443917828800:4:0)
[17:02:27.779] Build status: SCHEDULED
[17:02:27.779] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8894350443917828800:5:0) after 9m30s
[17:11:57.880] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8894350443917828800:5:0)
[17:11:57.912] Build status: SCHEDULED
[17:11:57.912] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8894350443917828800:6:0) after 2m47s
[17:14:44.893] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8894350443917828800:6:0)
[17:14:44.974] Build status: SCHEDULED
[17:14:44.974] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8894350443917828800:7:0) after 8m56s
[17:17:17.360] Received PubSub notification, asking Buildbucket for the build status
[17:17:17.395] Build status: STARTED
[17:23:40.991] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8894350443917828800:7:0)
[17:23:41.010] Build status: STARTED
[17:23:41.010] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8894350443917828800:9:0) after 6m11s
[17:29:52.025] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8894350443917828800:9:0)
[17:29:52.042] Build status: STARTED
[17:29:52.042] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8894350443917828800:10:0) after 2m51s
[17:32:43.059] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8894350443917828800:10:0)
[17:32:43.088] Build status: STARTED
[17:32:43.088] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8894350443917828800:11:0) after 1m14s
[17:33:57.165] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8894350443917828800:11:0)
[17:33:57.211] Build status: STARTED
[17:33:57.212] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8894350443917828800:12:0) after 5m16s
[17:39:13.334] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8894350443917828800:12:0)
[17:39:13.409] Build status: STARTED
[17:39:13.409] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8894350443917828800:13:0) after 6m18s
[17:45:31.494] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8894350443917828800:13:0)
[17:45:31.524] Build status: STARTED
[17:45:31.524] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8894350443917828800:14:0) after 8m43s
[17:54:14.571] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8894350443917828800:14:0)
[17:54:14.620] Build status: STARTED
[17:54:14.620] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8894350443917828800:15:0) after 2m43s
[17:56:57.665] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8894350443917828800:15:0)
[17:56:57.690] Build status: STARTED
[17:56:57.690] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8894350443917828800:16:0) after 5m17s
[18:02:14.993] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8894350443917828800:16:0)
[18:02:15.020] Build status: STARTED
[18:02:15.021] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8894350443917828800:17:0) after 7m22s
[18:09:37.073] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8894350443917828800:17:0)
[18:09:37.089] Build status: STARTED
[18:09:37.089] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8894350443917828800:18:0) after 4m29s
[18:14:06.157] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8894350443917828800:18:0)
[18:14:06.360] Build status: STARTED
[18:14:06.360] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8894350443917828800:19:0) after 4m55s
[18:19:01.426] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8894350443917828800:19:0)
[18:19:01.448] Build status: STARTED
[18:19:01.448] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8894350443917828800:20:0) after 8m58s
[18:27:59.492] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8894350443917828800:20:0)
[18:27:59.509] Build status: STARTED
[18:27:59.509] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8894350443917828800:21:0) after 3m25s
[18:31:24.528] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8894350443917828800:21:0)
[18:31:24.671] Build status: STARTED
[18:31:24.671] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8894350443917828800:22:0) after 6m44s
[18:38:08.751] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8894350443917828800:22:0)
[18:38:08.771] Build status: STARTED
[18:38:08.771] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8894350443917828800:23:0) after 6m21s
[18:38:57.025] Received PubSub notification, asking Buildbucket for the build status
[18:38:57.050] Build:
{
"id": "8728920380550282161",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-mac-x64"
},
"createdBy": "project:fuchsia",
"createTime": "2024-12-10T16:57:25.322019453Z",
"startTime": "2024-12-10T17:17:17.046622890Z",
"endTime": "2024-12-10T18:38:56.484663766Z",
"updateTime": "2024-12-10T18:38:56.484663766Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "3a573dcdc88d4571496dc26e514c5708e1e2c786",
"ref": "refs/heads/main"
}
}
}
[18:38:57.050] Invocation finished in 1h41m34.32290128s with status SUCCEEDED