[16:22:58.105] New invocation is queued and will start shortly
[16:22:59.435] Starting the invocation (attempt 1)
[16:22:59.469] Popped buildset tag "buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/70627af91f577f5195a11ee44c6af39503e1ce52"
[16:22:59.469] Popped gitiles commit info from properties and tags
[16:22:59.469] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[16:22:59.469] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[16:22:59.470] Buildbucket request:
{
"requestId": "8883299778934210432",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-mac-x64"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8883299778934210432",
"job": "fuchsia/toolchain.ci-clang-mac-x64-40be1bb5",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "d6c1ef576f0a44486a8a0f7f33123ad7c9f8c5e9"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@d6c1ef576f0a44486a8a0f7f33123ad7c9f8c5e9",
"title": "d6c1ef576f0a44486a8a0f7f33123ad7c9f8c5e9",
"url": "https://llvm.googlesource.com/llvm-project/+/d6c1ef576f0a44486a8a0f7f33123ad7c9f8c5e9"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "7113aece4eaa634cdcea5c4057da171c17229b40"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@7113aece4eaa634cdcea5c4057da171c17229b40",
"title": "7113aece4eaa634cdcea5c4057da171c17229b40",
"url": "https://llvm.googlesource.com/llvm-project/+/7113aece4eaa634cdcea5c4057da171c17229b40"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "6b78bbc56b835e69ecc5eb8f978c27592e4c4051"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@6b78bbc56b835e69ecc5eb8f978c27592e4c4051",
"title": "6b78bbc56b835e69ecc5eb8f978c27592e4c4051",
"url": "https://llvm.googlesource.com/llvm-project/+/6b78bbc56b835e69ecc5eb8f978c27592e4c4051"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "12fe15ff9d72697848496894401af3eeb7b6c3b8"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@12fe15ff9d72697848496894401af3eeb7b6c3b8",
"title": "12fe15ff9d72697848496894401af3eeb7b6c3b8",
"url": "https://llvm.googlesource.com/llvm-project/+/12fe15ff9d72697848496894401af3eeb7b6c3b8"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "58211f55c5d42394b3de3310a825d707e7622833"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@58211f55c5d42394b3de3310a825d707e7622833",
"title": "58211f55c5d42394b3de3310a825d707e7622833",
"url": "https://llvm.googlesource.com/llvm-project/+/58211f55c5d42394b3de3310a825d707e7622833"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "07b439605a4cc838a9157f6a948edb0369adeada"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@07b439605a4cc838a9157f6a948edb0369adeada",
"title": "07b439605a4cc838a9157f6a948edb0369adeada",
"url": "https://llvm.googlesource.com/llvm-project/+/07b439605a4cc838a9157f6a948edb0369adeada"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "d1ea4799d9a3e2757772a47e9dce5f2e24bb982f"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@d1ea4799d9a3e2757772a47e9dce5f2e24bb982f",
"title": "d1ea4799d9a3e2757772a47e9dce5f2e24bb982f",
"url": "https://llvm.googlesource.com/llvm-project/+/d1ea4799d9a3e2757772a47e9dce5f2e24bb982f"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "c3795ba7373d9a4878974cd664eb6d000bc91880"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@c3795ba7373d9a4878974cd664eb6d000bc91880",
"title": "c3795ba7373d9a4878974cd664eb6d000bc91880",
"url": "https://llvm.googlesource.com/llvm-project/+/c3795ba7373d9a4878974cd664eb6d000bc91880"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "61f95c6429df523dc3f04e85a5d500008c76e1fa"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@61f95c6429df523dc3f04e85a5d500008c76e1fa",
"title": "61f95c6429df523dc3f04e85a5d500008c76e1fa",
"url": "https://llvm.googlesource.com/llvm-project/+/61f95c6429df523dc3f04e85a5d500008c76e1fa"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "88e15b781506949c56936b8642774125772fdeb2"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@88e15b781506949c56936b8642774125772fdeb2",
"title": "88e15b781506949c56936b8642774125772fdeb2",
"url": "https://llvm.googlesource.com/llvm-project/+/88e15b781506949c56936b8642774125772fdeb2"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "3ad2cd5e70d0fb1d7831a735a4ec8c8b18578d75"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@3ad2cd5e70d0fb1d7831a735a4ec8c8b18578d75",
"title": "3ad2cd5e70d0fb1d7831a735a4ec8c8b18578d75",
"url": "https://llvm.googlesource.com/llvm-project/+/3ad2cd5e70d0fb1d7831a735a4ec8c8b18578d75"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "76b85d3a27d9de4667cdf6de158111830724f34d"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@76b85d3a27d9de4667cdf6de158111830724f34d",
"title": "76b85d3a27d9de4667cdf6de158111830724f34d",
"url": "https://llvm.googlesource.com/llvm-project/+/76b85d3a27d9de4667cdf6de158111830724f34d"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "5a41fc28f3b3f32a70fd5d81c2e33d10b3225806"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@5a41fc28f3b3f32a70fd5d81c2e33d10b3225806",
"title": "5a41fc28f3b3f32a70fd5d81c2e33d10b3225806",
"url": "https://llvm.googlesource.com/llvm-project/+/5a41fc28f3b3f32a70fd5d81c2e33d10b3225806"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "976c37ec950a93ed60068389ad05454f76da1e55"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@976c37ec950a93ed60068389ad05454f76da1e55",
"title": "976c37ec950a93ed60068389ad05454f76da1e55",
"url": "https://llvm.googlesource.com/llvm-project/+/976c37ec950a93ed60068389ad05454f76da1e55"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "a4b7688d27da1a0189fff6549853fdfe22b33c48"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@a4b7688d27da1a0189fff6549853fdfe22b33c48",
"title": "a4b7688d27da1a0189fff6549853fdfe22b33c48",
"url": "https://llvm.googlesource.com/llvm-project/+/a4b7688d27da1a0189fff6549853fdfe22b33c48"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "ffac1404f8e0f606cac12a21777dfe700b455e87"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@ffac1404f8e0f606cac12a21777dfe700b455e87",
"title": "ffac1404f8e0f606cac12a21777dfe700b455e87",
"url": "https://llvm.googlesource.com/llvm-project/+/ffac1404f8e0f606cac12a21777dfe700b455e87"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "438f984b4b3c6774f07eced877dce7cdbeef6a3b"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@438f984b4b3c6774f07eced877dce7cdbeef6a3b",
"title": "438f984b4b3c6774f07eced877dce7cdbeef6a3b",
"url": "https://llvm.googlesource.com/llvm-project/+/438f984b4b3c6774f07eced877dce7cdbeef6a3b"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "70627af91f577f5195a11ee44c6af39503e1ce52"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@70627af91f577f5195a11ee44c6af39503e1ce52",
"title": "70627af91f577f5195a11ee44c6af39503e1ce52",
"url": "https://llvm.googlesource.com/llvm-project/+/70627af91f577f5195a11ee44c6af39503e1ce52"
}
]
}
},
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "70627af91f577f5195a11ee44c6af39503e1ce52",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8883299778934210432"
},
{
"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:22:59.924] Scheduled build:
{
"id": "8717869716742358753",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-mac-x64"
},
"createdBy": "project:fuchsia",
"createTime": "2025-04-11T16:22:59.574731531Z",
"updateTime": "2025-04-11T16:22:59.574731531Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "70627af91f577f5195a11ee44c6af39503e1ce52",
"ref": "refs/heads/main"
}
}
}
[16:22:59.924] Task URL: https://cr-buildbucket.appspot.com/build/8717869716742358753
[16:22:59.924] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8883299778934210432:2:0) after 3m1s
[16:23:01.348] Received PubSub notification, asking Buildbucket for the build status
[16:23:01.369] Build status: SCHEDULED
[16:26:00.938] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8883299778934210432:2:0)
[16:26:00.958] Build status: SCHEDULED
[16:26:00.958] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8883299778934210432:4:0) after 2m43s
[16:28:43.981] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8883299778934210432:4:0)
[16:28:44.008] Build status: SCHEDULED
[16:28:44.008] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8883299778934210432:5:0) after 7m49s
[16:36:33.041] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8883299778934210432:5:0)
[16:36:33.082] Build status: SCHEDULED
[16:36:33.082] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8883299778934210432:6:0) after 5m49s
[16:42:22.160] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8883299778934210432:6:0)
[16:42:22.183] Build status: SCHEDULED
[16:42:22.183] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8883299778934210432:7:0) after 1m44s
[16:44:06.213] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8883299778934210432:7:0)
[16:44:06.235] Build status: SCHEDULED
[16:44:06.235] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8883299778934210432:8:0) after 7m6s
[16:51:05.805] Received PubSub notification, asking Buildbucket for the build status
[16:51:05.831] Build status: STARTED
[16:51:12.349] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8883299778934210432:8:0)
[16:51:12.367] Build status: STARTED
[16:51:12.367] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8883299778934210432:10:0) after 4m25s
[16:55:37.384] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8883299778934210432:10:0)
[16:55:37.400] Build status: STARTED
[16:55:37.400] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8883299778934210432:11:0) after 5m56s
[17:01:33.424] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8883299778934210432:11:0)
[17:01:33.451] Build status: STARTED
[17:01:33.451] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8883299778934210432:12:0) after 7m22s
[17:08:55.477] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8883299778934210432:12:0)
[17:08:55.527] Build status: STARTED
[17:08:55.527] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8883299778934210432:13:0) after 7m7s
[17:16:02.559] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8883299778934210432:13:0)
[17:16:02.585] Build status: STARTED
[17:16:02.586] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8883299778934210432:14:0) after 3m4s
[17:19:06.607] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8883299778934210432:14:0)
[17:19:06.627] Build status: STARTED
[17:19:06.627] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8883299778934210432:15:0) after 4m3s
[17:23:09.700] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8883299778934210432:15:0)
[17:23:09.718] Build status: STARTED
[17:23:09.718] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8883299778934210432:16:0) after 9m25s
[17:32:34.734] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8883299778934210432:16:0)
[17:32:34.753] Build status: STARTED
[17:32:34.753] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8883299778934210432:17:0) after 4m29s
[17:37:03.781] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8883299778934210432:17:0)
[17:37:03.813] Build status: STARTED
[17:37:03.813] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8883299778934210432:18:0) after 7m28s
[17:44:31.887] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8883299778934210432:18:0)
[17:44:31.912] Build status: STARTED
[17:44:31.912] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8883299778934210432:19:0) after 7m54s
[17:52:25.931] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8883299778934210432:19:0)
[17:52:25.961] Build status: STARTED
[17:52:25.961] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8883299778934210432:20:0) after 1m1s
[17:53:26.998] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8883299778934210432:20:0)
[17:53:27.020] Build status: STARTED
[17:53:27.020] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8883299778934210432:21:0) after 3m20s
[17:56:47.232] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8883299778934210432:21:0)
[17:56:47.253] Build status: STARTED
[17:56:47.253] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8883299778934210432:22:0) after 2m25s
[17:59:12.277] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8883299778934210432:22:0)
[17:59:12.295] Build status: STARTED
[17:59:12.295] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8883299778934210432:23:0) after 4m18s
[18:03:30.373] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8883299778934210432:23:0)
[18:03:30.392] Build status: STARTED
[18:03:30.392] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8883299778934210432:24:0) after 4m35s
[18:08:05.445] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8883299778934210432:24:0)
[18:08:05.469] Build status: STARTED
[18:08:05.469] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8883299778934210432:25:0) after 3m45s
[18:11:50.489] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8883299778934210432:25:0)
[18:11:50.512] Build status: STARTED
[18:11:50.512] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8883299778934210432:26:0) after 6m8s
[18:17:58.536] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8883299778934210432:26:0)
[18:17:58.554] Build status: STARTED
[18:17:58.554] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8883299778934210432:27:0) after 1m59s
[18:19:57.539] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8883299778934210432:27:0)
[18:19:57.563] Build status: STARTED
[18:19:57.563] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8883299778934210432:28:0) after 6m51s
[18:26:48.590] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8883299778934210432:28:0)
[18:26:48.607] Build status: STARTED
[18:26:48.607] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8883299778934210432:29:0) after 1m35s
[18:28:23.683] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8883299778934210432:29:0)
[18:28:23.703] Build status: STARTED
[18:28:23.703] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8883299778934210432:30:0) after 8m8s
[18:32:29.378] Received PubSub notification, asking Buildbucket for the build status
[18:32:29.399] Build:
{
"id": "8717869716742358753",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-mac-x64"
},
"createdBy": "project:fuchsia",
"createTime": "2025-04-11T16:22:59.574731531Z",
"startTime": "2025-04-11T16:51:05.603931622Z",
"endTime": "2025-04-11T18:32:29.031075845Z",
"updateTime": "2025-04-11T18:32:29.031075845Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "70627af91f577f5195a11ee44c6af39503e1ce52",
"ref": "refs/heads/main"
}
}
}
[18:32:29.399] Invocation finished in 2h9m31.297804179s with status SUCCEEDED