[18:08:49.994] New invocation is queued and will start shortly
[18:08:51.029] Starting the invocation (attempt 1)
[18:08:51.053] Popped buildset tag "buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/6aa9d928a86019ab8997fa9fb7c5533a67ed1a8d"
[18:08:51.053] Popped gitiles commit info from properties and tags
[18:08:51.053] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[18:08:51.054] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[18:08:51.054] Buildbucket request:
{
"requestId": "8870156558378019136",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-windows-x64"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8870156558378019136",
"job": "fuchsia/toolchain.ci-clang-windows-x64-40be1bb5",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "303bea8e6350bb2ff0c29d4aaf9621569918d836"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@303bea8e6350bb2ff0c29d4aaf9621569918d836",
"title": "303bea8e6350bb2ff0c29d4aaf9621569918d836",
"url": "https://llvm.googlesource.com/llvm-project/+/303bea8e6350bb2ff0c29d4aaf9621569918d836"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "c5a141bb8b5dfc4be06bb165d88e724e66bf5c4c"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@c5a141bb8b5dfc4be06bb165d88e724e66bf5c4c",
"title": "c5a141bb8b5dfc4be06bb165d88e724e66bf5c4c",
"url": "https://llvm.googlesource.com/llvm-project/+/c5a141bb8b5dfc4be06bb165d88e724e66bf5c4c"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "96b1dfb57fc822ea69bf75a8f0a69eb168776faa"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@96b1dfb57fc822ea69bf75a8f0a69eb168776faa",
"title": "96b1dfb57fc822ea69bf75a8f0a69eb168776faa",
"url": "https://llvm.googlesource.com/llvm-project/+/96b1dfb57fc822ea69bf75a8f0a69eb168776faa"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "f5006e043143717e2e8ade9a009e1209b4a3563b"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@f5006e043143717e2e8ade9a009e1209b4a3563b",
"title": "f5006e043143717e2e8ade9a009e1209b4a3563b",
"url": "https://llvm.googlesource.com/llvm-project/+/f5006e043143717e2e8ade9a009e1209b4a3563b"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "714f6b03bc89bff766ae628092cd059fd8aa0aa1"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@714f6b03bc89bff766ae628092cd059fd8aa0aa1",
"title": "714f6b03bc89bff766ae628092cd059fd8aa0aa1",
"url": "https://llvm.googlesource.com/llvm-project/+/714f6b03bc89bff766ae628092cd059fd8aa0aa1"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "4829dedfa9bb3d1e15aaa88cf1ff329c7b0e59de"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@4829dedfa9bb3d1e15aaa88cf1ff329c7b0e59de",
"title": "4829dedfa9bb3d1e15aaa88cf1ff329c7b0e59de",
"url": "https://llvm.googlesource.com/llvm-project/+/4829dedfa9bb3d1e15aaa88cf1ff329c7b0e59de"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "c93e2de67f3d4fb558edf9b69fd824b1fb9d29c2"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@c93e2de67f3d4fb558edf9b69fd824b1fb9d29c2",
"title": "c93e2de67f3d4fb558edf9b69fd824b1fb9d29c2",
"url": "https://llvm.googlesource.com/llvm-project/+/c93e2de67f3d4fb558edf9b69fd824b1fb9d29c2"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "b176ba78c8ded98cca955d4d32234fac8ada506c"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@b176ba78c8ded98cca955d4d32234fac8ada506c",
"title": "b176ba78c8ded98cca955d4d32234fac8ada506c",
"url": "https://llvm.googlesource.com/llvm-project/+/b176ba78c8ded98cca955d4d32234fac8ada506c"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "4d72bb381bf2aff8aa84c0b70d8384b6fdf98d1d"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@4d72bb381bf2aff8aa84c0b70d8384b6fdf98d1d",
"title": "4d72bb381bf2aff8aa84c0b70d8384b6fdf98d1d",
"url": "https://llvm.googlesource.com/llvm-project/+/4d72bb381bf2aff8aa84c0b70d8384b6fdf98d1d"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "adc0a2caff44e3884ce3189932fa0e9c8a28620d"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@adc0a2caff44e3884ce3189932fa0e9c8a28620d",
"title": "adc0a2caff44e3884ce3189932fa0e9c8a28620d",
"url": "https://llvm.googlesource.com/llvm-project/+/adc0a2caff44e3884ce3189932fa0e9c8a28620d"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "722339dc0927545834afffd8aca9a75efd450ca9"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@722339dc0927545834afffd8aca9a75efd450ca9",
"title": "722339dc0927545834afffd8aca9a75efd450ca9",
"url": "https://llvm.googlesource.com/llvm-project/+/722339dc0927545834afffd8aca9a75efd450ca9"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "878fa7b2686a8776d1f36a5bb516c95a07838825"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@878fa7b2686a8776d1f36a5bb516c95a07838825",
"title": "878fa7b2686a8776d1f36a5bb516c95a07838825",
"url": "https://llvm.googlesource.com/llvm-project/+/878fa7b2686a8776d1f36a5bb516c95a07838825"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "ded5f433dedf4a3419548929ac3dfa826e11d2e1"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@ded5f433dedf4a3419548929ac3dfa826e11d2e1",
"title": "ded5f433dedf4a3419548929ac3dfa826e11d2e1",
"url": "https://llvm.googlesource.com/llvm-project/+/ded5f433dedf4a3419548929ac3dfa826e11d2e1"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "6aa9d928a86019ab8997fa9fb7c5533a67ed1a8d"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@6aa9d928a86019ab8997fa9fb7c5533a67ed1a8d",
"title": "6aa9d928a86019ab8997fa9fb7c5533a67ed1a8d",
"url": "https://llvm.googlesource.com/llvm-project/+/6aa9d928a86019ab8997fa9fb7c5533a67ed1a8d"
}
]
}
},
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "6aa9d928a86019ab8997fa9fb7c5533a67ed1a8d",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8870156558378019136"
},
{
"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"
}
}
[18:08:51.585] Scheduled build:
{
"id": "8704726496548999569",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-windows-x64"
},
"createdBy": "project:fuchsia",
"createTime": "2025-09-03T18:08:51.108780188Z",
"updateTime": "2025-09-03T18:08:51.108780188Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "6aa9d928a86019ab8997fa9fb7c5533a67ed1a8d",
"ref": "refs/heads/main"
}
}
}
[18:08:51.585] Task URL: https://cr-buildbucket.appspot.com/build/8704726496548999569
[18:08:51.585] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8870156558378019136:2:0) after 9m24s
[18:08:52.445] Received PubSub notification, asking Buildbucket for the build status
[18:08:52.474] Build status: SCHEDULED
[18:08:54.742] Received PubSub notification, asking Buildbucket for the build status
[18:08:54.764] Build status: STARTED
[18:18:15.656] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8870156558378019136:2:0)
[18:18:15.683] Build status: STARTED
[18:18:15.683] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8870156558378019136:5:0) after 3m35s
[18:21:50.712] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8870156558378019136:5:0)
[18:21:50.781] Build status: STARTED
[18:21:50.781] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8870156558378019136:6:0) after 8m11s
[18:30:01.812] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8870156558378019136:6:0)
[18:30:01.876] Build status: STARTED
[18:30:01.876] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8870156558378019136:7:0) after 3m32s
[18:33:33.950] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8870156558378019136:7:0)
[18:33:33.967] Build status: STARTED
[18:33:33.967] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8870156558378019136:8:0) after 7m50s
[18:41:24.064] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8870156558378019136:8:0)
[18:41:24.095] Build status: STARTED
[18:41:24.095] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8870156558378019136:9:0) after 3m38s
[18:45:02.146] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8870156558378019136:9:0)
[18:45:02.221] Build status: STARTED
[18:45:02.221] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8870156558378019136:10:0) after 2m4s
[18:47:06.304] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8870156558378019136:10:0)
[18:47:06.329] Build status: STARTED
[18:47:06.329] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8870156558378019136:11:0) after 7m49s
[18:54:55.345] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8870156558378019136:11:0)
[18:54:55.363] Build status: STARTED
[18:54:55.363] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8870156558378019136:12:0) after 2m31s
[18:57:26.385] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8870156558378019136:12:0)
[18:57:26.403] Build status: STARTED
[18:57:26.403] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8870156558378019136:13:0) after 6m4s
[19:03:30.531] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8870156558378019136:13:0)
[19:03:30.547] Build status: STARTED
[19:03:30.547] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8870156558378019136:14:0) after 3m33s
[19:07:03.600] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8870156558378019136:14:0)
[19:07:03.630] Build status: STARTED
[19:07:03.630] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8870156558378019136:15:0) after 2m7s
[19:09:10.662] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8870156558378019136:15:0)
[19:09:10.683] Build status: STARTED
[19:09:10.683] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8870156558378019136:16:0) after 5m37s
[19:14:47.703] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8870156558378019136:16:0)
[19:14:47.721] Build status: STARTED
[19:14:47.721] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8870156558378019136:17:0) after 4m33s
[19:19:20.745] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8870156558378019136:17:0)
[19:19:20.762] Build status: STARTED
[19:19:20.762] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8870156558378019136:18:0) after 4m52s
[19:24:12.784] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8870156558378019136:18:0)
[19:24:12.802] Build status: STARTED
[19:24:12.802] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8870156558378019136:19:0) after 3m7s
[19:27:19.827] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8870156558378019136:19:0)
[19:27:19.849] Build status: STARTED
[19:27:19.849] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8870156558378019136:20:0) after 1m21s
[19:28:41.025] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8870156558378019136:20:0)
[19:28:41.126] Build status: STARTED
[19:28:41.127] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8870156558378019136:21:0) after 3m2s
[19:31:43.257] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8870156558378019136:21:0)
[19:31:43.275] Build status: STARTED
[19:31:43.275] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8870156558378019136:22:0) after 4m24s
[19:36:07.328] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8870156558378019136:22:0)
[19:36:07.345] Build status: STARTED
[19:36:07.346] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8870156558378019136:23:0) after 3m23s
[19:39:04.126] Received PubSub notification, asking Buildbucket for the build status
[19:39:04.151] Build:
{
"id": "8704726496548999569",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-windows-x64"
},
"createdBy": "project:fuchsia",
"createTime": "2025-09-03T18:08:51.108780188Z",
"startTime": "2025-09-03T18:08:54.535925887Z",
"endTime": "2025-09-03T19:39:03.792981215Z",
"updateTime": "2025-09-03T19:39:03.792981215Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "6aa9d928a86019ab8997fa9fb7c5533a67ed1a8d",
"ref": "refs/heads/main"
}
}
}
[19:39:04.151] Invocation finished in 1h30m14.171502544s with status SUCCEEDED