[15:00:34.724] New invocation is queued and will start shortly
[15:00:35.866] Starting the invocation (attempt 1)
[15:00:35.890] Popped buildset tag "buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/cff5a439a847db67ea3478b088ec2f8047871ff0"
[15:00:35.890] Popped gitiles commit info from properties and tags
[15:00:35.890] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[15:00:35.890] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[15:00:35.891] Buildbucket request:
{
"requestId": "8868356462993710384",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-windows-x64"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8868356462993710384",
"job": "fuchsia/toolchain.ci-clang-windows-x64-40be1bb5",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "d6140274f372b7ee8f657ded51519bbd44924f34"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@d6140274f372b7ee8f657ded51519bbd44924f34",
"title": "d6140274f372b7ee8f657ded51519bbd44924f34",
"url": "https://llvm.googlesource.com/llvm-project/+/d6140274f372b7ee8f657ded51519bbd44924f34"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "3ca59104cfe9c47ef64ce44491e7f0c1fbc9f788"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@3ca59104cfe9c47ef64ce44491e7f0c1fbc9f788",
"title": "3ca59104cfe9c47ef64ce44491e7f0c1fbc9f788",
"url": "https://llvm.googlesource.com/llvm-project/+/3ca59104cfe9c47ef64ce44491e7f0c1fbc9f788"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "154e0637c9b60108bda4e73645a3c9b9f62020c4"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@154e0637c9b60108bda4e73645a3c9b9f62020c4",
"title": "154e0637c9b60108bda4e73645a3c9b9f62020c4",
"url": "https://llvm.googlesource.com/llvm-project/+/154e0637c9b60108bda4e73645a3c9b9f62020c4"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "5ad347d1a1c1bdc716dafd07a395861529c0e595"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@5ad347d1a1c1bdc716dafd07a395861529c0e595",
"title": "5ad347d1a1c1bdc716dafd07a395861529c0e595",
"url": "https://llvm.googlesource.com/llvm-project/+/5ad347d1a1c1bdc716dafd07a395861529c0e595"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "05d032aea635398fe564520ba111165f9e1f4fc4"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@05d032aea635398fe564520ba111165f9e1f4fc4",
"title": "05d032aea635398fe564520ba111165f9e1f4fc4",
"url": "https://llvm.googlesource.com/llvm-project/+/05d032aea635398fe564520ba111165f9e1f4fc4"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "a04d3cab293087ec940127401a738820b2fa960b"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@a04d3cab293087ec940127401a738820b2fa960b",
"title": "a04d3cab293087ec940127401a738820b2fa960b",
"url": "https://llvm.googlesource.com/llvm-project/+/a04d3cab293087ec940127401a738820b2fa960b"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "79a0bf0efce50626595341e1eb01cee4328ad425"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@79a0bf0efce50626595341e1eb01cee4328ad425",
"title": "79a0bf0efce50626595341e1eb01cee4328ad425",
"url": "https://llvm.googlesource.com/llvm-project/+/79a0bf0efce50626595341e1eb01cee4328ad425"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "8f905c3e6f022ec6255d1e537eedcdbc029bf99d"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@8f905c3e6f022ec6255d1e537eedcdbc029bf99d",
"title": "8f905c3e6f022ec6255d1e537eedcdbc029bf99d",
"url": "https://llvm.googlesource.com/llvm-project/+/8f905c3e6f022ec6255d1e537eedcdbc029bf99d"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "5e23f8aa83a82e8ef81f013efc71484475bcfd94"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@5e23f8aa83a82e8ef81f013efc71484475bcfd94",
"title": "5e23f8aa83a82e8ef81f013efc71484475bcfd94",
"url": "https://llvm.googlesource.com/llvm-project/+/5e23f8aa83a82e8ef81f013efc71484475bcfd94"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "88bcb5818626c6a2314688e5fe78245e9b15fafd"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@88bcb5818626c6a2314688e5fe78245e9b15fafd",
"title": "88bcb5818626c6a2314688e5fe78245e9b15fafd",
"url": "https://llvm.googlesource.com/llvm-project/+/88bcb5818626c6a2314688e5fe78245e9b15fafd"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "1af2ddbbcfaf65c0fcf14235816055c5d1f93ef0"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@1af2ddbbcfaf65c0fcf14235816055c5d1f93ef0",
"title": "1af2ddbbcfaf65c0fcf14235816055c5d1f93ef0",
"url": "https://llvm.googlesource.com/llvm-project/+/1af2ddbbcfaf65c0fcf14235816055c5d1f93ef0"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "bcc1e75b957230b7462237334c4a04e6966bebd0"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@bcc1e75b957230b7462237334c4a04e6966bebd0",
"title": "bcc1e75b957230b7462237334c4a04e6966bebd0",
"url": "https://llvm.googlesource.com/llvm-project/+/bcc1e75b957230b7462237334c4a04e6966bebd0"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "c2dc2f8d98c476337230be6c14c30cd42c7b8df6"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@c2dc2f8d98c476337230be6c14c30cd42c7b8df6",
"title": "c2dc2f8d98c476337230be6c14c30cd42c7b8df6",
"url": "https://llvm.googlesource.com/llvm-project/+/c2dc2f8d98c476337230be6c14c30cd42c7b8df6"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "70bd610e43853d575e22be1cda46614fe9f0072f"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@70bd610e43853d575e22be1cda46614fe9f0072f",
"title": "70bd610e43853d575e22be1cda46614fe9f0072f",
"url": "https://llvm.googlesource.com/llvm-project/+/70bd610e43853d575e22be1cda46614fe9f0072f"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "113f01aa82d055410f22a9d03b3468fa68600589"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@113f01aa82d055410f22a9d03b3468fa68600589",
"title": "113f01aa82d055410f22a9d03b3468fa68600589",
"url": "https://llvm.googlesource.com/llvm-project/+/113f01aa82d055410f22a9d03b3468fa68600589"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "6007a4dbed2d8867c75bd571e1eb38e10ae14a27"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@6007a4dbed2d8867c75bd571e1eb38e10ae14a27",
"title": "6007a4dbed2d8867c75bd571e1eb38e10ae14a27",
"url": "https://llvm.googlesource.com/llvm-project/+/6007a4dbed2d8867c75bd571e1eb38e10ae14a27"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "ac62c4af29533e8101063f4ab7af66d0b4784d4d"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@ac62c4af29533e8101063f4ab7af66d0b4784d4d",
"title": "ac62c4af29533e8101063f4ab7af66d0b4784d4d",
"url": "https://llvm.googlesource.com/llvm-project/+/ac62c4af29533e8101063f4ab7af66d0b4784d4d"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "1d8568c96ce86be57aba88d5f23b06ba547ba224"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@1d8568c96ce86be57aba88d5f23b06ba547ba224",
"title": "1d8568c96ce86be57aba88d5f23b06ba547ba224",
"url": "https://llvm.googlesource.com/llvm-project/+/1d8568c96ce86be57aba88d5f23b06ba547ba224"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "cff5a439a847db67ea3478b088ec2f8047871ff0"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@cff5a439a847db67ea3478b088ec2f8047871ff0",
"title": "cff5a439a847db67ea3478b088ec2f8047871ff0",
"url": "https://llvm.googlesource.com/llvm-project/+/cff5a439a847db67ea3478b088ec2f8047871ff0"
}
]
}
},
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "cff5a439a847db67ea3478b088ec2f8047871ff0",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8868356462993710384"
},
{
"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:00:36.442] Scheduled build:
{
"id": "8702926400981474737",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-windows-x64"
},
"createdBy": "project:fuchsia",
"createTime": "2025-09-23T15:00:36.018507836Z",
"updateTime": "2025-09-23T15:00:36.018507836Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "cff5a439a847db67ea3478b088ec2f8047871ff0",
"ref": "refs/heads/main"
}
},
"canary": true
}
[15:00:36.442] Task URL: https://cr-buildbucket.appspot.com/build/8702926400981474737
[15:00:36.443] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8868356462993710384:2:0) after 2m59s
[15:00:36.748] Received PubSub notification, asking Buildbucket for the build status
[15:00:36.785] Build status: SCHEDULED
[15:00:39.786] Received PubSub notification, asking Buildbucket for the build status
[15:00:39.814] Build status: STARTED
[15:03:35.651] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8868356462993710384:2:0)
[15:03:35.680] Build status: STARTED
[15:03:35.680] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8868356462993710384:5:0) after 8m41s
[15:12:16.691] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8868356462993710384:5:0)
[15:12:16.727] Build status: STARTED
[15:12:16.727] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8868356462993710384:6:0) after 1m41s
[15:13:57.841] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8868356462993710384:6:0)
[15:13:57.914] Build status: STARTED
[15:13:57.914] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8868356462993710384:7:0) after 5m16s
[15:19:14.000] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8868356462993710384:7:0)
[15:19:14.033] Build status: STARTED
[15:19:14.033] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8868356462993710384:8:0) after 6m26s
[15:25:40.161] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8868356462993710384:8:0)
[15:25:40.178] Build status: STARTED
[15:25:40.178] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8868356462993710384:9:0) after 2m18s
[15:27:58.311] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8868356462993710384:9:0)
[15:27:58.340] Build status: STARTED
[15:27:58.340] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8868356462993710384:10:0) after 5m10s
[15:33:08.374] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8868356462993710384:10:0)
[15:33:08.392] Build status: STARTED
[15:33:08.392] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8868356462993710384:11:0) after 8m12s
[15:41:20.410] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8868356462993710384:11:0)
[15:41:20.462] Build status: STARTED
[15:41:20.462] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8868356462993710384:12:0) after 4m45s
[15:46:05.480] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8868356462993710384:12:0)
[15:46:05.536] Build status: STARTED
[15:46:05.536] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8868356462993710384:13:0) after 1m27s
[15:47:32.608] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8868356462993710384:13:0)
[15:47:32.629] Build status: STARTED
[15:47:32.629] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8868356462993710384:14:0) after 2m39s
[15:50:11.645] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8868356462993710384:14:0)
[15:50:11.708] Build status: STARTED
[15:50:11.708] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8868356462993710384:15:0) after 8m52s
[15:59:03.794] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8868356462993710384:15:0)
[15:59:03.822] Build status: STARTED
[15:59:03.822] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8868356462993710384:16:0) after 6m33s
[16:05:36.899] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8868356462993710384:16:0)
[16:05:36.916] Build status: STARTED
[16:05:36.916] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8868356462993710384:17:0) after 9m36s
[16:15:12.949] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8868356462993710384:17:0)
[16:15:12.992] Build status: STARTED
[16:15:12.992] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8868356462993710384:18:0) after 6m54s
[16:22:06.996] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8868356462993710384:18:0)
[16:22:07.019] Build status: STARTED
[16:22:07.019] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8868356462993710384:19:0) after 9m9s
[16:31:16.111] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8868356462993710384:19:0)
[16:31:16.903] Build status: STARTED
[16:31:16.903] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8868356462993710384:20:0) after 8m27s
[16:32:06.902] Received PubSub notification, asking Buildbucket for the build status
[16:32:06.959] Build:
{
"id": "8702926400981474737",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-windows-x64"
},
"createdBy": "project:fuchsia",
"createTime": "2025-09-23T15:00:36.018507836Z",
"startTime": "2025-09-23T15:00:39.567005215Z",
"endTime": "2025-09-23T16:32:06.487013559Z",
"updateTime": "2025-09-23T16:32:06.487013559Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "cff5a439a847db67ea3478b088ec2f8047871ff0",
"ref": "refs/heads/main"
}
},
"canary": true
}
[16:32:06.959] Invocation finished in 1h31m32.244136661s with status SUCCEEDED