[19:00:47.260] New invocation is queued and will start shortly
[19:00:48.335] Starting the invocation (attempt 1)
[19:00:48.367] Popped buildset tag "buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/667efaee701ae5345f4cde42f8b3e5b7f98549ee"
[19:00:48.367] Popped gitiles commit info from properties and tags
[19:00:48.367] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[19:00:48.367] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[19:00:48.367] Buildbucket request:
{
"requestId": "8836179427287881744",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-windows-x64"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8836179427287881744",
"job": "fuchsia/toolchain.ci-clang-windows-x64-40be1bb5",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "85f694b3eeafc07e5c586fa15715facefba71094"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@85f694b3eeafc07e5c586fa15715facefba71094",
"title": "85f694b3eeafc07e5c586fa15715facefba71094",
"url": "https://llvm.googlesource.com/llvm-project/+/85f694b3eeafc07e5c586fa15715facefba71094"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "4098f568c46e06b6df470111868b4c165dd80f4d"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@4098f568c46e06b6df470111868b4c165dd80f4d",
"title": "4098f568c46e06b6df470111868b4c165dd80f4d",
"url": "https://llvm.googlesource.com/llvm-project/+/4098f568c46e06b6df470111868b4c165dd80f4d"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "b7877e01cb1087d81fd72eb320c3c7d3f8e03500"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@b7877e01cb1087d81fd72eb320c3c7d3f8e03500",
"title": "b7877e01cb1087d81fd72eb320c3c7d3f8e03500",
"url": "https://llvm.googlesource.com/llvm-project/+/b7877e01cb1087d81fd72eb320c3c7d3f8e03500"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "914e15cd29f78e01e15378cfccff97d42e6e9e82"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@914e15cd29f78e01e15378cfccff97d42e6e9e82",
"title": "914e15cd29f78e01e15378cfccff97d42e6e9e82",
"url": "https://llvm.googlesource.com/llvm-project/+/914e15cd29f78e01e15378cfccff97d42e6e9e82"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "d44791d35a4b15f3da7855790203ca14f7953410"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@d44791d35a4b15f3da7855790203ca14f7953410",
"title": "d44791d35a4b15f3da7855790203ca14f7953410",
"url": "https://llvm.googlesource.com/llvm-project/+/d44791d35a4b15f3da7855790203ca14f7953410"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "cba24d6a935382154b0487d09c1d91a0e2bda04b"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@cba24d6a935382154b0487d09c1d91a0e2bda04b",
"title": "cba24d6a935382154b0487d09c1d91a0e2bda04b",
"url": "https://llvm.googlesource.com/llvm-project/+/cba24d6a935382154b0487d09c1d91a0e2bda04b"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "8e23b6dfccb42a599e82c6a6c1a13bfb0a546c9e"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@8e23b6dfccb42a599e82c6a6c1a13bfb0a546c9e",
"title": "8e23b6dfccb42a599e82c6a6c1a13bfb0a546c9e",
"url": "https://llvm.googlesource.com/llvm-project/+/8e23b6dfccb42a599e82c6a6c1a13bfb0a546c9e"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "86858de86cb28299ebc9c0ce8a06e5a61ed6b261"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@86858de86cb28299ebc9c0ce8a06e5a61ed6b261",
"title": "86858de86cb28299ebc9c0ce8a06e5a61ed6b261",
"url": "https://llvm.googlesource.com/llvm-project/+/86858de86cb28299ebc9c0ce8a06e5a61ed6b261"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "667efaee701ae5345f4cde42f8b3e5b7f98549ee"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@667efaee701ae5345f4cde42f8b3e5b7f98549ee",
"title": "667efaee701ae5345f4cde42f8b3e5b7f98549ee",
"url": "https://llvm.googlesource.com/llvm-project/+/667efaee701ae5345f4cde42f8b3e5b7f98549ee"
}
]
}
},
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "667efaee701ae5345f4cde42f8b3e5b7f98549ee",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8836179427287881744"
},
{
"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"
}
}
[19:00:48.847] Scheduled build:
{
"id": "8670749365321586945",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-windows-x64"
},
"createdBy": "project:fuchsia",
"createTime": "2026-09-13T19:00:48.505722800Z",
"updateTime": "2026-09-13T19:00:48.505722800Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "667efaee701ae5345f4cde42f8b3e5b7f98549ee",
"ref": "refs/heads/main"
}
}
}
[19:00:48.847] Task URL: https://cr-buildbucket.appspot.com/build/8670749365321586945
[19:00:48.847] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8836179427287881744:2:0) after 6m23s
[19:00:49.107] Received PubSub notification, asking Buildbucket for the build status
[19:00:49.166] Build status: SCHEDULED
[19:00:52.589] Received PubSub notification, asking Buildbucket for the build status
[19:00:52.608] Build status: STARTED
[19:07:11.862] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8836179427287881744:2:0)
[19:07:12.001] Build status: STARTED
[19:07:12.001] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8836179427287881744:5:0) after 9m20s
[19:16:32.021] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8836179427287881744:5:0)
[19:16:32.166] Build status: STARTED
[19:16:32.166] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8836179427287881744:6:0) after 2m15s
[19:18:47.181] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8836179427287881744:6:0)
[19:18:47.199] Build status: STARTED
[19:18:47.199] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8836179427287881744:7:0) after 1m30s
[19:20:17.313] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8836179427287881744:7:0)
[19:20:17.337] Build status: STARTED
[19:20:17.337] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8836179427287881744:8:0) after 9m0s
[19:29:17.355] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8836179427287881744:8:0)
[19:29:17.377] Build status: STARTED
[19:29:17.377] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8836179427287881744:9:0) after 1m45s
[19:31:02.499] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8836179427287881744:9:0)
[19:31:02.536] Build status: STARTED
[19:31:02.536] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8836179427287881744:10:0) after 6m6s
[19:37:08.785] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8836179427287881744:10:0)
[19:37:08.916] Build status: STARTED
[19:37:08.916] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8836179427287881744:11:0) after 1m21s
[19:38:29.988] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8836179427287881744:11:0)
[19:38:30.019] Build status: STARTED
[19:38:30.019] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8836179427287881744:12:0) after 4m41s
[19:43:11.036] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8836179427287881744:12:0)
[19:43:11.055] Build status: STARTED
[19:43:11.055] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8836179427287881744:13:0) after 1m2s
[19:44:13.107] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8836179427287881744:13:0)
[19:44:13.133] Build status: STARTED
[19:44:13.133] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8836179427287881744:14:0) after 8m30s
[19:52:43.231] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8836179427287881744:14:0)
[19:52:43.280] Build status: STARTED
[19:52:43.280] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8836179427287881744:15:0) after 6m37s
[19:59:20.464] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8836179427287881744:15:0)
[19:59:20.531] Build status: STARTED
[19:59:20.531] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8836179427287881744:16:0) after 1m21s
[20:00:41.555] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8836179427287881744:16:0)
[20:00:41.583] Build status: STARTED
[20:00:41.583] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8836179427287881744:17:0) after 8m47s
[20:09:28.923] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8836179427287881744:17:0)
[20:09:28.943] Build status: STARTED
[20:09:28.943] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8836179427287881744:18:0) after 3m58s
[20:13:27.452] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8836179427287881744:18:0)
[20:13:27.471] Build status: STARTED
[20:13:27.471] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8836179427287881744:19:0) after 8m6s
[20:21:33.548] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8836179427287881744:19:0)
[20:21:33.607] Build status: STARTED
[20:21:33.607] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8836179427287881744:20:0) after 2m38s
[20:24:11.723] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8836179427287881744:20:0)
[20:24:11.744] Build status: STARTED
[20:24:11.744] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8836179427287881744:21:0) after 6m56s
[20:28:37.837] Received PubSub notification, asking Buildbucket for the build status
[20:28:37.862] Build:
{
"id": "8670749365321586945",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-windows-x64"
},
"createdBy": "project:fuchsia",
"createTime": "2026-09-13T19:00:48.505722800Z",
"startTime": "2026-09-13T19:00:52.342924909Z",
"endTime": "2026-09-13T20:28:35.510978763Z",
"updateTime": "2026-09-13T20:28:35.510978763Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "667efaee701ae5345f4cde42f8b3e5b7f98549ee",
"ref": "refs/heads/main"
}
}
}
[20:28:37.862] Invocation finished in 1h27m50.616792523s with status SUCCEEDED