[13:35:16.694] New invocation is queued and will start shortly
[13:35:17.749] Starting the invocation (attempt 1)
[13:35:17.780] Popped buildset tag "buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/0d92b7f9021e3a0c891db9ffb4eac4fc721981f8"
[13:35:17.780] Popped gitiles commit info from properties and tags
[13:35:17.780] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[13:35:17.780] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[13:35:17.780] Buildbucket request:
{
"requestId": "8868361829640101824",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-windows-x64"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8868361829640101824",
"job": "fuchsia/toolchain.ci-clang-windows-x64-40be1bb5",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "2bc46ae8ffdd9510bc0f623c3ea35f7febbcd671"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@2bc46ae8ffdd9510bc0f623c3ea35f7febbcd671",
"title": "2bc46ae8ffdd9510bc0f623c3ea35f7febbcd671",
"url": "https://llvm.googlesource.com/llvm-project/+/2bc46ae8ffdd9510bc0f623c3ea35f7febbcd671"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "3826849613b8bb82c2c99845c2633fcfdb138a6f"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@3826849613b8bb82c2c99845c2633fcfdb138a6f",
"title": "3826849613b8bb82c2c99845c2633fcfdb138a6f",
"url": "https://llvm.googlesource.com/llvm-project/+/3826849613b8bb82c2c99845c2633fcfdb138a6f"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "fcebe6bdbb2a7e5fec50504ba1d610c0e7028740"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@fcebe6bdbb2a7e5fec50504ba1d610c0e7028740",
"title": "fcebe6bdbb2a7e5fec50504ba1d610c0e7028740",
"url": "https://llvm.googlesource.com/llvm-project/+/fcebe6bdbb2a7e5fec50504ba1d610c0e7028740"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "004e462682231548c9cf054be2341d3f5087ebbe"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@004e462682231548c9cf054be2341d3f5087ebbe",
"title": "004e462682231548c9cf054be2341d3f5087ebbe",
"url": "https://llvm.googlesource.com/llvm-project/+/004e462682231548c9cf054be2341d3f5087ebbe"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "612a105c46a77dc4c1c04d1e5cdd85d1b77decec"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@612a105c46a77dc4c1c04d1e5cdd85d1b77decec",
"title": "612a105c46a77dc4c1c04d1e5cdd85d1b77decec",
"url": "https://llvm.googlesource.com/llvm-project/+/612a105c46a77dc4c1c04d1e5cdd85d1b77decec"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "204580aa8e157ea6b96b94d19513b17c53532ff0"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@204580aa8e157ea6b96b94d19513b17c53532ff0",
"title": "204580aa8e157ea6b96b94d19513b17c53532ff0",
"url": "https://llvm.googlesource.com/llvm-project/+/204580aa8e157ea6b96b94d19513b17c53532ff0"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "0d92b7f9021e3a0c891db9ffb4eac4fc721981f8"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@0d92b7f9021e3a0c891db9ffb4eac4fc721981f8",
"title": "0d92b7f9021e3a0c891db9ffb4eac4fc721981f8",
"url": "https://llvm.googlesource.com/llvm-project/+/0d92b7f9021e3a0c891db9ffb4eac4fc721981f8"
}
]
}
},
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "0d92b7f9021e3a0c891db9ffb4eac4fc721981f8",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8868361829640101824"
},
{
"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"
}
}
[13:35:18.264] Scheduled build:
{
"id": "8702931767782415169",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-windows-x64"
},
"createdBy": "project:fuchsia",
"createTime": "2025-09-23T13:35:17.837523093Z",
"updateTime": "2025-09-23T13:35:17.837523093Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "0d92b7f9021e3a0c891db9ffb4eac4fc721981f8",
"ref": "refs/heads/main"
}
}
}
[13:35:18.264] Task URL: https://cr-buildbucket.appspot.com/build/8702931767782415169
[13:35:18.264] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8868361829640101824:2:0) after 1m11s
[13:35:19.326] Received PubSub notification, asking Buildbucket for the build status
[13:35:19.342] Build status: SCHEDULED
[13:35:21.525] Received PubSub notification, asking Buildbucket for the build status
[13:35:21.542] Build status: STARTED
[13:36:29.641] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8868361829640101824:2:0)
[13:36:29.658] Build status: STARTED
[13:36:29.658] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8868361829640101824:5:0) after 7m39s
[13:44:08.702] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8868361829640101824:5:0)
[13:44:08.735] Build status: STARTED
[13:44:08.735] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8868361829640101824:6:0) after 6m35s
[13:50:43.801] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8868361829640101824:6:0)
[13:50:43.822] Build status: STARTED
[13:50:43.822] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8868361829640101824:7:0) after 5m6s
[13:55:49.834] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8868361829640101824:7:0)
[13:55:49.851] Build status: STARTED
[13:55:49.851] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8868361829640101824:8:0) after 9m27s
[14:05:16.872] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8868361829640101824:8:0)
[14:05:16.889] Build status: STARTED
[14:05:16.889] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8868361829640101824:9:0) after 9m37s
[14:14:54.046] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8868361829640101824:9:0)
[14:14:54.065] Build status: STARTED
[14:14:54.065] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8868361829640101824:10:0) after 2m31s
[14:17:25.092] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8868361829640101824:10:0)
[14:17:25.117] Build status: STARTED
[14:17:25.117] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8868361829640101824:11:0) after 3m14s
[14:20:39.238] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8868361829640101824:11:0)
[14:20:39.285] Build status: STARTED
[14:20:39.286] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8868361829640101824:12:0) after 1m58s
[14:22:37.257] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8868361829640101824:12:0)
[14:22:37.272] Build status: STARTED
[14:22:37.272] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8868361829640101824:13:0) after 9m42s
[14:32:19.314] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8868361829640101824:13:0)
[14:32:19.364] Build status: STARTED
[14:32:19.365] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8868361829640101824:14:0) after 2m24s
[14:34:43.378] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8868361829640101824:14:0)
[14:34:43.397] Build status: STARTED
[14:34:43.397] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8868361829640101824:15:0) after 3m16s
[14:37:59.419] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8868361829640101824:15:0)
[14:37:59.441] Build status: STARTED
[14:37:59.441] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8868361829640101824:16:0) after 3m26s
[14:41:25.459] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8868361829640101824:16:0)
[14:41:25.477] Build status: STARTED
[14:41:25.477] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8868361829640101824:17:0) after 6m0s
[14:47:25.564] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8868361829640101824:17:0)
[14:47:25.584] Build status: STARTED
[14:47:25.584] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8868361829640101824:18:0) after 8m20s
[14:55:45.651] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8868361829640101824:18:0)
[14:55:45.697] Build status: STARTED
[14:55:45.697] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8868361829640101824:19:0) after 2m16s
[14:58:01.817] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8868361829640101824:19:0)
[14:58:01.835] Build status: STARTED
[14:58:01.835] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8868361829640101824:20:0) after 7m16s
[15:00:33.200] Received PubSub notification, asking Buildbucket for the build status
[15:00:33.253] Build:
{
"id": "8702931767782415169",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-windows-x64"
},
"createdBy": "project:fuchsia",
"createTime": "2025-09-23T13:35:17.837523093Z",
"startTime": "2025-09-23T13:35:21.340848289Z",
"endTime": "2025-09-23T15:00:32.604109418Z",
"updateTime": "2025-09-23T15:00:32.604109418Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "0d92b7f9021e3a0c891db9ffb4eac4fc721981f8",
"ref": "refs/heads/main"
}
}
}
[15:00:33.253] Invocation finished in 1h25m16.570470651s with status SUCCEEDED