[16:31:18.633] New invocation is queued and will start shortly
[16:31:19.742] Starting the invocation (attempt 1)
[16:31:19.766] Popped buildset tag "buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/071d1fb8beda4c0ec9ede0acab12a382f34758fe"
[16:31:19.766] Popped gitiles commit info from properties and tags
[16:31:19.766] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[16:31:19.766] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[16:31:19.767] Buildbucket request:
{
"requestId": "8862552548795480224",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-windows-x64"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8862552548795480224",
"job": "fuchsia/toolchain.ci-clang-windows-x64-40be1bb5",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "0c2701fe7fa002e1befc5f86c268a7964f96d286"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@0c2701fe7fa002e1befc5f86c268a7964f96d286",
"title": "0c2701fe7fa002e1befc5f86c268a7964f96d286",
"url": "https://llvm.googlesource.com/llvm-project/+/0c2701fe7fa002e1befc5f86c268a7964f96d286"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "6e983e3876afe5e502d96cef3d4b0fbb7cd068ed"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@6e983e3876afe5e502d96cef3d4b0fbb7cd068ed",
"title": "6e983e3876afe5e502d96cef3d4b0fbb7cd068ed",
"url": "https://llvm.googlesource.com/llvm-project/+/6e983e3876afe5e502d96cef3d4b0fbb7cd068ed"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "e7bcd80e5bbc9c4c287d835a1df46742ba0fc3e9"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@e7bcd80e5bbc9c4c287d835a1df46742ba0fc3e9",
"title": "e7bcd80e5bbc9c4c287d835a1df46742ba0fc3e9",
"url": "https://llvm.googlesource.com/llvm-project/+/e7bcd80e5bbc9c4c287d835a1df46742ba0fc3e9"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "7bf459bce34280273942e4a75ce9eab4d4b4e496"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@7bf459bce34280273942e4a75ce9eab4d4b4e496",
"title": "7bf459bce34280273942e4a75ce9eab4d4b4e496",
"url": "https://llvm.googlesource.com/llvm-project/+/7bf459bce34280273942e4a75ce9eab4d4b4e496"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "9b88cd9945c5077f0d07f04cd9c9e8e146c48a1b"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@9b88cd9945c5077f0d07f04cd9c9e8e146c48a1b",
"title": "9b88cd9945c5077f0d07f04cd9c9e8e146c48a1b",
"url": "https://llvm.googlesource.com/llvm-project/+/9b88cd9945c5077f0d07f04cd9c9e8e146c48a1b"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "43e69b18920ecabcf7c6c5fb898f9b18120200f2"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@43e69b18920ecabcf7c6c5fb898f9b18120200f2",
"title": "43e69b18920ecabcf7c6c5fb898f9b18120200f2",
"url": "https://llvm.googlesource.com/llvm-project/+/43e69b18920ecabcf7c6c5fb898f9b18120200f2"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "59b3d1814afca973d1417ed2f1d5dac4af3de636"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@59b3d1814afca973d1417ed2f1d5dac4af3de636",
"title": "59b3d1814afca973d1417ed2f1d5dac4af3de636",
"url": "https://llvm.googlesource.com/llvm-project/+/59b3d1814afca973d1417ed2f1d5dac4af3de636"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "9e1d3cac8562fab0a62c1ab19228da5ff6fb26c5"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@9e1d3cac8562fab0a62c1ab19228da5ff6fb26c5",
"title": "9e1d3cac8562fab0a62c1ab19228da5ff6fb26c5",
"url": "https://llvm.googlesource.com/llvm-project/+/9e1d3cac8562fab0a62c1ab19228da5ff6fb26c5"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "e8b9d4217046727845d107c6d4e4ff275e6ee1b4"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@e8b9d4217046727845d107c6d4e4ff275e6ee1b4",
"title": "e8b9d4217046727845d107c6d4e4ff275e6ee1b4",
"url": "https://llvm.googlesource.com/llvm-project/+/e8b9d4217046727845d107c6d4e4ff275e6ee1b4"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "44c9d3a6f5d155ce7d934244dd673b7a8cd5296b"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@44c9d3a6f5d155ce7d934244dd673b7a8cd5296b",
"title": "44c9d3a6f5d155ce7d934244dd673b7a8cd5296b",
"url": "https://llvm.googlesource.com/llvm-project/+/44c9d3a6f5d155ce7d934244dd673b7a8cd5296b"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "c333f7dab9f89734777f7d19bc7b68c86f393216"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@c333f7dab9f89734777f7d19bc7b68c86f393216",
"title": "c333f7dab9f89734777f7d19bc7b68c86f393216",
"url": "https://llvm.googlesource.com/llvm-project/+/c333f7dab9f89734777f7d19bc7b68c86f393216"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "96cbbebc20dc62e6a780952e3745f67aaefcdf13"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@96cbbebc20dc62e6a780952e3745f67aaefcdf13",
"title": "96cbbebc20dc62e6a780952e3745f67aaefcdf13",
"url": "https://llvm.googlesource.com/llvm-project/+/96cbbebc20dc62e6a780952e3745f67aaefcdf13"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "071d1fb8beda4c0ec9ede0acab12a382f34758fe"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@071d1fb8beda4c0ec9ede0acab12a382f34758fe",
"title": "071d1fb8beda4c0ec9ede0acab12a382f34758fe",
"url": "https://llvm.googlesource.com/llvm-project/+/071d1fb8beda4c0ec9ede0acab12a382f34758fe"
}
]
}
},
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "071d1fb8beda4c0ec9ede0acab12a382f34758fe",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8862552548795480224"
},
{
"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"
}
}
[16:31:20.205] Scheduled build:
{
"id": "8697122486887349313",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-windows-x64"
},
"createdBy": "project:fuchsia",
"createTime": "2025-11-26T16:31:19.824562152Z",
"updateTime": "2025-11-26T16:31:19.824562152Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "071d1fb8beda4c0ec9ede0acab12a382f34758fe",
"ref": "refs/heads/main"
}
}
}
[16:31:20.205] Task URL: https://cr-buildbucket.appspot.com/build/8697122486887349313
[16:31:20.205] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8862552548795480224:2:0) after 8m1s
[16:31:20.452] Received PubSub notification, asking Buildbucket for the build status
[16:31:20.476] Build status: SCHEDULED
[16:31:23.890] Received PubSub notification, asking Buildbucket for the build status
[16:31:23.913] Build status: STARTED
[16:39:21.267] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8862552548795480224:2:0)
[16:39:21.293] Build status: STARTED
[16:39:21.293] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8862552548795480224:5:0) after 8m54s
[16:48:15.448] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8862552548795480224:5:0)
[16:48:15.473] Build status: STARTED
[16:48:15.473] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8862552548795480224:6:0) after 6m1s
[16:54:16.464] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8862552548795480224:6:0)
[16:54:16.480] Build status: STARTED
[16:54:16.480] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8862552548795480224:7:0) after 5m51s
[17:00:07.559] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8862552548795480224:7:0)
[17:00:07.580] Build status: STARTED
[17:00:07.580] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8862552548795480224:8:0) after 6m20s
[17:06:27.624] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8862552548795480224:8:0)
[17:06:27.641] Build status: STARTED
[17:06:27.641] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8862552548795480224:9:0) after 6m26s
[17:12:53.717] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8862552548795480224:9:0)
[17:12:53.757] Build status: STARTED
[17:12:53.757] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8862552548795480224:10:0) after 8m45s
[17:21:38.863] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8862552548795480224:10:0)
[17:21:38.947] Build status: STARTED
[17:21:38.947] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8862552548795480224:11:0) after 3m56s
[17:25:34.963] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8862552548795480224:11:0)
[17:25:34.980] Build status: STARTED
[17:25:34.980] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8862552548795480224:12:0) after 7m28s
[17:33:02.996] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8862552548795480224:12:0)
[17:33:03.017] Build status: STARTED
[17:33:03.017] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8862552548795480224:13:0) after 1m30s
[17:34:33.129] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8862552548795480224:13:0)
[17:34:33.150] Build status: STARTED
[17:34:33.150] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8862552548795480224:14:0) after 3m3s
[17:37:36.157] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8862552548795480224:14:0)
[17:37:36.171] Build status: STARTED
[17:37:36.171] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8862552548795480224:15:0) after 1m22s
[17:38:58.248] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8862552548795480224:15:0)
[17:38:58.286] Build status: STARTED
[17:38:58.286] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8862552548795480224:16:0) after 7m41s
[17:46:39.300] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8862552548795480224:16:0)
[17:46:39.314] Build status: STARTED
[17:46:39.315] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8862552548795480224:17:0) after 4m1s
[17:50:40.335] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8862552548795480224:17:0)
[17:50:40.383] Build status: STARTED
[17:50:40.383] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8862552548795480224:18:0) after 8m28s
[17:59:08.401] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8862552548795480224:18:0)
[17:59:08.416] Build status: STARTED
[17:59:08.416] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8862552548795480224:19:0) after 2m14s
[18:01:22.484] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8862552548795480224:19:0)
[18:01:22.502] Build status: STARTED
[18:01:22.502] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8862552548795480224:20:0) after 4m34s
[18:05:22.901] Received PubSub notification, asking Buildbucket for the build status
[18:05:22.917] Build:
{
"id": "8697122486887349313",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-windows-x64"
},
"createdBy": "project:fuchsia",
"createTime": "2025-11-26T16:31:19.824562152Z",
"startTime": "2025-11-26T16:31:23.668621274Z",
"endTime": "2025-11-26T18:05:22.556072979Z",
"updateTime": "2025-11-26T18:05:22.556072979Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "071d1fb8beda4c0ec9ede0acab12a382f34758fe",
"ref": "refs/heads/main"
}
}
}
[18:05:22.917] Invocation finished in 1h34m4.295637747s with status SUCCEEDED