[11:19:49.092] New invocation is queued and will start shortly
[11:19:50.218] Starting the invocation (attempt 1)
[11:19:50.246] Popped buildset tag "buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/cecdff92838f3c049548e3445a15d8c9c7a49205"
[11:19:50.246] Popped gitiles commit info from properties and tags
[11:19:50.246] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[11:19:50.246] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[11:19:50.247] Buildbucket request:
{
"requestId": "8868460949011025232",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-windows-x64"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8868460949011025232",
"job": "fuchsia/toolchain.ci-clang-windows-x64-40be1bb5",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "dc6a9151ad14a5fe4cdbca60f5cb6deb77668524"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@dc6a9151ad14a5fe4cdbca60f5cb6deb77668524",
"title": "dc6a9151ad14a5fe4cdbca60f5cb6deb77668524",
"url": "https://llvm.googlesource.com/llvm-project/+/dc6a9151ad14a5fe4cdbca60f5cb6deb77668524"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "34dfbb0ec98c205bc1165a1e58c686a0159ca23c"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@34dfbb0ec98c205bc1165a1e58c686a0159ca23c",
"title": "34dfbb0ec98c205bc1165a1e58c686a0159ca23c",
"url": "https://llvm.googlesource.com/llvm-project/+/34dfbb0ec98c205bc1165a1e58c686a0159ca23c"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "d46998b1dd1a2db10f4372a0ac8eced9c5b5a073"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@d46998b1dd1a2db10f4372a0ac8eced9c5b5a073",
"title": "d46998b1dd1a2db10f4372a0ac8eced9c5b5a073",
"url": "https://llvm.googlesource.com/llvm-project/+/d46998b1dd1a2db10f4372a0ac8eced9c5b5a073"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "f9b080cf5f433fa00678d5cc90b5ef76eb43aa8e"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@f9b080cf5f433fa00678d5cc90b5ef76eb43aa8e",
"title": "f9b080cf5f433fa00678d5cc90b5ef76eb43aa8e",
"url": "https://llvm.googlesource.com/llvm-project/+/f9b080cf5f433fa00678d5cc90b5ef76eb43aa8e"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "1ed15374638ecf6046169194b4b3ca34b7cf340f"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@1ed15374638ecf6046169194b4b3ca34b7cf340f",
"title": "1ed15374638ecf6046169194b4b3ca34b7cf340f",
"url": "https://llvm.googlesource.com/llvm-project/+/1ed15374638ecf6046169194b4b3ca34b7cf340f"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "e8e678cfa2aa8322942ea8719f9e06b316096156"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@e8e678cfa2aa8322942ea8719f9e06b316096156",
"title": "e8e678cfa2aa8322942ea8719f9e06b316096156",
"url": "https://llvm.googlesource.com/llvm-project/+/e8e678cfa2aa8322942ea8719f9e06b316096156"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "6884cc7e77631a73a151bcd9be69a75e4edb5fcb"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@6884cc7e77631a73a151bcd9be69a75e4edb5fcb",
"title": "6884cc7e77631a73a151bcd9be69a75e4edb5fcb",
"url": "https://llvm.googlesource.com/llvm-project/+/6884cc7e77631a73a151bcd9be69a75e4edb5fcb"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "ab766861956e43aa138aa97e34edace57bebfa89"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@ab766861956e43aa138aa97e34edace57bebfa89",
"title": "ab766861956e43aa138aa97e34edace57bebfa89",
"url": "https://llvm.googlesource.com/llvm-project/+/ab766861956e43aa138aa97e34edace57bebfa89"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "cecdff92838f3c049548e3445a15d8c9c7a49205"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@cecdff92838f3c049548e3445a15d8c9c7a49205",
"title": "cecdff92838f3c049548e3445a15d8c9c7a49205",
"url": "https://llvm.googlesource.com/llvm-project/+/cecdff92838f3c049548e3445a15d8c9c7a49205"
}
]
}
},
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "cecdff92838f3c049548e3445a15d8c9c7a49205",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8868460949011025232"
},
{
"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"
}
}
[11:19:50.688] Scheduled build:
{
"id": "8703030887077880929",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-windows-x64"
},
"createdBy": "project:fuchsia",
"createTime": "2025-09-22T11:19:50.311506625Z",
"updateTime": "2025-09-22T11:19:50.311506625Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "cecdff92838f3c049548e3445a15d8c9c7a49205",
"ref": "refs/heads/main"
}
}
}
[11:19:50.688] Task URL: https://cr-buildbucket.appspot.com/build/8703030887077880929
[11:19:50.688] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8868460949011025232:2:0) after 1m27s
[11:19:51.612] Received PubSub notification, asking Buildbucket for the build status
[11:19:51.637] Build status: SCHEDULED
[11:19:54.282] Received PubSub notification, asking Buildbucket for the build status
[11:19:54.298] Build status: STARTED
[11:21:17.796] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8868460949011025232:2:0)
[11:21:17.825] Build status: STARTED
[11:21:17.825] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8868460949011025232:5:0) after 9m8s
[11:30:26.032] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8868460949011025232:5:0)
[11:30:26.082] Build status: STARTED
[11:30:26.082] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8868460949011025232:6:0) after 1m47s
[11:32:13.116] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8868460949011025232:6:0)
[11:32:13.197] Build status: STARTED
[11:32:13.197] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8868460949011025232:7:0) after 5m47s
[11:38:00.404] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8868460949011025232:7:0)
[11:38:00.442] Build status: STARTED
[11:38:00.442] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8868460949011025232:8:0) after 9m37s
[11:47:37.559] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8868460949011025232:8:0)
[11:47:37.605] Build status: STARTED
[11:47:37.605] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8868460949011025232:9:0) after 2m50s
[11:50:27.793] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8868460949011025232:9:0)
[11:50:27.862] Build status: STARTED
[11:50:27.862] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8868460949011025232:10:0) after 3m39s
[11:54:06.881] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8868460949011025232:10:0)
[11:54:06.898] Build status: STARTED
[11:54:06.898] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8868460949011025232:11:0) after 7m51s
[12:01:57.957] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8868460949011025232:11:0)
[12:01:58.069] Build status: STARTED
[12:01:58.069] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8868460949011025232:12:0) after 1m56s
[12:03:54.104] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8868460949011025232:12:0)
[12:03:54.122] Build status: STARTED
[12:03:54.122] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8868460949011025232:13:0) after 8m29s
[12:12:23.117] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8868460949011025232:13:0)
[12:12:23.136] Build status: STARTED
[12:12:23.136] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8868460949011025232:14:0) after 7m33s
[12:19:56.523] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8868460949011025232:14:0)
[12:19:56.547] Build status: STARTED
[12:19:56.547] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8868460949011025232:15:0) after 6m27s
[12:26:24.115] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8868460949011025232:15:0)
[12:26:24.150] Build status: STARTED
[12:26:24.150] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8868460949011025232:16:0) after 7m28s
[12:33:52.195] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8868460949011025232:16:0)
[12:33:52.212] Build status: STARTED
[12:33:52.212] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8868460949011025232:17:0) after 2m37s
[12:36:29.629] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8868460949011025232:17:0)
[12:36:29.687] Build status: STARTED
[12:36:29.687] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8868460949011025232:18:0) after 2m39s
[12:39:08.802] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8868460949011025232:18:0)
[12:39:08.818] Build status: STARTED
[12:39:08.818] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8868460949011025232:19:0) after 7m52s
[12:47:01.331] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8868460949011025232:19:0)
[12:47:01.345] Build status: STARTED
[12:47:01.345] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8868460949011025232:20:0) after 2m59s
[12:49:32.017] Received PubSub notification, asking Buildbucket for the build status
[12:49:32.043] Build:
{
"id": "8703030887077880929",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-windows-x64"
},
"createdBy": "project:fuchsia",
"createTime": "2025-09-22T11:19:50.311506625Z",
"startTime": "2025-09-22T11:19:54.073777464Z",
"endTime": "2025-09-22T12:49:31.593092340Z",
"updateTime": "2025-09-22T12:49:31.593092340Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "cecdff92838f3c049548e3445a15d8c9c7a49205",
"ref": "refs/heads/main"
}
}
}
[12:49:32.043] Invocation finished in 1h29m42.958948758s with status SUCCEEDED