[10:36:04.055] New invocation is queued and will start shortly
[10:36:05.137] Starting the invocation (attempt 1)
[10:36:05.231] Popped buildset tag "buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/d6f159dd05a2b237fb1e36d1614aa438d5ca1130"
[10:36:05.231] Popped gitiles commit info from properties and tags
[10:36:05.231] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[10:36:05.231] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[10:36:05.232] Buildbucket request:
{
"requestId": "8860581765487966240",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-mac-x64"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8860581765487966240",
"job": "fuchsia/toolchain.ci-clang-mac-x64-40be1bb5",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "f8ab74f25e6c021d06f31c3791294d8b46bba888"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@f8ab74f25e6c021d06f31c3791294d8b46bba888",
"title": "f8ab74f25e6c021d06f31c3791294d8b46bba888",
"url": "https://llvm.googlesource.com/llvm-project/+/f8ab74f25e6c021d06f31c3791294d8b46bba888"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "e655317cf134887b369c43598ac1c0605865c1b7"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@e655317cf134887b369c43598ac1c0605865c1b7",
"title": "e655317cf134887b369c43598ac1c0605865c1b7",
"url": "https://llvm.googlesource.com/llvm-project/+/e655317cf134887b369c43598ac1c0605865c1b7"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "98b82f90dfb7865ae4dbfcb5a83a9e817e7894a1"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@98b82f90dfb7865ae4dbfcb5a83a9e817e7894a1",
"title": "98b82f90dfb7865ae4dbfcb5a83a9e817e7894a1",
"url": "https://llvm.googlesource.com/llvm-project/+/98b82f90dfb7865ae4dbfcb5a83a9e817e7894a1"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "2093d2eea1d2efa529f5ea90560dbd511efaa089"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@2093d2eea1d2efa529f5ea90560dbd511efaa089",
"title": "2093d2eea1d2efa529f5ea90560dbd511efaa089",
"url": "https://llvm.googlesource.com/llvm-project/+/2093d2eea1d2efa529f5ea90560dbd511efaa089"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "726452720ccf9ba163ebd8d48f660ae6a34a2963"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@726452720ccf9ba163ebd8d48f660ae6a34a2963",
"title": "726452720ccf9ba163ebd8d48f660ae6a34a2963",
"url": "https://llvm.googlesource.com/llvm-project/+/726452720ccf9ba163ebd8d48f660ae6a34a2963"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "ad761003103fa58ddb283c160d21266bf61c0d6d"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@ad761003103fa58ddb283c160d21266bf61c0d6d",
"title": "ad761003103fa58ddb283c160d21266bf61c0d6d",
"url": "https://llvm.googlesource.com/llvm-project/+/ad761003103fa58ddb283c160d21266bf61c0d6d"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "c501a71e8a66ebd7c5531279a9da2ddfa88560c2"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@c501a71e8a66ebd7c5531279a9da2ddfa88560c2",
"title": "c501a71e8a66ebd7c5531279a9da2ddfa88560c2",
"url": "https://llvm.googlesource.com/llvm-project/+/c501a71e8a66ebd7c5531279a9da2ddfa88560c2"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "c8bf963282979d3bdec103ffa2ccf0cac05ec335"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@c8bf963282979d3bdec103ffa2ccf0cac05ec335",
"title": "c8bf963282979d3bdec103ffa2ccf0cac05ec335",
"url": "https://llvm.googlesource.com/llvm-project/+/c8bf963282979d3bdec103ffa2ccf0cac05ec335"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "64e3de71b0f2f531fc72d6202eec3e59eaf23a99"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@64e3de71b0f2f531fc72d6202eec3e59eaf23a99",
"title": "64e3de71b0f2f531fc72d6202eec3e59eaf23a99",
"url": "https://llvm.googlesource.com/llvm-project/+/64e3de71b0f2f531fc72d6202eec3e59eaf23a99"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "b036d70eeef7b65d889fc9438328e75b7646217e"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@b036d70eeef7b65d889fc9438328e75b7646217e",
"title": "b036d70eeef7b65d889fc9438328e75b7646217e",
"url": "https://llvm.googlesource.com/llvm-project/+/b036d70eeef7b65d889fc9438328e75b7646217e"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "1c06165c9b203a9543bc6c368e680d38158b44a0"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@1c06165c9b203a9543bc6c368e680d38158b44a0",
"title": "1c06165c9b203a9543bc6c368e680d38158b44a0",
"url": "https://llvm.googlesource.com/llvm-project/+/1c06165c9b203a9543bc6c368e680d38158b44a0"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "e957c81750017d1ab505de8239ef993250867704"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@e957c81750017d1ab505de8239ef993250867704",
"title": "e957c81750017d1ab505de8239ef993250867704",
"url": "https://llvm.googlesource.com/llvm-project/+/e957c81750017d1ab505de8239ef993250867704"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "8cfda791054bf9a7cdb43369e36caae2a56032c6"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@8cfda791054bf9a7cdb43369e36caae2a56032c6",
"title": "8cfda791054bf9a7cdb43369e36caae2a56032c6",
"url": "https://llvm.googlesource.com/llvm-project/+/8cfda791054bf9a7cdb43369e36caae2a56032c6"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "4e859c5a95ec0de993f5f8e75f1b5a6733ac7489"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@4e859c5a95ec0de993f5f8e75f1b5a6733ac7489",
"title": "4e859c5a95ec0de993f5f8e75f1b5a6733ac7489",
"url": "https://llvm.googlesource.com/llvm-project/+/4e859c5a95ec0de993f5f8e75f1b5a6733ac7489"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "0af137c0b0182acc24613f3d6c7631c7c23cfee7"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@0af137c0b0182acc24613f3d6c7631c7c23cfee7",
"title": "0af137c0b0182acc24613f3d6c7631c7c23cfee7",
"url": "https://llvm.googlesource.com/llvm-project/+/0af137c0b0182acc24613f3d6c7631c7c23cfee7"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "7fe5953a44bbce16c0fcc5b52e47905c1719b7b3"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@7fe5953a44bbce16c0fcc5b52e47905c1719b7b3",
"title": "7fe5953a44bbce16c0fcc5b52e47905c1719b7b3",
"url": "https://llvm.googlesource.com/llvm-project/+/7fe5953a44bbce16c0fcc5b52e47905c1719b7b3"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "d6f159dd05a2b237fb1e36d1614aa438d5ca1130"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@d6f159dd05a2b237fb1e36d1614aa438d5ca1130",
"title": "d6f159dd05a2b237fb1e36d1614aa438d5ca1130",
"url": "https://llvm.googlesource.com/llvm-project/+/d6f159dd05a2b237fb1e36d1614aa438d5ca1130"
}
]
}
},
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "d6f159dd05a2b237fb1e36d1614aa438d5ca1130",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8860581765487966240"
},
{
"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"
}
}
[10:36:05.630] Scheduled build:
{
"id": "8695151703537159713",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-mac-x64"
},
"createdBy": "project:fuchsia",
"createTime": "2025-12-18T10:36:05.288601389Z",
"updateTime": "2025-12-18T10:36:05.288601389Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "d6f159dd05a2b237fb1e36d1614aa438d5ca1130",
"ref": "refs/heads/main"
}
}
}
[10:36:05.630] Task URL: https://cr-buildbucket.appspot.com/build/8695151703537159713
[10:36:05.630] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8860581765487966240:2:0) after 8m23s
[10:36:08.994] Received PubSub notification, asking Buildbucket for the build status
[10:36:09.012] Build status: SCHEDULED
[10:36:11.066] Received PubSub notification, asking Buildbucket for the build status
[10:36:11.086] Build status: STARTED
[10:44:28.643] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8860581765487966240:2:0)
[10:44:28.658] Build status: STARTED
[10:44:28.658] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8860581765487966240:5:0) after 3m32s
[10:48:00.729] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8860581765487966240:5:0)
[10:48:00.746] Build status: STARTED
[10:48:00.746] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8860581765487966240:6:0) after 3m2s
[10:51:02.760] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8860581765487966240:6:0)
[10:51:02.776] Build status: STARTED
[10:51:02.776] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8860581765487966240:7:0) after 2m24s
[10:53:26.750] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8860581765487966240:7:0)
[10:53:26.767] Build status: STARTED
[10:53:26.767] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8860581765487966240:8:0) after 3m43s
[10:57:09.784] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8860581765487966240:8:0)
[10:57:09.799] Build status: STARTED
[10:57:09.799] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8860581765487966240:9:0) after 6m9s
[11:03:18.815] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8860581765487966240:9:0)
[11:03:18.835] Build status: STARTED
[11:03:18.835] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8860581765487966240:10:0) after 7m10s
[11:10:28.874] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8860581765487966240:10:0)
[11:10:28.887] Build status: STARTED
[11:10:28.887] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8860581765487966240:11:0) after 2m33s
[11:13:01.964] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8860581765487966240:11:0)
[11:13:01.981] Build status: STARTED
[11:13:01.982] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8860581765487966240:12:0) after 4m40s
[11:17:42.059] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8860581765487966240:12:0)
[11:17:42.075] Build status: STARTED
[11:17:42.075] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8860581765487966240:13:0) after 7m32s
[11:25:14.103] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8860581765487966240:13:0)
[11:25:14.128] Build status: STARTED
[11:25:14.128] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8860581765487966240:14:0) after 6m45s
[11:31:59.336] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8860581765487966240:14:0)
[11:31:59.355] Build status: STARTED
[11:31:59.355] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8860581765487966240:15:0) after 5m59s
[11:37:58.492] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8860581765487966240:15:0)
[11:37:58.518] Build status: STARTED
[11:37:58.518] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8860581765487966240:16:0) after 5m0s
[11:42:58.535] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8860581765487966240:16:0)
[11:42:58.554] Build status: STARTED
[11:42:58.554] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8860581765487966240:17:0) after 6m6s
[11:49:04.618] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8860581765487966240:17:0)
[11:49:04.634] Build status: STARTED
[11:49:04.634] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8860581765487966240:18:0) after 7m31s
[11:56:35.702] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8860581765487966240:18:0)
[11:56:35.729] Build status: STARTED
[11:56:35.729] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8860581765487966240:19:0) after 8m32s
[12:05:07.794] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8860581765487966240:19:0)
[12:05:07.816] Build status: STARTED
[12:05:07.816] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8860581765487966240:20:0) after 8m12s
[12:13:19.879] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8860581765487966240:20:0)
[12:13:19.900] Build status: STARTED
[12:13:19.900] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8860581765487966240:21:0) after 2m22s
[12:15:41.920] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8860581765487966240:21:0)
[12:15:41.933] Build status: STARTED
[12:15:41.933] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8860581765487966240:22:0) after 6m30s
[12:22:11.962] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8860581765487966240:22:0)
[12:22:11.979] Build status: STARTED
[12:22:11.979] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8860581765487966240:23:0) after 9m39s
[12:31:51.031] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8860581765487966240:23:0)
[12:31:51.053] Build status: STARTED
[12:31:51.053] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8860581765487966240:24:0) after 6m35s
[12:33:14.464] Received PubSub notification, asking Buildbucket for the build status
[12:33:14.486] Build:
{
"id": "8695151703537159713",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-mac-x64"
},
"createdBy": "project:fuchsia",
"createTime": "2025-12-18T10:36:05.288601389Z",
"startTime": "2025-12-18T10:36:10.402528408Z",
"endTime": "2025-12-18T12:32:54.179611090Z",
"updateTime": "2025-12-18T12:32:54.179611090Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "d6f159dd05a2b237fb1e36d1614aa438d5ca1130",
"ref": "refs/heads/main"
}
}
}
[12:33:14.486] Invocation finished in 1h57m10.441836553s with status SUCCEEDED