[09:20:52.989] New invocation is queued and will start shortly
[09:20:54.233] Starting the invocation (attempt 1)
[09:20:54.263] Popped buildset tag "buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/78f690bba7846d3e9795bc27a5e27627a4a1ea28"
[09:20:54.263] Popped gitiles commit info from properties and tags
[09:20:54.263] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[09:20:54.263] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[09:20:54.263] Buildbucket request:
{
"requestId": "8889124540093760272",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-windows-x64"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8889124540093760272",
"job": "fuchsia/toolchain.ci-clang-windows-x64-40be1bb5",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "6e402f5121e87e82fa686046c867ef67d4b4b851"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@6e402f5121e87e82fa686046c867ef67d4b4b851",
"title": "6e402f5121e87e82fa686046c867ef67d4b4b851",
"url": "https://llvm.googlesource.com/llvm-project/+/6e402f5121e87e82fa686046c867ef67d4b4b851"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "feb5a77d700f46d6638f073d411cbe0d8a924fdf"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@feb5a77d700f46d6638f073d411cbe0d8a924fdf",
"title": "feb5a77d700f46d6638f073d411cbe0d8a924fdf",
"url": "https://llvm.googlesource.com/llvm-project/+/feb5a77d700f46d6638f073d411cbe0d8a924fdf"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "0cfb98f871b6bc82691b5aa85b20703de1621875"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@0cfb98f871b6bc82691b5aa85b20703de1621875",
"title": "0cfb98f871b6bc82691b5aa85b20703de1621875",
"url": "https://llvm.googlesource.com/llvm-project/+/0cfb98f871b6bc82691b5aa85b20703de1621875"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "3115278c4e079c7ba85dc4233100de68ca5f711b"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@3115278c4e079c7ba85dc4233100de68ca5f711b",
"title": "3115278c4e079c7ba85dc4233100de68ca5f711b",
"url": "https://llvm.googlesource.com/llvm-project/+/3115278c4e079c7ba85dc4233100de68ca5f711b"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "f82902fef4a004a7f26d49448e66b2dbeed4d692"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@f82902fef4a004a7f26d49448e66b2dbeed4d692",
"title": "f82902fef4a004a7f26d49448e66b2dbeed4d692",
"url": "https://llvm.googlesource.com/llvm-project/+/f82902fef4a004a7f26d49448e66b2dbeed4d692"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "4562efc674a5b5e052abdfc40047e82a359d0df0"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@4562efc674a5b5e052abdfc40047e82a359d0df0",
"title": "4562efc674a5b5e052abdfc40047e82a359d0df0",
"url": "https://llvm.googlesource.com/llvm-project/+/4562efc674a5b5e052abdfc40047e82a359d0df0"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "c7dc836bbe3658a9210a944b850450f5ae7b50a4"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@c7dc836bbe3658a9210a944b850450f5ae7b50a4",
"title": "c7dc836bbe3658a9210a944b850450f5ae7b50a4",
"url": "https://llvm.googlesource.com/llvm-project/+/c7dc836bbe3658a9210a944b850450f5ae7b50a4"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "5eed019080a53af5a5be915a5cf411466b77bf4b"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@5eed019080a53af5a5be915a5cf411466b77bf4b",
"title": "5eed019080a53af5a5be915a5cf411466b77bf4b",
"url": "https://llvm.googlesource.com/llvm-project/+/5eed019080a53af5a5be915a5cf411466b77bf4b"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "eb8901bda11fd55deeecd067fc4c9dcc0fb89984"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@eb8901bda11fd55deeecd067fc4c9dcc0fb89984",
"title": "eb8901bda11fd55deeecd067fc4c9dcc0fb89984",
"url": "https://llvm.googlesource.com/llvm-project/+/eb8901bda11fd55deeecd067fc4c9dcc0fb89984"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "a6abd0a13d2748977dd1409a34948cd392a1cb21"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@a6abd0a13d2748977dd1409a34948cd392a1cb21",
"title": "a6abd0a13d2748977dd1409a34948cd392a1cb21",
"url": "https://llvm.googlesource.com/llvm-project/+/a6abd0a13d2748977dd1409a34948cd392a1cb21"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "df22bbe2beb57687c76402bc0cfdf7901a31cf29"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@df22bbe2beb57687c76402bc0cfdf7901a31cf29",
"title": "df22bbe2beb57687c76402bc0cfdf7901a31cf29",
"url": "https://llvm.googlesource.com/llvm-project/+/df22bbe2beb57687c76402bc0cfdf7901a31cf29"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "d4144ca27da174da3f8e7e3472e788b4246fd04e"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@d4144ca27da174da3f8e7e3472e788b4246fd04e",
"title": "d4144ca27da174da3f8e7e3472e788b4246fd04e",
"url": "https://llvm.googlesource.com/llvm-project/+/d4144ca27da174da3f8e7e3472e788b4246fd04e"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "7ef33e609c45515de9db1b5222fe6e05edd76c94"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@7ef33e609c45515de9db1b5222fe6e05edd76c94",
"title": "7ef33e609c45515de9db1b5222fe6e05edd76c94",
"url": "https://llvm.googlesource.com/llvm-project/+/7ef33e609c45515de9db1b5222fe6e05edd76c94"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "d2b45ce100d641a8f1690e30843bb9c5ea71ab86"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@d2b45ce100d641a8f1690e30843bb9c5ea71ab86",
"title": "d2b45ce100d641a8f1690e30843bb9c5ea71ab86",
"url": "https://llvm.googlesource.com/llvm-project/+/d2b45ce100d641a8f1690e30843bb9c5ea71ab86"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "80fd902573f860001af08d75f15d8f92005bae90"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@80fd902573f860001af08d75f15d8f92005bae90",
"title": "80fd902573f860001af08d75f15d8f92005bae90",
"url": "https://llvm.googlesource.com/llvm-project/+/80fd902573f860001af08d75f15d8f92005bae90"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "ecb016a87d89aed36b8f5d8102e15d8eb0e57108"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@ecb016a87d89aed36b8f5d8102e15d8eb0e57108",
"title": "ecb016a87d89aed36b8f5d8102e15d8eb0e57108",
"url": "https://llvm.googlesource.com/llvm-project/+/ecb016a87d89aed36b8f5d8102e15d8eb0e57108"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "78f690bba7846d3e9795bc27a5e27627a4a1ea28"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@78f690bba7846d3e9795bc27a5e27627a4a1ea28",
"title": "78f690bba7846d3e9795bc27a5e27627a4a1ea28",
"url": "https://llvm.googlesource.com/llvm-project/+/78f690bba7846d3e9795bc27a5e27627a4a1ea28"
}
]
}
},
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "78f690bba7846d3e9795bc27a5e27627a4a1ea28",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8889124540093760272"
},
{
"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"
}
}
[09:20:54.876] Scheduled build:
{
"id": "8723694478039331313",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-windows-x64"
},
"createdBy": "project:fuchsia",
"createTime": "2025-02-06T09:20:54.326012457Z",
"updateTime": "2025-02-06T09:20:54.326012457Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "78f690bba7846d3e9795bc27a5e27627a4a1ea28",
"ref": "refs/heads/main"
}
}
}
[09:20:54.876] Task URL: https://cr-buildbucket.appspot.com/build/8723694478039331313
[09:20:54.876] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8889124540093760272:2:0) after 5m16s
[09:20:55.220] Received PubSub notification, asking Buildbucket for the build status
[09:20:55.248] Build status: SCHEDULED
[09:21:01.848] Received PubSub notification, asking Buildbucket for the build status
[09:21:01.881] Build status: STARTED
[09:26:10.845] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8889124540093760272:2:0)
[09:26:10.870] Build status: STARTED
[09:26:10.870] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8889124540093760272:5:0) after 5m5s
[09:31:15.912] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8889124540093760272:5:0)
[09:31:15.937] Build status: STARTED
[09:31:15.937] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8889124540093760272:6:0) after 1m5s
[09:32:21.006] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8889124540093760272:6:0)
[09:32:21.029] Build status: STARTED
[09:32:21.029] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8889124540093760272:7:0) after 1m21s
[09:33:42.014] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8889124540093760272:7:0)
[09:33:42.039] Build status: STARTED
[09:33:42.039] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8889124540093760272:8:0) after 2m46s
[09:36:28.064] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8889124540093760272:8:0)
[09:36:28.093] Build status: STARTED
[09:36:28.093] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8889124540093760272:9:0) after 8m11s
[09:44:39.425] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8889124540093760272:9:0)
[09:44:39.441] Build status: STARTED
[09:44:39.441] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8889124540093760272:10:0) after 7m32s
[09:52:11.662] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8889124540093760272:10:0)
[09:52:11.685] Build status: STARTED
[09:52:11.685] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8889124540093760272:11:0) after 6m12s
[09:58:23.705] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8889124540093760272:11:0)
[09:58:23.732] Build status: STARTED
[09:58:23.732] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8889124540093760272:12:0) after 8m47s
[10:07:10.892] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8889124540093760272:12:0)
[10:07:10.932] Build status: STARTED
[10:07:10.932] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8889124540093760272:13:0) after 1m18s
[10:08:29.027] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8889124540093760272:13:0)
[10:08:29.050] Build status: STARTED
[10:08:29.050] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8889124540093760272:14:0) after 5m43s
[10:14:12.189] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8889124540093760272:14:0)
[10:14:12.204] Build status: STARTED
[10:14:12.204] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8889124540093760272:15:0) after 6m27s
[10:20:39.225] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8889124540093760272:15:0)
[10:20:39.288] Build status: STARTED
[10:20:39.288] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8889124540093760272:16:0) after 9m53s
[10:30:32.520] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8889124540093760272:16:0)
[10:30:32.562] Build status: STARTED
[10:30:32.562] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8889124540093760272:17:0) after 4m37s
[10:35:09.775] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8889124540093760272:17:0)
[10:35:09.796] Build status: STARTED
[10:35:09.796] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8889124540093760272:18:0) after 2m22s
[10:37:31.815] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8889124540093760272:18:0)
[10:37:31.832] Build status: STARTED
[10:37:31.832] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8889124540093760272:19:0) after 5m35s
[10:43:06.833] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8889124540093760272:19:0)
[10:43:06.849] Build status: STARTED
[10:43:06.849] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8889124540093760272:20:0) after 1m16s
[10:44:22.972] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8889124540093760272:20:0)
[10:44:22.988] Build status: STARTED
[10:44:22.988] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8889124540093760272:21:0) after 2m55s
[10:47:18.020] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8889124540093760272:21:0)
[10:47:18.103] Build status: STARTED
[10:47:18.103] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8889124540093760272:22:0) after 2m48s
[10:48:48.231] Received PubSub notification, asking Buildbucket for the build status
[10:48:48.256] Build:
{
"id": "8723694478039331313",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-windows-x64"
},
"createdBy": "project:fuchsia",
"createTime": "2025-02-06T09:20:54.326012457Z",
"startTime": "2025-02-06T09:21:01.312302979Z",
"endTime": "2025-02-06T10:48:47.914900443Z",
"updateTime": "2025-02-06T10:48:47.914900443Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "78f690bba7846d3e9795bc27a5e27627a4a1ea28",
"ref": "refs/heads/main"
}
}
}
[10:48:48.256] Invocation finished in 1h27m55.272691711s with status SUCCEEDED