[01:20:06.650] New invocation is queued and will start shortly
[01:20:07.991] Starting the invocation (attempt 1)
[01:20:08.020] Popped buildset tag "buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/b74801ad8790e35eeaa03bf2359683f3378269c5"
[01:20:08.020] Popped gitiles commit info from properties and tags
[01:20:08.020] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[01:20:08.020] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[01:20:08.020] Buildbucket request:
{
"requestId": "8865871367315269424",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-windows-x64"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8865871367315269424",
"job": "fuchsia/toolchain.ci-clang-windows-x64-40be1bb5",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "c9124a1b0853899bdd22d267124551ec4d720a23"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@c9124a1b0853899bdd22d267124551ec4d720a23",
"title": "c9124a1b0853899bdd22d267124551ec4d720a23",
"url": "https://llvm.googlesource.com/llvm-project/+/c9124a1b0853899bdd22d267124551ec4d720a23"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "750d81ab992f838106f0bce816f08c1abda2ac3d"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@750d81ab992f838106f0bce816f08c1abda2ac3d",
"title": "750d81ab992f838106f0bce816f08c1abda2ac3d",
"url": "https://llvm.googlesource.com/llvm-project/+/750d81ab992f838106f0bce816f08c1abda2ac3d"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "0833b48760efb72318952f1f0eb4cbd45eb941f4"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@0833b48760efb72318952f1f0eb4cbd45eb941f4",
"title": "0833b48760efb72318952f1f0eb4cbd45eb941f4",
"url": "https://llvm.googlesource.com/llvm-project/+/0833b48760efb72318952f1f0eb4cbd45eb941f4"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "f0f2f71c8d2bacb9d41b37fdf2a23fbbc73fb601"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@f0f2f71c8d2bacb9d41b37fdf2a23fbbc73fb601",
"title": "f0f2f71c8d2bacb9d41b37fdf2a23fbbc73fb601",
"url": "https://llvm.googlesource.com/llvm-project/+/f0f2f71c8d2bacb9d41b37fdf2a23fbbc73fb601"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "f3805fc187705a322a07ed832f153c442d00d495"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@f3805fc187705a322a07ed832f153c442d00d495",
"title": "f3805fc187705a322a07ed832f153c442d00d495",
"url": "https://llvm.googlesource.com/llvm-project/+/f3805fc187705a322a07ed832f153c442d00d495"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "e32f08f4e45f4c39dcd029b32dc0ed3673357656"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@e32f08f4e45f4c39dcd029b32dc0ed3673357656",
"title": "e32f08f4e45f4c39dcd029b32dc0ed3673357656",
"url": "https://llvm.googlesource.com/llvm-project/+/e32f08f4e45f4c39dcd029b32dc0ed3673357656"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "896d546cf3924779066a311d21e04a3dd1f1f428"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@896d546cf3924779066a311d21e04a3dd1f1f428",
"title": "896d546cf3924779066a311d21e04a3dd1f1f428",
"url": "https://llvm.googlesource.com/llvm-project/+/896d546cf3924779066a311d21e04a3dd1f1f428"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "de21b0d62ebf072675ec8fe178db0d4ebd0da10d"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@de21b0d62ebf072675ec8fe178db0d4ebd0da10d",
"title": "de21b0d62ebf072675ec8fe178db0d4ebd0da10d",
"url": "https://llvm.googlesource.com/llvm-project/+/de21b0d62ebf072675ec8fe178db0d4ebd0da10d"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "005ec78b71c8790a58cb1124e8ca2fcf47a880a0"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@005ec78b71c8790a58cb1124e8ca2fcf47a880a0",
"title": "005ec78b71c8790a58cb1124e8ca2fcf47a880a0",
"url": "https://llvm.googlesource.com/llvm-project/+/005ec78b71c8790a58cb1124e8ca2fcf47a880a0"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "8521ffdfaaf43057219b6f83d4a0c744ab3e66a6"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@8521ffdfaaf43057219b6f83d4a0c744ab3e66a6",
"title": "8521ffdfaaf43057219b6f83d4a0c744ab3e66a6",
"url": "https://llvm.googlesource.com/llvm-project/+/8521ffdfaaf43057219b6f83d4a0c744ab3e66a6"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "9173846640767d3bb2f0d8402c91a9b3b043668f"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@9173846640767d3bb2f0d8402c91a9b3b043668f",
"title": "9173846640767d3bb2f0d8402c91a9b3b043668f",
"url": "https://llvm.googlesource.com/llvm-project/+/9173846640767d3bb2f0d8402c91a9b3b043668f"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "f3a60cf8dd602958f706c11db66e401257364be7"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@f3a60cf8dd602958f706c11db66e401257364be7",
"title": "f3a60cf8dd602958f706c11db66e401257364be7",
"url": "https://llvm.googlesource.com/llvm-project/+/f3a60cf8dd602958f706c11db66e401257364be7"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "b74801ad8790e35eeaa03bf2359683f3378269c5"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@b74801ad8790e35eeaa03bf2359683f3378269c5",
"title": "b74801ad8790e35eeaa03bf2359683f3378269c5",
"url": "https://llvm.googlesource.com/llvm-project/+/b74801ad8790e35eeaa03bf2359683f3378269c5"
}
]
}
},
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "b74801ad8790e35eeaa03bf2359683f3378269c5",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8865871367315269424"
},
{
"key": "scheduler_job_id",
"value": "fuchsia/toolchain.ci-clang-windows-x64-40be1bb5"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[01:20:08.401] Scheduled build:
{
"id": "8700441305141023873",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-windows-x64"
},
"createdBy": "project:fuchsia",
"createTime": "2025-10-21T01:20:08.094065346Z",
"updateTime": "2025-10-21T01:20:08.094065346Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "b74801ad8790e35eeaa03bf2359683f3378269c5",
"ref": "refs/heads/main"
}
}
}
[01:20:08.401] Task URL: https://cr-buildbucket.appspot.com/build/8700441305141023873
[01:20:08.401] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8865871367315269424:2:0) after 6m31s
[01:20:09.354] Received PubSub notification, asking Buildbucket for the build status
[01:20:09.377] Build status: SCHEDULED
[01:20:11.660] Received PubSub notification, asking Buildbucket for the build status
[01:20:11.685] Build status: STARTED
[01:26:39.433] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8865871367315269424:2:0)
[01:26:39.453] Build status: STARTED
[01:26:39.453] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8865871367315269424:5:0) after 1m58s
[01:28:37.516] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8865871367315269424:5:0)
[01:28:37.544] Build status: STARTED
[01:28:37.544] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8865871367315269424:6:0) after 5m1s
[01:33:38.931] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8865871367315269424:6:0)
[01:33:38.955] Build status: STARTED
[01:33:38.955] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8865871367315269424:7:0) after 5m47s
[01:39:25.968] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8865871367315269424:7:0)
[01:39:25.995] Build status: STARTED
[01:39:25.995] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8865871367315269424:8:0) after 4m38s
[01:44:04.108] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8865871367315269424:8:0)
[01:44:04.158] Build status: STARTED
[01:44:04.158] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8865871367315269424:9:0) after 6m45s
[01:50:49.172] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8865871367315269424:9:0)
[01:50:49.188] Build status: STARTED
[01:50:49.188] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8865871367315269424:10:0) after 3m59s
[01:54:48.302] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8865871367315269424:10:0)
[01:54:48.323] Build status: STARTED
[01:54:48.323] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8865871367315269424:11:0) after 7m23s
[02:02:11.386] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8865871367315269424:11:0)
[02:02:11.408] Build status: STARTED
[02:02:11.408] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8865871367315269424:12:0) after 3m10s
[02:05:21.509] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8865871367315269424:12:0)
[02:05:21.540] Build status: STARTED
[02:05:21.540] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8865871367315269424:13:0) after 4m38s
[02:09:59.556] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8865871367315269424:13:0)
[02:09:59.597] Build status: STARTED
[02:09:59.597] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8865871367315269424:14:0) after 1m14s
[02:11:13.660] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8865871367315269424:14:0)
[02:11:13.678] Build status: STARTED
[02:11:13.678] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8865871367315269424:15:0) after 8m28s
[02:19:41.865] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8865871367315269424:15:0)
[02:19:41.882] Build status: STARTED
[02:19:41.882] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8865871367315269424:16:0) after 8m55s
[02:28:36.965] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8865871367315269424:16:0)
[02:28:36.983] Build status: STARTED
[02:28:36.983] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8865871367315269424:17:0) after 3m44s
[02:32:20.999] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8865871367315269424:17:0)
[02:32:21.015] Build status: STARTED
[02:32:21.015] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8865871367315269424:18:0) after 4m29s
[02:36:50.033] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8865871367315269424:18:0)
[02:36:50.049] Build status: STARTED
[02:36:50.050] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8865871367315269424:19:0) after 7m25s
[02:44:15.048] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8865871367315269424:19:0)
[02:44:15.112] Build status: STARTED
[02:44:15.112] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8865871367315269424:20:0) after 3m23s
[02:47:38.262] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8865871367315269424:20:0)
[02:47:38.290] Build status: STARTED
[02:47:38.290] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8865871367315269424:21:0) after 3m12s
[02:48:43.842] Received PubSub notification, asking Buildbucket for the build status
[02:48:43.855] Build:
{
"id": "8700441305141023873",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-windows-x64"
},
"createdBy": "project:fuchsia",
"createTime": "2025-10-21T01:20:08.094065346Z",
"startTime": "2025-10-21T01:20:11.508210163Z",
"endTime": "2025-10-21T02:48:43.277950650Z",
"updateTime": "2025-10-21T02:48:43.277950650Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "b74801ad8790e35eeaa03bf2359683f3378269c5",
"ref": "refs/heads/main"
}
}
}
[02:48:43.855] Invocation finished in 1h28m37.21858196s with status SUCCEEDED