[00:06:00.302] New invocation is queued and will start shortly
[00:06:01.411] Starting the invocation (attempt 1)
[00:06:01.439] Popped buildset tag "buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/169626f11ab19a0b33fba2ca84cf4d9ec2b76fb1"
[00:06:01.439] Popped gitiles commit info from properties and tags
[00:06:01.439] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[00:06:01.439] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[00:06:01.440] Buildbucket request:
{
"requestId": "8865604238745550048",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-windows-x64"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8865604238745550048",
"job": "fuchsia/toolchain.ci-clang-windows-x64-40be1bb5",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "ca10dacf19d52cad8cbf6c4b5eb5dad0e265a704"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@ca10dacf19d52cad8cbf6c4b5eb5dad0e265a704",
"title": "ca10dacf19d52cad8cbf6c4b5eb5dad0e265a704",
"url": "https://llvm.googlesource.com/llvm-project/+/ca10dacf19d52cad8cbf6c4b5eb5dad0e265a704"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "6836261ee4acecd14c31f8d66d746f58de87a34b"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@6836261ee4acecd14c31f8d66d746f58de87a34b",
"title": "6836261ee4acecd14c31f8d66d746f58de87a34b",
"url": "https://llvm.googlesource.com/llvm-project/+/6836261ee4acecd14c31f8d66d746f58de87a34b"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "ef923f1b281cf25bc8fed129e0851b178a094c56"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@ef923f1b281cf25bc8fed129e0851b178a094c56",
"title": "ef923f1b281cf25bc8fed129e0851b178a094c56",
"url": "https://llvm.googlesource.com/llvm-project/+/ef923f1b281cf25bc8fed129e0851b178a094c56"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "997af95fac7b9069e8afa5bd208e02344fab8ce3"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@997af95fac7b9069e8afa5bd208e02344fab8ce3",
"title": "997af95fac7b9069e8afa5bd208e02344fab8ce3",
"url": "https://llvm.googlesource.com/llvm-project/+/997af95fac7b9069e8afa5bd208e02344fab8ce3"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "cab4c68a669df7856c9b0babf05709e10f89c7e2"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@cab4c68a669df7856c9b0babf05709e10f89c7e2",
"title": "cab4c68a669df7856c9b0babf05709e10f89c7e2",
"url": "https://llvm.googlesource.com/llvm-project/+/cab4c68a669df7856c9b0babf05709e10f89c7e2"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "bfae15a1257a63f205db12308ca4b131f3b3f3b3"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@bfae15a1257a63f205db12308ca4b131f3b3f3b3",
"title": "bfae15a1257a63f205db12308ca4b131f3b3f3b3",
"url": "https://llvm.googlesource.com/llvm-project/+/bfae15a1257a63f205db12308ca4b131f3b3f3b3"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "29969c988bb9004d201e7e6280e193cbcf7aacc8"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@29969c988bb9004d201e7e6280e193cbcf7aacc8",
"title": "29969c988bb9004d201e7e6280e193cbcf7aacc8",
"url": "https://llvm.googlesource.com/llvm-project/+/29969c988bb9004d201e7e6280e193cbcf7aacc8"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "301fa24671256734df6b7ee65f23ad885400108e"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@301fa24671256734df6b7ee65f23ad885400108e",
"title": "301fa24671256734df6b7ee65f23ad885400108e",
"url": "https://llvm.googlesource.com/llvm-project/+/301fa24671256734df6b7ee65f23ad885400108e"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "9470c2e152c6917b8950d2d506b0a4505723011a"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@9470c2e152c6917b8950d2d506b0a4505723011a",
"title": "9470c2e152c6917b8950d2d506b0a4505723011a",
"url": "https://llvm.googlesource.com/llvm-project/+/9470c2e152c6917b8950d2d506b0a4505723011a"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "d12ab4434cd84667a25cee6e7eddedc0ac7e4371"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@d12ab4434cd84667a25cee6e7eddedc0ac7e4371",
"title": "d12ab4434cd84667a25cee6e7eddedc0ac7e4371",
"url": "https://llvm.googlesource.com/llvm-project/+/d12ab4434cd84667a25cee6e7eddedc0ac7e4371"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "475a1c5882305357ec432c93c496fed7c8e1fcdf"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@475a1c5882305357ec432c93c496fed7c8e1fcdf",
"title": "475a1c5882305357ec432c93c496fed7c8e1fcdf",
"url": "https://llvm.googlesource.com/llvm-project/+/475a1c5882305357ec432c93c496fed7c8e1fcdf"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "09cf301384ce29312347c608db4871f21af753fc"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@09cf301384ce29312347c608db4871f21af753fc",
"title": "09cf301384ce29312347c608db4871f21af753fc",
"url": "https://llvm.googlesource.com/llvm-project/+/09cf301384ce29312347c608db4871f21af753fc"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "6dd78f6aefdb76ce7c82ea69813f8e92481737cd"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@6dd78f6aefdb76ce7c82ea69813f8e92481737cd",
"title": "6dd78f6aefdb76ce7c82ea69813f8e92481737cd",
"url": "https://llvm.googlesource.com/llvm-project/+/6dd78f6aefdb76ce7c82ea69813f8e92481737cd"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "7d0ce4840c1f2850de905b06d957a6dcd99c2825"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@7d0ce4840c1f2850de905b06d957a6dcd99c2825",
"title": "7d0ce4840c1f2850de905b06d957a6dcd99c2825",
"url": "https://llvm.googlesource.com/llvm-project/+/7d0ce4840c1f2850de905b06d957a6dcd99c2825"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "0e8781100357b46c9ec6cd2e31a635ad2b2b3211"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@0e8781100357b46c9ec6cd2e31a635ad2b2b3211",
"title": "0e8781100357b46c9ec6cd2e31a635ad2b2b3211",
"url": "https://llvm.googlesource.com/llvm-project/+/0e8781100357b46c9ec6cd2e31a635ad2b2b3211"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "cea8ffa5f3412a58adc5c9c4b0ad0e31869f6e3d"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@cea8ffa5f3412a58adc5c9c4b0ad0e31869f6e3d",
"title": "cea8ffa5f3412a58adc5c9c4b0ad0e31869f6e3d",
"url": "https://llvm.googlesource.com/llvm-project/+/cea8ffa5f3412a58adc5c9c4b0ad0e31869f6e3d"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "169626f11ab19a0b33fba2ca84cf4d9ec2b76fb1"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@169626f11ab19a0b33fba2ca84cf4d9ec2b76fb1",
"title": "169626f11ab19a0b33fba2ca84cf4d9ec2b76fb1",
"url": "https://llvm.googlesource.com/llvm-project/+/169626f11ab19a0b33fba2ca84cf4d9ec2b76fb1"
}
]
}
},
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "169626f11ab19a0b33fba2ca84cf4d9ec2b76fb1",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8865604238745550048"
},
{
"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"
}
}
[00:06:01.822] Scheduled build:
{
"id": "8700174176810611633",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-windows-x64"
},
"createdBy": "project:fuchsia",
"createTime": "2025-10-24T00:06:01.522887616Z",
"updateTime": "2025-10-24T00:06:01.522887616Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "169626f11ab19a0b33fba2ca84cf4d9ec2b76fb1",
"ref": "refs/heads/main"
}
}
}
[00:06:01.822] Task URL: https://cr-buildbucket.appspot.com/build/8700174176810611633
[00:06:01.822] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8865604238745550048:2:0) after 4m24s
[00:06:02.832] Received PubSub notification, asking Buildbucket for the build status
[00:06:02.903] Build status: SCHEDULED
[00:06:05.214] Received PubSub notification, asking Buildbucket for the build status
[00:06:05.238] Build status: STARTED
[00:10:25.888] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8865604238745550048:2:0)
[00:10:25.918] Build status: STARTED
[00:10:25.918] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8865604238745550048:5:0) after 1m51s
[00:12:16.930] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8865604238745550048:5:0)
[00:12:16.948] Build status: STARTED
[00:12:16.948] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8865604238745550048:6:0) after 3m48s
[00:16:05.014] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8865604238745550048:6:0)
[00:16:05.088] Build status: STARTED
[00:16:05.088] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8865604238745550048:7:0) after 6m10s
[00:22:15.125] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8865604238745550048:7:0)
[00:22:15.188] Build status: STARTED
[00:22:15.188] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8865604238745550048:8:0) after 1m48s
[00:24:03.207] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8865604238745550048:8:0)
[00:24:03.262] Build status: STARTED
[00:24:03.262] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8865604238745550048:9:0) after 4m32s
[00:28:35.279] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8865604238745550048:9:0)
[00:28:35.319] Build status: STARTED
[00:28:35.319] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8865604238745550048:10:0) after 5m13s
[00:33:48.333] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8865604238745550048:10:0)
[00:33:48.388] Build status: STARTED
[00:33:48.388] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8865604238745550048:11:0) after 1m10s
[00:34:58.400] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8865604238745550048:11:0)
[00:34:58.434] Build status: STARTED
[00:34:58.434] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8865604238745550048:12:0) after 4m23s
[00:39:21.445] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8865604238745550048:12:0)
[00:39:21.473] Build status: STARTED
[00:39:21.473] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8865604238745550048:13:0) after 3m22s
[00:42:43.587] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8865604238745550048:13:0)
[00:42:43.612] Build status: STARTED
[00:42:43.612] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8865604238745550048:14:0) after 9m32s
[00:52:15.839] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8865604238745550048:14:0)
[00:52:15.858] Build status: STARTED
[00:52:15.858] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8865604238745550048:15:0) after 2m39s
[00:54:54.925] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8865604238745550048:15:0)
[00:54:54.944] Build status: STARTED
[00:54:54.944] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8865604238745550048:16:0) after 3m2s
[00:57:57.047] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8865604238745550048:16:0)
[00:57:57.096] Build status: STARTED
[00:57:57.096] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8865604238745550048:17:0) after 7m28s
[01:05:25.161] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8865604238745550048:17:0)
[01:05:25.194] Build status: STARTED
[01:05:25.194] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8865604238745550048:18:0) after 4m23s
[01:09:48.274] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8865604238745550048:18:0)
[01:09:48.356] Build status: STARTED
[01:09:48.356] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8865604238745550048:19:0) after 9m57s
[01:19:45.371] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8865604238745550048:19:0)
[01:19:45.426] Build status: STARTED
[01:19:45.426] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8865604238745550048:20:0) after 5m16s
[01:25:01.482] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8865604238745550048:20:0)
[01:25:01.825] Build status: STARTED
[01:25:01.825] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8865604238745550048:21:0) after 4m25s
[01:29:26.874] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8865604238745550048:21:0)
[01:29:26.897] Build status: STARTED
[01:29:26.897] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8865604238745550048:22:0) after 6m23s
[01:35:32.714] Received PubSub notification, asking Buildbucket for the build status
[01:35:32.731] Build:
{
"id": "8700174176810611633",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-windows-x64"
},
"createdBy": "project:fuchsia",
"createTime": "2025-10-24T00:06:01.522887616Z",
"startTime": "2025-10-24T00:06:04.935371516Z",
"endTime": "2025-10-24T01:35:32.328945704Z",
"updateTime": "2025-10-24T01:35:32.328945704Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "169626f11ab19a0b33fba2ca84cf4d9ec2b76fb1",
"ref": "refs/heads/main"
}
}
}
[01:35:32.731] Invocation finished in 1h29m32.43801867s with status SUCCEEDED