[15:28:18.348] New invocation is queued and will start shortly
[15:28:20.086] Starting the invocation (attempt 1)
[15:28:20.113] Popped buildset tag "buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/b2d3db9bfb01ceb821b38dfc57f7965b09f602cf"
[15:28:20.114] Popped gitiles commit info from properties and tags
[15:28:20.114] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[15:28:20.114] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[15:28:20.114] Buildbucket request:
{
"requestId": "8841175628637541712",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-windows-x64"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8841175628637541712",
"job": "fuchsia/toolchain.ci-clang-windows-x64-40be1bb5",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "97a105f8e681e8e9e5778b6f8bf95a8c365a05f6"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@97a105f8e681e8e9e5778b6f8bf95a8c365a05f6",
"title": "97a105f8e681e8e9e5778b6f8bf95a8c365a05f6",
"url": "https://llvm.googlesource.com/llvm-project/+/97a105f8e681e8e9e5778b6f8bf95a8c365a05f6"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "e16e6077cbc2b0ab6335dd4dc67e3a6318b1ad3a"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@e16e6077cbc2b0ab6335dd4dc67e3a6318b1ad3a",
"title": "e16e6077cbc2b0ab6335dd4dc67e3a6318b1ad3a",
"url": "https://llvm.googlesource.com/llvm-project/+/e16e6077cbc2b0ab6335dd4dc67e3a6318b1ad3a"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "35aa7b529ebeafc9767a4c5398047a92b86bd4a8"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@35aa7b529ebeafc9767a4c5398047a92b86bd4a8",
"title": "35aa7b529ebeafc9767a4c5398047a92b86bd4a8",
"url": "https://llvm.googlesource.com/llvm-project/+/35aa7b529ebeafc9767a4c5398047a92b86bd4a8"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "b16c5f7cc88c9f41d904cc73d5618cc7453ac862"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@b16c5f7cc88c9f41d904cc73d5618cc7453ac862",
"title": "b16c5f7cc88c9f41d904cc73d5618cc7453ac862",
"url": "https://llvm.googlesource.com/llvm-project/+/b16c5f7cc88c9f41d904cc73d5618cc7453ac862"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "bb5c8d5bea4817a2447d9acfdb7ef11c4323ddac"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@bb5c8d5bea4817a2447d9acfdb7ef11c4323ddac",
"title": "bb5c8d5bea4817a2447d9acfdb7ef11c4323ddac",
"url": "https://llvm.googlesource.com/llvm-project/+/bb5c8d5bea4817a2447d9acfdb7ef11c4323ddac"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "1ed1ca59245bfa949919f31cef5fd5c87c20c6ec"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@1ed1ca59245bfa949919f31cef5fd5c87c20c6ec",
"title": "1ed1ca59245bfa949919f31cef5fd5c87c20c6ec",
"url": "https://llvm.googlesource.com/llvm-project/+/1ed1ca59245bfa949919f31cef5fd5c87c20c6ec"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "6998fd59e16026a00fee8e83243c0ec91047fee3"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@6998fd59e16026a00fee8e83243c0ec91047fee3",
"title": "6998fd59e16026a00fee8e83243c0ec91047fee3",
"url": "https://llvm.googlesource.com/llvm-project/+/6998fd59e16026a00fee8e83243c0ec91047fee3"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "6f744fb04cf1cf30b45ff73883566eeebb7eeb7d"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@6f744fb04cf1cf30b45ff73883566eeebb7eeb7d",
"title": "6f744fb04cf1cf30b45ff73883566eeebb7eeb7d",
"url": "https://llvm.googlesource.com/llvm-project/+/6f744fb04cf1cf30b45ff73883566eeebb7eeb7d"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "4c5b4f40c4ac77f1b50a90451fd040356748ac6a"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@4c5b4f40c4ac77f1b50a90451fd040356748ac6a",
"title": "4c5b4f40c4ac77f1b50a90451fd040356748ac6a",
"url": "https://llvm.googlesource.com/llvm-project/+/4c5b4f40c4ac77f1b50a90451fd040356748ac6a"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "2549a2c39b4b86b035df052948bd3f867728b075"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@2549a2c39b4b86b035df052948bd3f867728b075",
"title": "2549a2c39b4b86b035df052948bd3f867728b075",
"url": "https://llvm.googlesource.com/llvm-project/+/2549a2c39b4b86b035df052948bd3f867728b075"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "7bbed7999de1a60c790a3b0f01d965c18fd832e8"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@7bbed7999de1a60c790a3b0f01d965c18fd832e8",
"title": "7bbed7999de1a60c790a3b0f01d965c18fd832e8",
"url": "https://llvm.googlesource.com/llvm-project/+/7bbed7999de1a60c790a3b0f01d965c18fd832e8"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "b2d3db9bfb01ceb821b38dfc57f7965b09f602cf"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@b2d3db9bfb01ceb821b38dfc57f7965b09f602cf",
"title": "b2d3db9bfb01ceb821b38dfc57f7965b09f602cf",
"url": "https://llvm.googlesource.com/llvm-project/+/b2d3db9bfb01ceb821b38dfc57f7965b09f602cf"
}
]
}
},
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "b2d3db9bfb01ceb821b38dfc57f7965b09f602cf",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8841175628637541712"
},
{
"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:28:20.966] Scheduled build:
{
"id": "8675745566059651473",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-windows-x64"
},
"createdBy": "project:fuchsia",
"createTime": "2026-07-20T15:28:20.181602381Z",
"updateTime": "2026-07-20T15:28:20.181602381Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "b2d3db9bfb01ceb821b38dfc57f7965b09f602cf",
"ref": "refs/heads/main"
}
},
"canary": true
}
[15:28:20.966] Task URL: https://cr-buildbucket.appspot.com/build/8675745566059651473
[15:28:20.966] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8841175628637541712:2:0) after 5m22s
[15:28:21.984] Received PubSub notification, asking Buildbucket for the build status
[15:28:22.036] Build status: SCHEDULED
[15:28:25.998] Received PubSub notification, asking Buildbucket for the build status
[15:28:26.019] Build status: STARTED
[15:33:43.069] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8841175628637541712:2:0)
[15:33:43.091] Build status: STARTED
[15:33:43.091] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8841175628637541712:5:0) after 9m13s
[15:42:56.267] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8841175628637541712:5:0)
[15:42:56.297] Build status: STARTED
[15:42:56.297] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8841175628637541712:6:0) after 1m45s
[15:44:41.313] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8841175628637541712:6:0)
[15:44:41.339] Build status: STARTED
[15:44:41.339] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8841175628637541712:7:0) after 5m6s
[15:49:47.358] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8841175628637541712:7:0)
[15:49:47.381] Build status: STARTED
[15:49:47.381] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8841175628637541712:8:0) after 1m39s
[15:51:26.363] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8841175628637541712:8:0)
[15:51:26.384] Build status: STARTED
[15:51:26.384] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8841175628637541712:9:0) after 5m36s
[15:57:02.461] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8841175628637541712:9:0)
[15:57:02.479] Build status: STARTED
[15:57:02.479] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8841175628637541712:10:0) after 9m47s
[16:06:49.505] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8841175628637541712:10:0)
[16:06:49.523] Build status: STARTED
[16:06:49.523] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8841175628637541712:11:0) after 6m28s
[16:13:17.539] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8841175628637541712:11:0)
[16:13:17.557] Build status: STARTED
[16:13:17.557] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8841175628637541712:12:0) after 8m24s
[16:21:41.600] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8841175628637541712:12:0)
[16:21:41.622] Build status: STARTED
[16:21:41.622] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8841175628637541712:13:0) after 2m54s
[16:24:35.646] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8841175628637541712:13:0)
[16:24:35.684] Build status: STARTED
[16:24:35.684] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8841175628637541712:14:0) after 9m8s
[16:33:43.911] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8841175628637541712:14:0)
[16:33:43.936] Build status: STARTED
[16:33:43.936] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8841175628637541712:15:0) after 2m53s
[16:36:36.961] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8841175628637541712:15:0)
[16:36:37.000] Build status: STARTED
[16:36:37.000] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8841175628637541712:16:0) after 9m49s
[16:46:26.070] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8841175628637541712:16:0)
[16:46:26.098] Build status: STARTED
[16:46:26.098] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8841175628637541712:17:0) after 3m6s
[16:49:32.114] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8841175628637541712:17:0)
[16:49:32.133] Build status: STARTED
[16:49:32.133] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8841175628637541712:18:0) after 5m8s
[16:54:18.693] Received PubSub notification, asking Buildbucket for the build status
[16:54:18.715] Build:
{
"id": "8675745566059651473",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-windows-x64"
},
"createdBy": "project:fuchsia",
"createTime": "2026-07-20T15:28:20.181602381Z",
"startTime": "2026-07-20T15:28:25.492192461Z",
"endTime": "2026-07-20T16:54:17.869688621Z",
"updateTime": "2026-07-20T16:54:17.869688621Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "b2d3db9bfb01ceb821b38dfc57f7965b09f602cf",
"ref": "refs/heads/main"
}
},
"canary": true
}
[16:54:18.715] Invocation finished in 1h26m0.375997811s with status SUCCEEDED