[06:20:13.256] New invocation is queued and will start shortly
[06:20:14.337] Starting the invocation (attempt 1)
[06:20:14.366] Popped buildset tag "buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/f8278a152fdc1aed9f16a7e9b4a42f1c450fb844"
[06:20:14.366] Popped gitiles commit info from properties and tags
[06:20:14.366] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[06:20:14.367] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[06:20:14.367] Buildbucket request:
{
"requestId": "8857970549941126064",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-windows-x64"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8857970549941126064",
"job": "fuchsia/toolchain.ci-clang-windows-x64-40be1bb5",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "d8487bea958d2a357f23b963d774c6ce892b028c"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@d8487bea958d2a357f23b963d774c6ce892b028c",
"title": "d8487bea958d2a357f23b963d774c6ce892b028c",
"url": "https://llvm.googlesource.com/llvm-project/+/d8487bea958d2a357f23b963d774c6ce892b028c"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "de32b2123a2c337d4bd9d64c8c965d9506b935c2"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@de32b2123a2c337d4bd9d64c8c965d9506b935c2",
"title": "de32b2123a2c337d4bd9d64c8c965d9506b935c2",
"url": "https://llvm.googlesource.com/llvm-project/+/de32b2123a2c337d4bd9d64c8c965d9506b935c2"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "22271c9e763514d4180d0f299ebdc905c39fc04b"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@22271c9e763514d4180d0f299ebdc905c39fc04b",
"title": "22271c9e763514d4180d0f299ebdc905c39fc04b",
"url": "https://llvm.googlesource.com/llvm-project/+/22271c9e763514d4180d0f299ebdc905c39fc04b"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "dbe520fc0bcbe256bd9e943a4260ac056fc92c1d"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@dbe520fc0bcbe256bd9e943a4260ac056fc92c1d",
"title": "dbe520fc0bcbe256bd9e943a4260ac056fc92c1d",
"url": "https://llvm.googlesource.com/llvm-project/+/dbe520fc0bcbe256bd9e943a4260ac056fc92c1d"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "aa116291929225ff83dc2eca0ff6cb7b637c1240"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@aa116291929225ff83dc2eca0ff6cb7b637c1240",
"title": "aa116291929225ff83dc2eca0ff6cb7b637c1240",
"url": "https://llvm.googlesource.com/llvm-project/+/aa116291929225ff83dc2eca0ff6cb7b637c1240"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "8741ee2981e0f5c643ce0ae43603a0b8cbeb2351"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@8741ee2981e0f5c643ce0ae43603a0b8cbeb2351",
"title": "8741ee2981e0f5c643ce0ae43603a0b8cbeb2351",
"url": "https://llvm.googlesource.com/llvm-project/+/8741ee2981e0f5c643ce0ae43603a0b8cbeb2351"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "66e4919b22fb0de96a922f408c8115dd5bf132fc"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@66e4919b22fb0de96a922f408c8115dd5bf132fc",
"title": "66e4919b22fb0de96a922f408c8115dd5bf132fc",
"url": "https://llvm.googlesource.com/llvm-project/+/66e4919b22fb0de96a922f408c8115dd5bf132fc"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "3bdd794f98bb1ba0544b51d8ba7164c99d9c6a14"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@3bdd794f98bb1ba0544b51d8ba7164c99d9c6a14",
"title": "3bdd794f98bb1ba0544b51d8ba7164c99d9c6a14",
"url": "https://llvm.googlesource.com/llvm-project/+/3bdd794f98bb1ba0544b51d8ba7164c99d9c6a14"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "f8278a152fdc1aed9f16a7e9b4a42f1c450fb844"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@f8278a152fdc1aed9f16a7e9b4a42f1c450fb844",
"title": "f8278a152fdc1aed9f16a7e9b4a42f1c450fb844",
"url": "https://llvm.googlesource.com/llvm-project/+/f8278a152fdc1aed9f16a7e9b4a42f1c450fb844"
}
]
}
},
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "f8278a152fdc1aed9f16a7e9b4a42f1c450fb844",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8857970549941126064"
},
{
"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"
}
}
[06:20:14.795] Scheduled build:
{
"id": "8692540488065908145",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-windows-x64"
},
"createdBy": "project:fuchsia",
"createTime": "2026-01-16T06:20:14.418256313Z",
"updateTime": "2026-01-16T06:20:14.418256313Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "f8278a152fdc1aed9f16a7e9b4a42f1c450fb844",
"ref": "refs/heads/main"
}
}
}
[06:20:14.795] Task URL: https://cr-buildbucket.appspot.com/build/8692540488065908145
[06:20:14.795] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8857970549941126064:2:0) after 3m25s
[06:20:15.843] Received PubSub notification, asking Buildbucket for the build status
[06:20:15.862] Build status: SCHEDULED
[06:20:18.378] Received PubSub notification, asking Buildbucket for the build status
[06:20:18.403] Build status: STARTED
[06:23:39.911] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8857970549941126064:2:0)
[06:23:39.993] Build status: STARTED
[06:23:39.993] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8857970549941126064:5:0) after 4m51s
[06:28:31.023] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8857970549941126064:5:0)
[06:28:31.077] Build status: STARTED
[06:28:31.077] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8857970549941126064:6:0) after 7m12s
[06:35:43.142] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8857970549941126064:6:0)
[06:35:43.167] Build status: STARTED
[06:35:43.167] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8857970549941126064:7:0) after 3m45s
[06:39:28.141] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8857970549941126064:7:0)
[06:39:28.164] Build status: STARTED
[06:39:28.164] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8857970549941126064:8:0) after 7m3s
[06:46:31.269] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8857970549941126064:8:0)
[06:46:31.401] Build status: STARTED
[06:46:31.401] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8857970549941126064:9:0) after 4m29s
[06:51:00.416] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8857970549941126064:9:0)
[06:51:00.436] Build status: STARTED
[06:51:00.436] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8857970549941126064:10:0) after 9m38s
[07:00:38.449] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8857970549941126064:10:0)
[07:00:38.469] Build status: STARTED
[07:00:38.469] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8857970549941126064:11:0) after 1m17s
[07:01:55.485] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8857970549941126064:11:0)
[07:01:55.500] Build status: STARTED
[07:01:55.500] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8857970549941126064:12:0) after 7m41s
[07:09:36.704] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8857970549941126064:12:0)
[07:09:36.735] Build status: STARTED
[07:09:36.735] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8857970549941126064:13:0) after 2m4s
[07:11:40.750] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8857970549941126064:13:0)
[07:11:40.767] Build status: STARTED
[07:11:40.767] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8857970549941126064:14:0) after 8m11s
[07:19:51.819] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8857970549941126064:14:0)
[07:19:51.840] Build status: STARTED
[07:19:51.840] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8857970549941126064:15:0) after 1m59s
[07:21:51.039] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8857970549941126064:15:0)
[07:21:51.058] Build status: STARTED
[07:21:51.058] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8857970549941126064:16:0) after 4m41s
[07:26:32.084] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8857970549941126064:16:0)
[07:26:32.105] Build status: STARTED
[07:26:32.105] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8857970549941126064:17:0) after 4m40s
[07:31:12.127] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8857970549941126064:17:0)
[07:31:12.145] Build status: STARTED
[07:31:12.145] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8857970549941126064:18:0) after 6m48s
[07:38:00.183] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8857970549941126064:18:0)
[07:38:00.205] Build status: STARTED
[07:38:00.205] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8857970549941126064:19:0) after 4m3s
[07:42:03.272] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8857970549941126064:19:0)
[07:42:03.297] Build status: STARTED
[07:42:03.297] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8857970549941126064:20:0) after 3m50s
[07:45:53.331] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8857970549941126064:20:0)
[07:45:53.363] Build status: STARTED
[07:45:53.363] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8857970549941126064:21:0) after 4m7s
[07:50:00.389] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8857970549941126064:21:0)
[07:50:00.407] Build status: STARTED
[07:50:00.407] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8857970549941126064:22:0) after 6m34s
[07:51:16.883] Received PubSub notification, asking Buildbucket for the build status
[07:51:16.907] Build:
{
"id": "8692540488065908145",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-windows-x64"
},
"createdBy": "project:fuchsia",
"createTime": "2026-01-16T06:20:14.418256313Z",
"startTime": "2026-01-16T06:20:18.095507289Z",
"endTime": "2026-01-16T07:51:16.631620654Z",
"updateTime": "2026-01-16T07:51:16.631620654Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "f8278a152fdc1aed9f16a7e9b4a42f1c450fb844",
"ref": "refs/heads/main"
}
}
}
[07:51:16.907] Invocation finished in 1h31m3.660926334s with status SUCCEEDED