[15:17:28.867] New invocation is queued and will start shortly
[15:17:30.003] Starting the invocation (attempt 1)
[15:17:30.040] Popped buildset tag "buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/9865f7ec2bb15f3d8aa25c7e9305393422597dc5"
[15:17:30.040] Popped gitiles commit info from properties and tags
[15:17:30.040] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[15:17:30.044] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[15:17:30.045] Buildbucket request:
{
"requestId": "8868989578356116560",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-windows-x64"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8868989578356116560",
"job": "fuchsia/toolchain.ci-clang-windows-x64-40be1bb5",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "311d78f2a1d80fd6b7700a0199c146accd2c7d3c"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@311d78f2a1d80fd6b7700a0199c146accd2c7d3c",
"title": "311d78f2a1d80fd6b7700a0199c146accd2c7d3c",
"url": "https://llvm.googlesource.com/llvm-project/+/311d78f2a1d80fd6b7700a0199c146accd2c7d3c"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "e7101dac9cbdad08696a05b4b73ed76c20a6f2fc"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@e7101dac9cbdad08696a05b4b73ed76c20a6f2fc",
"title": "e7101dac9cbdad08696a05b4b73ed76c20a6f2fc",
"url": "https://llvm.googlesource.com/llvm-project/+/e7101dac9cbdad08696a05b4b73ed76c20a6f2fc"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "148e099b39a25ea4336faeef485c53819b269fc2"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@148e099b39a25ea4336faeef485c53819b269fc2",
"title": "148e099b39a25ea4336faeef485c53819b269fc2",
"url": "https://llvm.googlesource.com/llvm-project/+/148e099b39a25ea4336faeef485c53819b269fc2"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "ce073a9445a2eaf5810ea734e2dcad6f14441218"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@ce073a9445a2eaf5810ea734e2dcad6f14441218",
"title": "ce073a9445a2eaf5810ea734e2dcad6f14441218",
"url": "https://llvm.googlesource.com/llvm-project/+/ce073a9445a2eaf5810ea734e2dcad6f14441218"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "334013b090eef5b97cef8bc1817ed9ff67680488"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@334013b090eef5b97cef8bc1817ed9ff67680488",
"title": "334013b090eef5b97cef8bc1817ed9ff67680488",
"url": "https://llvm.googlesource.com/llvm-project/+/334013b090eef5b97cef8bc1817ed9ff67680488"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "b3fa92fd4edce2d9be61eb289a179a98bcf13880"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@b3fa92fd4edce2d9be61eb289a179a98bcf13880",
"title": "b3fa92fd4edce2d9be61eb289a179a98bcf13880",
"url": "https://llvm.googlesource.com/llvm-project/+/b3fa92fd4edce2d9be61eb289a179a98bcf13880"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "2771d35e2aaf76cf3716954d6094a822e56dfda5"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@2771d35e2aaf76cf3716954d6094a822e56dfda5",
"title": "2771d35e2aaf76cf3716954d6094a822e56dfda5",
"url": "https://llvm.googlesource.com/llvm-project/+/2771d35e2aaf76cf3716954d6094a822e56dfda5"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "7e71877835a567ada4d0e57413a5f64de3545033"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@7e71877835a567ada4d0e57413a5f64de3545033",
"title": "7e71877835a567ada4d0e57413a5f64de3545033",
"url": "https://llvm.googlesource.com/llvm-project/+/7e71877835a567ada4d0e57413a5f64de3545033"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "a4c5a747c5507d0c45524e45082389089fa9a791"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@a4c5a747c5507d0c45524e45082389089fa9a791",
"title": "a4c5a747c5507d0c45524e45082389089fa9a791",
"url": "https://llvm.googlesource.com/llvm-project/+/a4c5a747c5507d0c45524e45082389089fa9a791"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "44b686e52ec462c173d0b114172db2a783215116"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@44b686e52ec462c173d0b114172db2a783215116",
"title": "44b686e52ec462c173d0b114172db2a783215116",
"url": "https://llvm.googlesource.com/llvm-project/+/44b686e52ec462c173d0b114172db2a783215116"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "a42aac5f83e272f83207844dde1530b86e6fcf2b"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@a42aac5f83e272f83207844dde1530b86e6fcf2b",
"title": "a42aac5f83e272f83207844dde1530b86e6fcf2b",
"url": "https://llvm.googlesource.com/llvm-project/+/a42aac5f83e272f83207844dde1530b86e6fcf2b"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "eeced0d073ee387d98e39fdcada2277ad81cd4a9"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@eeced0d073ee387d98e39fdcada2277ad81cd4a9",
"title": "eeced0d073ee387d98e39fdcada2277ad81cd4a9",
"url": "https://llvm.googlesource.com/llvm-project/+/eeced0d073ee387d98e39fdcada2277ad81cd4a9"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "175bab32d7f37bfb854b89c0da7e9f4aa427bc70"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@175bab32d7f37bfb854b89c0da7e9f4aa427bc70",
"title": "175bab32d7f37bfb854b89c0da7e9f4aa427bc70",
"url": "https://llvm.googlesource.com/llvm-project/+/175bab32d7f37bfb854b89c0da7e9f4aa427bc70"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "beb6bab87e6370087049bb900155d5ca164acc15"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@beb6bab87e6370087049bb900155d5ca164acc15",
"title": "beb6bab87e6370087049bb900155d5ca164acc15",
"url": "https://llvm.googlesource.com/llvm-project/+/beb6bab87e6370087049bb900155d5ca164acc15"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "f017bcb3e375843dc146eda823fcdd4c95a10153"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@f017bcb3e375843dc146eda823fcdd4c95a10153",
"title": "f017bcb3e375843dc146eda823fcdd4c95a10153",
"url": "https://llvm.googlesource.com/llvm-project/+/f017bcb3e375843dc146eda823fcdd4c95a10153"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "babdad3fdbc66b4992654f9b7dc0fa4da85bd843"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@babdad3fdbc66b4992654f9b7dc0fa4da85bd843",
"title": "babdad3fdbc66b4992654f9b7dc0fa4da85bd843",
"url": "https://llvm.googlesource.com/llvm-project/+/babdad3fdbc66b4992654f9b7dc0fa4da85bd843"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "9865f7ec2bb15f3d8aa25c7e9305393422597dc5"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@9865f7ec2bb15f3d8aa25c7e9305393422597dc5",
"title": "9865f7ec2bb15f3d8aa25c7e9305393422597dc5",
"url": "https://llvm.googlesource.com/llvm-project/+/9865f7ec2bb15f3d8aa25c7e9305393422597dc5"
}
]
}
},
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "9865f7ec2bb15f3d8aa25c7e9305393422597dc5",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8868989578356116560"
},
{
"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"
}
}
[15:17:30.549] Scheduled build:
{
"id": "8703559516393822769",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-windows-x64"
},
"createdBy": "project:fuchsia",
"createTime": "2025-09-16T15:17:30.110623009Z",
"updateTime": "2025-09-16T15:17:30.110623009Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "9865f7ec2bb15f3d8aa25c7e9305393422597dc5",
"ref": "refs/heads/main"
}
}
}
[15:17:30.549] Task URL: https://cr-buildbucket.appspot.com/build/8703559516393822769
[15:17:30.549] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8868989578356116560:2:0) after 4m20s
[15:17:31.482] Received PubSub notification, asking Buildbucket for the build status
[15:17:31.514] Build status: SCHEDULED
[15:17:41.519] Received PubSub notification, asking Buildbucket for the build status
[15:17:41.554] Build status: STARTED
[15:21:50.720] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8868989578356116560:2:0)
[15:21:50.942] Build status: STARTED
[15:21:50.942] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8868989578356116560:5:0) after 1m2s
[15:22:53.015] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8868989578356116560:5:0)
[15:22:53.099] Build status: STARTED
[15:22:53.099] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8868989578356116560:6:0) after 5m11s
[15:28:04.121] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8868989578356116560:6:0)
[15:28:04.189] Build status: STARTED
[15:28:04.189] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8868989578356116560:7:0) after 5m2s
[15:33:06.269] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8868989578356116560:7:0)
[15:33:06.297] Build status: STARTED
[15:33:06.297] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8868989578356116560:8:0) after 8m48s
[15:41:54.364] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8868989578356116560:8:0)
[15:41:54.383] Build status: STARTED
[15:41:54.383] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8868989578356116560:9:0) after 6m0s
[15:47:54.423] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8868989578356116560:9:0)
[15:47:54.439] Build status: STARTED
[15:47:54.440] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8868989578356116560:10:0) after 3m6s
[15:51:00.521] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8868989578356116560:10:0)
[15:51:00.542] Build status: STARTED
[15:51:00.542] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8868989578356116560:11:0) after 2m26s
[15:53:26.658] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8868989578356116560:11:0)
[15:53:26.678] Build status: STARTED
[15:53:26.678] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8868989578356116560:12:0) after 3m55s
[15:57:21.697] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8868989578356116560:12:0)
[15:57:21.717] Build status: STARTED
[15:57:21.717] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8868989578356116560:13:0) after 6m11s
[16:03:32.740] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8868989578356116560:13:0)
[16:03:32.778] Build status: STARTED
[16:03:32.778] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8868989578356116560:14:0) after 7m21s
[16:10:53.899] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8868989578356116560:14:0)
[16:10:53.932] Build status: STARTED
[16:10:53.932] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8868989578356116560:15:0) after 2m21s
[16:13:14.950] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8868989578356116560:15:0)
[16:13:14.976] Build status: STARTED
[16:13:14.976] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8868989578356116560:16:0) after 5m14s
[16:18:29.074] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8868989578356116560:16:0)
[16:18:29.097] Build status: STARTED
[16:18:29.097] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8868989578356116560:17:0) after 2m19s
[16:20:48.107] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8868989578356116560:17:0)
[16:20:48.122] Build status: STARTED
[16:20:48.122] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8868989578356116560:18:0) after 8m12s
[16:29:00.290] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8868989578356116560:18:0)
[16:29:00.314] Build status: STARTED
[16:29:00.314] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8868989578356116560:19:0) after 2m15s
[16:31:15.358] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8868989578356116560:19:0)
[16:31:15.379] Build status: STARTED
[16:31:15.379] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8868989578356116560:20:0) after 8m12s
[16:39:27.427] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8868989578356116560:20:0)
[16:39:27.443] Build status: STARTED
[16:39:27.444] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8868989578356116560:21:0) after 8m23s
[16:47:50.463] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8868989578356116560:21:0)
[16:47:50.480] Build status: STARTED
[16:47:50.480] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8868989578356116560:22:0) after 1m9s
[16:48:59.544] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8868989578356116560:22:0)
[16:48:59.573] Build status: STARTED
[16:48:59.573] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8868989578356116560:23:0) after 7m4s
[16:49:34.707] Received PubSub notification, asking Buildbucket for the build status
[16:49:34.724] Build:
{
"id": "8703559516393822769",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-windows-x64"
},
"createdBy": "project:fuchsia",
"createTime": "2025-09-16T15:17:30.110623009Z",
"startTime": "2025-09-16T15:17:39.324845273Z",
"endTime": "2025-09-16T16:49:34.263177407Z",
"updateTime": "2025-09-16T16:49:34.263177407Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "9865f7ec2bb15f3d8aa25c7e9305393422597dc5",
"ref": "refs/heads/main"
}
}
}
[16:49:34.724] Invocation finished in 1h32m5.868595431s with status SUCCEEDED