[20:40:24.262] New invocation is queued and will start shortly
[20:40:25.343] Starting the invocation (attempt 1)
[20:40:25.372] Popped buildset tag "buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/21a1e6e6a70d70635c68b9aaa54f816ae36a6416"
[20:40:25.372] Popped gitiles commit info from properties and tags
[20:40:25.372] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[20:40:25.372] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[20:40:25.373] Buildbucket request:
{
"requestId": "8858641207604847056",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-windows-x64"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8858641207604847056",
"job": "fuchsia/toolchain.ci-clang-windows-x64-40be1bb5",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "55e508c1339d0bb33b8012e16b93b7ae3a53a419"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@55e508c1339d0bb33b8012e16b93b7ae3a53a419",
"title": "55e508c1339d0bb33b8012e16b93b7ae3a53a419",
"url": "https://llvm.googlesource.com/llvm-project/+/55e508c1339d0bb33b8012e16b93b7ae3a53a419"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "292c61388d5d7102e355e5cf3c0f46d96c6b55a0"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@292c61388d5d7102e355e5cf3c0f46d96c6b55a0",
"title": "292c61388d5d7102e355e5cf3c0f46d96c6b55a0",
"url": "https://llvm.googlesource.com/llvm-project/+/292c61388d5d7102e355e5cf3c0f46d96c6b55a0"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "700d1f029d00f6c1b6496f148f7d526e690c4643"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@700d1f029d00f6c1b6496f148f7d526e690c4643",
"title": "700d1f029d00f6c1b6496f148f7d526e690c4643",
"url": "https://llvm.googlesource.com/llvm-project/+/700d1f029d00f6c1b6496f148f7d526e690c4643"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "14af55c53acf12edfbe1f79d15d570660aafcecc"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@14af55c53acf12edfbe1f79d15d570660aafcecc",
"title": "14af55c53acf12edfbe1f79d15d570660aafcecc",
"url": "https://llvm.googlesource.com/llvm-project/+/14af55c53acf12edfbe1f79d15d570660aafcecc"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "289a3292be0c6a3df86bcdf5be7dd05b79a5570c"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@289a3292be0c6a3df86bcdf5be7dd05b79a5570c",
"title": "289a3292be0c6a3df86bcdf5be7dd05b79a5570c",
"url": "https://llvm.googlesource.com/llvm-project/+/289a3292be0c6a3df86bcdf5be7dd05b79a5570c"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "c379a88c09af4657d609888a46ada7719b2c9da9"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@c379a88c09af4657d609888a46ada7719b2c9da9",
"title": "c379a88c09af4657d609888a46ada7719b2c9da9",
"url": "https://llvm.googlesource.com/llvm-project/+/c379a88c09af4657d609888a46ada7719b2c9da9"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "21a1e6e6a70d70635c68b9aaa54f816ae36a6416"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@21a1e6e6a70d70635c68b9aaa54f816ae36a6416",
"title": "21a1e6e6a70d70635c68b9aaa54f816ae36a6416",
"url": "https://llvm.googlesource.com/llvm-project/+/21a1e6e6a70d70635c68b9aaa54f816ae36a6416"
}
]
}
},
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "21a1e6e6a70d70635c68b9aaa54f816ae36a6416",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8858641207604847056"
},
{
"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"
}
}
[20:40:25.920] Scheduled build:
{
"id": "8693211145728168481",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-windows-x64"
},
"createdBy": "project:fuchsia",
"createTime": "2026-01-08T20:40:25.430073050Z",
"updateTime": "2026-01-08T20:40:25.430073050Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "21a1e6e6a70d70635c68b9aaa54f816ae36a6416",
"ref": "refs/heads/main"
}
}
}
[20:40:25.920] Task URL: https://cr-buildbucket.appspot.com/build/8693211145728168481
[20:40:25.920] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8858641207604847056:2:0) after 3m22s
[20:40:26.146] Received PubSub notification, asking Buildbucket for the build status
[20:40:26.163] Build status: SCHEDULED
[20:40:30.629] Received PubSub notification, asking Buildbucket for the build status
[20:40:30.671] Build status: STARTED
[20:43:47.957] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8858641207604847056:2:0)
[20:43:47.982] Build status: STARTED
[20:43:47.982] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8858641207604847056:5:0) after 4m32s
[20:48:20.065] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8858641207604847056:5:0)
[20:48:20.210] Build status: STARTED
[20:48:20.210] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8858641207604847056:6:0) after 2m58s
[20:51:18.253] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8858641207604847056:6:0)
[20:51:18.276] Build status: STARTED
[20:51:18.276] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8858641207604847056:7:0) after 1m31s
[20:52:49.290] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8858641207604847056:7:0)
[20:52:49.359] Build status: STARTED
[20:52:49.359] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8858641207604847056:8:0) after 6m54s
[20:59:43.373] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8858641207604847056:8:0)
[20:59:43.390] Build status: STARTED
[20:59:43.390] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8858641207604847056:9:0) after 6m52s
[21:06:35.605] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8858641207604847056:9:0)
[21:06:35.618] Build status: STARTED
[21:06:35.618] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8858641207604847056:10:0) after 3m46s
[21:10:21.632] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8858641207604847056:10:0)
[21:10:21.647] Build status: STARTED
[21:10:21.647] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8858641207604847056:11:0) after 1m29s
[21:11:50.659] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8858641207604847056:11:0)
[21:11:50.681] Build status: STARTED
[21:11:50.682] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8858641207604847056:12:0) after 4m25s
[21:16:15.698] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8858641207604847056:12:0)
[21:16:15.773] Build status: STARTED
[21:16:15.773] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8858641207604847056:13:0) after 7m6s
[21:23:21.837] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8858641207604847056:13:0)
[21:23:21.854] Build status: STARTED
[21:23:21.854] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8858641207604847056:14:0) after 2m54s
[21:26:15.833] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8858641207604847056:14:0)
[21:26:15.849] Build status: STARTED
[21:26:15.849] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8858641207604847056:15:0) after 5m0s
[21:31:15.863] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8858641207604847056:15:0)
[21:31:15.881] Build status: STARTED
[21:31:15.881] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8858641207604847056:16:0) after 3m8s
[21:34:23.967] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8858641207604847056:16:0)
[21:34:23.986] Build status: STARTED
[21:34:23.986] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8858641207604847056:17:0) after 8m3s
[21:42:27.045] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8858641207604847056:17:0)
[21:42:27.062] Build status: STARTED
[21:42:27.062] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8858641207604847056:18:0) after 6m3s
[21:48:30.093] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8858641207604847056:18:0)
[21:48:30.109] Build status: STARTED
[21:48:30.109] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8858641207604847056:19:0) after 2m51s
[21:51:21.155] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8858641207604847056:19:0)
[21:51:21.176] Build status: STARTED
[21:51:21.176] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8858641207604847056:20:0) after 7m56s
[21:59:17.237] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8858641207604847056:20:0)
[21:59:17.289] Build status: STARTED
[21:59:17.289] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8858641207604847056:21:0) after 6m12s
[22:05:29.304] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8858641207604847056:21:0)
[22:05:29.320] Build status: STARTED
[22:05:29.320] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8858641207604847056:22:0) after 7m22s
[22:09:52.680] Received PubSub notification, asking Buildbucket for the build status
[22:09:52.697] Build:
{
"id": "8693211145728168481",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-windows-x64"
},
"createdBy": "project:fuchsia",
"createTime": "2026-01-08T20:40:25.430073050Z",
"startTime": "2026-01-08T20:40:30.434993072Z",
"endTime": "2026-01-08T22:09:51.996186192Z",
"updateTime": "2026-01-08T22:09:51.996186192Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "21a1e6e6a70d70635c68b9aaa54f816ae36a6416",
"ref": "refs/heads/main"
}
}
}
[22:09:52.697] Invocation finished in 1h29m28.44024894s with status SUCCEEDED