[17:18:08.163] New invocation is queued and will start shortly
[17:18:09.231] Starting the invocation (attempt 1)
[17:18:09.263] Popped buildset tag "buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/32feb01dc3c9cd78f7de1ed15722480be92fef49"
[17:18:09.263] Popped gitiles commit info from properties and tags
[17:18:09.263] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[17:18:09.263] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[17:18:09.264] Buildbucket request:
{
"requestId": "8860647066497090176",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-mac-x64"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8860647066497090176",
"job": "fuchsia/toolchain.ci-clang-mac-x64-40be1bb5",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "2fc0d8cb9a659e2d9f22c50239f0721c26e5d78b"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@2fc0d8cb9a659e2d9f22c50239f0721c26e5d78b",
"title": "2fc0d8cb9a659e2d9f22c50239f0721c26e5d78b",
"url": "https://llvm.googlesource.com/llvm-project/+/2fc0d8cb9a659e2d9f22c50239f0721c26e5d78b"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "77455615a4be9dc8be0486d15c0528704437b509"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@77455615a4be9dc8be0486d15c0528704437b509",
"title": "77455615a4be9dc8be0486d15c0528704437b509",
"url": "https://llvm.googlesource.com/llvm-project/+/77455615a4be9dc8be0486d15c0528704437b509"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "a3b79893da47275dc374b0139645c7ebe7c2e2d2"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@a3b79893da47275dc374b0139645c7ebe7c2e2d2",
"title": "a3b79893da47275dc374b0139645c7ebe7c2e2d2",
"url": "https://llvm.googlesource.com/llvm-project/+/a3b79893da47275dc374b0139645c7ebe7c2e2d2"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "5c371b14b0ae77cdc28188e07d7b72a55b610e84"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@5c371b14b0ae77cdc28188e07d7b72a55b610e84",
"title": "5c371b14b0ae77cdc28188e07d7b72a55b610e84",
"url": "https://llvm.googlesource.com/llvm-project/+/5c371b14b0ae77cdc28188e07d7b72a55b610e84"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "97cf9ea3b93b417825e7c6672242f7c8d06f5054"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@97cf9ea3b93b417825e7c6672242f7c8d06f5054",
"title": "97cf9ea3b93b417825e7c6672242f7c8d06f5054",
"url": "https://llvm.googlesource.com/llvm-project/+/97cf9ea3b93b417825e7c6672242f7c8d06f5054"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "550ccd22f4df30c585c7ca4e838e0507415170a5"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@550ccd22f4df30c585c7ca4e838e0507415170a5",
"title": "550ccd22f4df30c585c7ca4e838e0507415170a5",
"url": "https://llvm.googlesource.com/llvm-project/+/550ccd22f4df30c585c7ca4e838e0507415170a5"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "b8ee6ed79449f33a980d3d2a98e203ab58ad4cc2"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@b8ee6ed79449f33a980d3d2a98e203ab58ad4cc2",
"title": "b8ee6ed79449f33a980d3d2a98e203ab58ad4cc2",
"url": "https://llvm.googlesource.com/llvm-project/+/b8ee6ed79449f33a980d3d2a98e203ab58ad4cc2"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "4947f68970bbc1140e4ec718903d56e7c0d5c13f"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@4947f68970bbc1140e4ec718903d56e7c0d5c13f",
"title": "4947f68970bbc1140e4ec718903d56e7c0d5c13f",
"url": "https://llvm.googlesource.com/llvm-project/+/4947f68970bbc1140e4ec718903d56e7c0d5c13f"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "fa78d6a5f15efaaaa58b2789a3cc9833379167ac"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@fa78d6a5f15efaaaa58b2789a3cc9833379167ac",
"title": "fa78d6a5f15efaaaa58b2789a3cc9833379167ac",
"url": "https://llvm.googlesource.com/llvm-project/+/fa78d6a5f15efaaaa58b2789a3cc9833379167ac"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "d4e732314869f3b96e5802aace08805f3c19697e"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@d4e732314869f3b96e5802aace08805f3c19697e",
"title": "d4e732314869f3b96e5802aace08805f3c19697e",
"url": "https://llvm.googlesource.com/llvm-project/+/d4e732314869f3b96e5802aace08805f3c19697e"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "1f2818cea3f675d4ae85f2fc680c7f4f9ff9a111"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@1f2818cea3f675d4ae85f2fc680c7f4f9ff9a111",
"title": "1f2818cea3f675d4ae85f2fc680c7f4f9ff9a111",
"url": "https://llvm.googlesource.com/llvm-project/+/1f2818cea3f675d4ae85f2fc680c7f4f9ff9a111"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "fbe5e8c9f482df2f527b8f81f22c61a4c487c2ca"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@fbe5e8c9f482df2f527b8f81f22c61a4c487c2ca",
"title": "fbe5e8c9f482df2f527b8f81f22c61a4c487c2ca",
"url": "https://llvm.googlesource.com/llvm-project/+/fbe5e8c9f482df2f527b8f81f22c61a4c487c2ca"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "32feb01dc3c9cd78f7de1ed15722480be92fef49"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@32feb01dc3c9cd78f7de1ed15722480be92fef49",
"title": "32feb01dc3c9cd78f7de1ed15722480be92fef49",
"url": "https://llvm.googlesource.com/llvm-project/+/32feb01dc3c9cd78f7de1ed15722480be92fef49"
}
]
}
},
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "32feb01dc3c9cd78f7de1ed15722480be92fef49",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8860647066497090176"
},
{
"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"
}
}
[17:18:09.687] Scheduled build:
{
"id": "8695217004615717009",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-mac-x64"
},
"createdBy": "project:fuchsia",
"createTime": "2025-12-17T17:18:09.327982088Z",
"updateTime": "2025-12-17T17:18:09.327982088Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "32feb01dc3c9cd78f7de1ed15722480be92fef49",
"ref": "refs/heads/main"
}
}
}
[17:18:09.687] Task URL: https://cr-buildbucket.appspot.com/build/8695217004615717009
[17:18:09.687] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8860647066497090176:2:0) after 5m1s
[17:18:10.683] Received PubSub notification, asking Buildbucket for the build status
[17:18:10.696] Build status: SCHEDULED
[17:19:03.463] Received PubSub notification, asking Buildbucket for the build status
[17:19:03.487] Build status: STARTED
[17:23:10.689] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8860647066497090176:2:0)
[17:23:10.711] Build status: STARTED
[17:23:10.711] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8860647066497090176:5:0) after 7m10s
[17:30:20.728] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8860647066497090176:5:0)
[17:30:20.775] Build status: STARTED
[17:30:20.775] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8860647066497090176:6:0) after 6m40s
[17:37:00.843] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8860647066497090176:6:0)
[17:37:00.867] Build status: STARTED
[17:37:00.867] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8860647066497090176:7:0) after 9m53s
[17:46:53.899] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8860647066497090176:7:0)
[17:46:53.917] Build status: STARTED
[17:46:53.918] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8860647066497090176:8:0) after 9m53s
[17:56:46.955] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8860647066497090176:8:0)
[17:56:46.972] Build status: STARTED
[17:56:46.972] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8860647066497090176:9:0) after 4m24s
[18:01:11.012] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8860647066497090176:9:0)
[18:01:11.027] Build status: STARTED
[18:01:11.027] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8860647066497090176:10:0) after 4m56s
[18:06:07.040] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8860647066497090176:10:0)
[18:06:07.058] Build status: STARTED
[18:06:07.058] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8860647066497090176:11:0) after 4m50s
[18:10:57.073] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8860647066497090176:11:0)
[18:10:57.099] Build status: STARTED
[18:10:57.099] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8860647066497090176:12:0) after 9m8s
[18:20:05.189] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8860647066497090176:12:0)
[18:20:05.205] Build status: STARTED
[18:20:05.205] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8860647066497090176:13:0) after 5m21s
[18:25:26.262] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8860647066497090176:13:0)
[18:25:26.282] Build status: STARTED
[18:25:26.282] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8860647066497090176:14:0) after 7m32s
[18:32:58.349] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8860647066497090176:14:0)
[18:32:58.407] Build status: STARTED
[18:32:58.407] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8860647066497090176:15:0) after 7m7s
[18:40:05.424] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8860647066497090176:15:0)
[18:40:05.439] Build status: STARTED
[18:40:05.439] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8860647066497090176:16:0) after 6m43s
[18:46:48.484] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8860647066497090176:16:0)
[18:46:48.501] Build status: STARTED
[18:46:48.501] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8860647066497090176:17:0) after 4m19s
[18:51:07.553] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8860647066497090176:17:0)
[18:51:07.593] Build status: STARTED
[18:51:07.604] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8860647066497090176:18:0) after 1m36s
[18:52:43.615] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8860647066497090176:18:0)
[18:52:43.631] Build status: STARTED
[18:52:43.631] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8860647066497090176:19:0) after 5m48s
[18:58:31.699] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8860647066497090176:19:0)
[18:58:31.714] Build status: STARTED
[18:58:31.714] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8860647066497090176:20:0) after 4m36s
[19:03:07.745] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8860647066497090176:20:0)
[19:03:07.767] Build status: STARTED
[19:03:07.767] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8860647066497090176:21:0) after 1m55s
[19:05:02.822] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8860647066497090176:21:0)
[19:05:02.843] Build status: STARTED
[19:05:02.843] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8860647066497090176:22:0) after 1m41s
[19:06:43.897] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8860647066497090176:22:0)
[19:06:43.921] Build status: STARTED
[19:06:43.921] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8860647066497090176:23:0) after 7m47s
[19:14:30.943] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8860647066497090176:23:0)
[19:14:31.017] Build status: STARTED
[19:14:31.017] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8860647066497090176:24:0) after 4m13s
[19:17:08.735] Received PubSub notification, asking Buildbucket for the build status
[19:17:08.750] Build:
{
"id": "8695217004615717009",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-mac-x64"
},
"createdBy": "project:fuchsia",
"createTime": "2025-12-17T17:18:09.327982088Z",
"startTime": "2025-12-17T17:19:03.258129844Z",
"endTime": "2025-12-17T19:17:08.273987341Z",
"updateTime": "2025-12-17T19:17:08.273987341Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "32feb01dc3c9cd78f7de1ed15722480be92fef49",
"ref": "refs/heads/main"
}
}
}
[19:17:08.750] Invocation finished in 1h59m0.601536166s with status SUCCEEDED