[08:30:38.360] New invocation is queued and will start shortly
[08:30:39.551] Starting the invocation (attempt 1)
[08:30:39.579] Popped buildset tag "buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/d561259a083725cb9242f00cb14ae3a0ec1d2c7b"
[08:30:39.579] Popped gitiles commit info from properties and tags
[08:30:39.579] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[08:30:39.580] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[08:30:39.581] Buildbucket request:
{
"requestId": "8872820247218533184",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-windows-x64"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8872820247218533184",
"job": "fuchsia/toolchain.ci-clang-windows-x64-40be1bb5",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "e044cc50eec8b2875b047c242f7afa4bc47046fe"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@e044cc50eec8b2875b047c242f7afa4bc47046fe",
"title": "e044cc50eec8b2875b047c242f7afa4bc47046fe",
"url": "https://llvm.googlesource.com/llvm-project/+/e044cc50eec8b2875b047c242f7afa4bc47046fe"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "fcae1ba7757a9c7b4e65ff068e0cb854a9fa2edd"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@fcae1ba7757a9c7b4e65ff068e0cb854a9fa2edd",
"title": "fcae1ba7757a9c7b4e65ff068e0cb854a9fa2edd",
"url": "https://llvm.googlesource.com/llvm-project/+/fcae1ba7757a9c7b4e65ff068e0cb854a9fa2edd"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "fb632ed2377d280b581b8d4653b855e60d611f77"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@fb632ed2377d280b581b8d4653b855e60d611f77",
"title": "fb632ed2377d280b581b8d4653b855e60d611f77",
"url": "https://llvm.googlesource.com/llvm-project/+/fb632ed2377d280b581b8d4653b855e60d611f77"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "ba099c516daf4c5e77e3342803b1d91c9a0f9399"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@ba099c516daf4c5e77e3342803b1d91c9a0f9399",
"title": "ba099c516daf4c5e77e3342803b1d91c9a0f9399",
"url": "https://llvm.googlesource.com/llvm-project/+/ba099c516daf4c5e77e3342803b1d91c9a0f9399"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "6393a9edde6da41d0e927b34a6c9ba965289c6da"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@6393a9edde6da41d0e927b34a6c9ba965289c6da",
"title": "6393a9edde6da41d0e927b34a6c9ba965289c6da",
"url": "https://llvm.googlesource.com/llvm-project/+/6393a9edde6da41d0e927b34a6c9ba965289c6da"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "c233deb794b71260f012ac339574d51908b4fe26"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@c233deb794b71260f012ac339574d51908b4fe26",
"title": "c233deb794b71260f012ac339574d51908b4fe26",
"url": "https://llvm.googlesource.com/llvm-project/+/c233deb794b71260f012ac339574d51908b4fe26"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "0cf7377a1e6545821e3525b40a091575a3dfce61"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@0cf7377a1e6545821e3525b40a091575a3dfce61",
"title": "0cf7377a1e6545821e3525b40a091575a3dfce61",
"url": "https://llvm.googlesource.com/llvm-project/+/0cf7377a1e6545821e3525b40a091575a3dfce61"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "c5e6938c6710a1c34a32830c743f19a29ffef6e5"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@c5e6938c6710a1c34a32830c743f19a29ffef6e5",
"title": "c5e6938c6710a1c34a32830c743f19a29ffef6e5",
"url": "https://llvm.googlesource.com/llvm-project/+/c5e6938c6710a1c34a32830c743f19a29ffef6e5"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "87283db54852a899a52e4e01aa01b471ffa34a1d"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@87283db54852a899a52e4e01aa01b471ffa34a1d",
"title": "87283db54852a899a52e4e01aa01b471ffa34a1d",
"url": "https://llvm.googlesource.com/llvm-project/+/87283db54852a899a52e4e01aa01b471ffa34a1d"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "091c33b1f5d54201f8129b03f8cfc70aa94b053c"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@091c33b1f5d54201f8129b03f8cfc70aa94b053c",
"title": "091c33b1f5d54201f8129b03f8cfc70aa94b053c",
"url": "https://llvm.googlesource.com/llvm-project/+/091c33b1f5d54201f8129b03f8cfc70aa94b053c"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "1cac2be874c5f1b1b70bdaea8891f5e5b76a84e2"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@1cac2be874c5f1b1b70bdaea8891f5e5b76a84e2",
"title": "1cac2be874c5f1b1b70bdaea8891f5e5b76a84e2",
"url": "https://llvm.googlesource.com/llvm-project/+/1cac2be874c5f1b1b70bdaea8891f5e5b76a84e2"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "43ead215e4e519b99942b1bda9368681a1f13bea"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@43ead215e4e519b99942b1bda9368681a1f13bea",
"title": "43ead215e4e519b99942b1bda9368681a1f13bea",
"url": "https://llvm.googlesource.com/llvm-project/+/43ead215e4e519b99942b1bda9368681a1f13bea"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "00a648ab110583ed45cc931a0c1aabf4bfcd17e3"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@00a648ab110583ed45cc931a0c1aabf4bfcd17e3",
"title": "00a648ab110583ed45cc931a0c1aabf4bfcd17e3",
"url": "https://llvm.googlesource.com/llvm-project/+/00a648ab110583ed45cc931a0c1aabf4bfcd17e3"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "155359c1f2bda7fb8d4e8001157ecea03689df68"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@155359c1f2bda7fb8d4e8001157ecea03689df68",
"title": "155359c1f2bda7fb8d4e8001157ecea03689df68",
"url": "https://llvm.googlesource.com/llvm-project/+/155359c1f2bda7fb8d4e8001157ecea03689df68"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "76d98cfcc40e9a351efc52287338f0fd5d4402fb"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@76d98cfcc40e9a351efc52287338f0fd5d4402fb",
"title": "76d98cfcc40e9a351efc52287338f0fd5d4402fb",
"url": "https://llvm.googlesource.com/llvm-project/+/76d98cfcc40e9a351efc52287338f0fd5d4402fb"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "a53489606a4e704e5a7ac148e950eabfe21397cd"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@a53489606a4e704e5a7ac148e950eabfe21397cd",
"title": "a53489606a4e704e5a7ac148e950eabfe21397cd",
"url": "https://llvm.googlesource.com/llvm-project/+/a53489606a4e704e5a7ac148e950eabfe21397cd"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "d561259a083725cb9242f00cb14ae3a0ec1d2c7b"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@d561259a083725cb9242f00cb14ae3a0ec1d2c7b",
"title": "d561259a083725cb9242f00cb14ae3a0ec1d2c7b",
"url": "https://llvm.googlesource.com/llvm-project/+/d561259a083725cb9242f00cb14ae3a0ec1d2c7b"
}
]
}
},
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "d561259a083725cb9242f00cb14ae3a0ec1d2c7b",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8872820247218533184"
},
{
"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"
}
}
[08:30:39.975] Scheduled build:
{
"id": "8707390185201583233",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-windows-x64"
},
"createdBy": "project:fuchsia",
"createTime": "2025-08-05T08:30:39.653140381Z",
"updateTime": "2025-08-05T08:30:39.653140381Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "d561259a083725cb9242f00cb14ae3a0ec1d2c7b",
"ref": "refs/heads/main"
}
}
}
[08:30:39.975] Task URL: https://cr-buildbucket.appspot.com/build/8707390185201583233
[08:30:39.975] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8872820247218533184:2:0) after 1m17s
[08:30:40.116] Received PubSub notification, asking Buildbucket for the build status
[08:30:40.141] Build status: SCHEDULED
[08:30:45.293] Received PubSub notification, asking Buildbucket for the build status
[08:30:45.319] Build status: STARTED
[08:31:57.001] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8872820247218533184:2:0)
[08:31:57.024] Build status: STARTED
[08:31:57.024] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8872820247218533184:5:0) after 2m40s
[08:34:37.024] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8872820247218533184:5:0)
[08:34:37.049] Build status: STARTED
[08:34:37.049] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8872820247218533184:6:0) after 2m10s
[08:36:47.322] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8872820247218533184:6:0)
[08:36:47.341] Build status: STARTED
[08:36:47.341] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8872820247218533184:7:0) after 6m26s
[08:43:13.468] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8872820247218533184:7:0)
[08:43:13.502] Build status: STARTED
[08:43:13.502] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8872820247218533184:8:0) after 3m43s
[08:46:56.642] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8872820247218533184:8:0)
[08:46:56.659] Build status: STARTED
[08:46:56.659] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8872820247218533184:9:0) after 4m9s
[08:51:05.776] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8872820247218533184:9:0)
[08:51:05.798] Build status: STARTED
[08:51:05.798] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8872820247218533184:10:0) after 5m54s
[08:56:59.838] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8872820247218533184:10:0)
[08:56:59.859] Build status: STARTED
[08:56:59.859] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8872820247218533184:11:0) after 2m18s
[08:59:18.133] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8872820247218533184:11:0)
[08:59:18.151] Build status: STARTED
[08:59:18.151] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8872820247218533184:12:0) after 6m37s
[09:05:55.174] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8872820247218533184:12:0)
[09:05:55.205] Build status: STARTED
[09:05:55.205] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8872820247218533184:13:0) after 4m11s
[09:10:06.255] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8872820247218533184:13:0)
[09:10:06.316] Build status: STARTED
[09:10:06.316] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8872820247218533184:14:0) after 8m4s
[09:18:10.346] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8872820247218533184:14:0)
[09:18:10.373] Build status: STARTED
[09:18:10.373] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8872820247218533184:15:0) after 5m25s
[09:23:35.390] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8872820247218533184:15:0)
[09:23:35.407] Build status: STARTED
[09:23:35.407] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8872820247218533184:16:0) after 9m30s
[09:33:05.435] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8872820247218533184:16:0)
[09:33:05.455] Build status: STARTED
[09:33:05.455] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8872820247218533184:17:0) after 5m44s
[09:38:49.546] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8872820247218533184:17:0)
[09:38:49.793] Build status: STARTED
[09:38:49.793] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8872820247218533184:18:0) after 2m22s
[09:41:12.164] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8872820247218533184:18:0)
[09:41:12.181] Build status: STARTED
[09:41:12.181] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8872820247218533184:19:0) after 5m58s
[09:47:10.207] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8872820247218533184:19:0)
[09:47:10.226] Build status: STARTED
[09:47:10.226] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8872820247218533184:20:0) after 3m19s
[09:50:29.253] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8872820247218533184:20:0)
[09:50:29.270] Build status: STARTED
[09:50:29.270] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8872820247218533184:21:0) after 4m19s
[09:54:48.289] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8872820247218533184:21:0)
[09:54:48.324] Build status: STARTED
[09:54:48.324] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8872820247218533184:22:0) after 7m58s
[10:00:56.698] Received PubSub notification, asking Buildbucket for the build status
[10:00:56.716] Build:
{
"id": "8707390185201583233",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-windows-x64"
},
"createdBy": "project:fuchsia",
"createTime": "2025-08-05T08:30:39.653140381Z",
"startTime": "2025-08-05T08:30:45.094362045Z",
"endTime": "2025-08-05T10:00:55.850992134Z",
"updateTime": "2025-08-05T10:00:55.850992134Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "d561259a083725cb9242f00cb14ae3a0ec1d2c7b",
"ref": "refs/heads/main"
}
}
}
[10:00:56.716] Invocation finished in 1h30m18.370834003s with status SUCCEEDED