[20:21:10.248] New invocation is queued and will start shortly
[20:21:11.358] Starting the invocation (attempt 1)
[20:21:11.384] Popped buildset tag "buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/f2f04c363cc131493fdb679cf4809d4dadd32780"
[20:21:11.384] Popped gitiles commit info from properties and tags
[20:21:11.384] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[20:21:11.384] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[20:21:11.385] Buildbucket request:
{
"requestId": "8863987638698625808",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-windows-x64"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8863987638698625808",
"job": "fuchsia/toolchain.ci-clang-windows-x64-40be1bb5",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "b639b6a1c529a476ca7d3fed280de9adf2d02ce5"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@b639b6a1c529a476ca7d3fed280de9adf2d02ce5",
"title": "b639b6a1c529a476ca7d3fed280de9adf2d02ce5",
"url": "https://llvm.googlesource.com/llvm-project/+/b639b6a1c529a476ca7d3fed280de9adf2d02ce5"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "e9d3340b57494091cf77130d3f7cc03fbe9ccbd6"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@e9d3340b57494091cf77130d3f7cc03fbe9ccbd6",
"title": "e9d3340b57494091cf77130d3f7cc03fbe9ccbd6",
"url": "https://llvm.googlesource.com/llvm-project/+/e9d3340b57494091cf77130d3f7cc03fbe9ccbd6"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "b7423af8da9992e4e006edae12431167408def32"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@b7423af8da9992e4e006edae12431167408def32",
"title": "b7423af8da9992e4e006edae12431167408def32",
"url": "https://llvm.googlesource.com/llvm-project/+/b7423af8da9992e4e006edae12431167408def32"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "08222caf28b6bcc9376f352b552cecf640e8537e"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@08222caf28b6bcc9376f352b552cecf640e8537e",
"title": "08222caf28b6bcc9376f352b552cecf640e8537e",
"url": "https://llvm.googlesource.com/llvm-project/+/08222caf28b6bcc9376f352b552cecf640e8537e"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "0d97f43974122316863295256bfd20c6bd93a24c"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@0d97f43974122316863295256bfd20c6bd93a24c",
"title": "0d97f43974122316863295256bfd20c6bd93a24c",
"url": "https://llvm.googlesource.com/llvm-project/+/0d97f43974122316863295256bfd20c6bd93a24c"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "46a8ddbd1494812474502de5f9841492225c28a1"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@46a8ddbd1494812474502de5f9841492225c28a1",
"title": "46a8ddbd1494812474502de5f9841492225c28a1",
"url": "https://llvm.googlesource.com/llvm-project/+/46a8ddbd1494812474502de5f9841492225c28a1"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "821d2825a4f782da3da3c03b8a002802bff4b95c"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@821d2825a4f782da3da3c03b8a002802bff4b95c",
"title": "821d2825a4f782da3da3c03b8a002802bff4b95c",
"url": "https://llvm.googlesource.com/llvm-project/+/821d2825a4f782da3da3c03b8a002802bff4b95c"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "89577e910eab2024f897b82f9f174a251dc75db9"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@89577e910eab2024f897b82f9f174a251dc75db9",
"title": "89577e910eab2024f897b82f9f174a251dc75db9",
"url": "https://llvm.googlesource.com/llvm-project/+/89577e910eab2024f897b82f9f174a251dc75db9"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "efc83cc4a08f5ac4142e70ef9cab62787384643a"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@efc83cc4a08f5ac4142e70ef9cab62787384643a",
"title": "efc83cc4a08f5ac4142e70ef9cab62787384643a",
"url": "https://llvm.googlesource.com/llvm-project/+/efc83cc4a08f5ac4142e70ef9cab62787384643a"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "0364bafdadb7792c59bc9fa54c2a96d4278f9e66"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@0364bafdadb7792c59bc9fa54c2a96d4278f9e66",
"title": "0364bafdadb7792c59bc9fa54c2a96d4278f9e66",
"url": "https://llvm.googlesource.com/llvm-project/+/0364bafdadb7792c59bc9fa54c2a96d4278f9e66"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "5c4083ef1c182b99aed8dfeba7399635166337ab"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@5c4083ef1c182b99aed8dfeba7399635166337ab",
"title": "5c4083ef1c182b99aed8dfeba7399635166337ab",
"url": "https://llvm.googlesource.com/llvm-project/+/5c4083ef1c182b99aed8dfeba7399635166337ab"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "70a6475fdd6cb80e9c4f0fa3c523ab806dfeb46b"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@70a6475fdd6cb80e9c4f0fa3c523ab806dfeb46b",
"title": "70a6475fdd6cb80e9c4f0fa3c523ab806dfeb46b",
"url": "https://llvm.googlesource.com/llvm-project/+/70a6475fdd6cb80e9c4f0fa3c523ab806dfeb46b"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "2f54efd1bf96f08e564dbd092f65c04b16e9d4dc"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@2f54efd1bf96f08e564dbd092f65c04b16e9d4dc",
"title": "2f54efd1bf96f08e564dbd092f65c04b16e9d4dc",
"url": "https://llvm.googlesource.com/llvm-project/+/2f54efd1bf96f08e564dbd092f65c04b16e9d4dc"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "eae817d26acfd9c1b236c55f06c0b4055462a81f"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@eae817d26acfd9c1b236c55f06c0b4055462a81f",
"title": "eae817d26acfd9c1b236c55f06c0b4055462a81f",
"url": "https://llvm.googlesource.com/llvm-project/+/eae817d26acfd9c1b236c55f06c0b4055462a81f"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "f2f04c363cc131493fdb679cf4809d4dadd32780"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@f2f04c363cc131493fdb679cf4809d4dadd32780",
"title": "f2f04c363cc131493fdb679cf4809d4dadd32780",
"url": "https://llvm.googlesource.com/llvm-project/+/f2f04c363cc131493fdb679cf4809d4dadd32780"
}
]
}
},
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "f2f04c363cc131493fdb679cf4809d4dadd32780",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8863987638698625808"
},
{
"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"
}
}
[20:21:12.016] Scheduled build:
{
"id": "8698557576733139089",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-windows-x64"
},
"createdBy": "project:fuchsia",
"createTime": "2025-11-10T20:21:11.496663929Z",
"updateTime": "2025-11-10T20:21:11.496663929Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "f2f04c363cc131493fdb679cf4809d4dadd32780",
"ref": "refs/heads/main"
}
}
}
[20:21:12.016] Task URL: https://cr-buildbucket.appspot.com/build/8698557576733139089
[20:21:12.016] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8863987638698625808:2:0) after 9m37s
[20:21:12.091] Received PubSub notification, asking Buildbucket for the build status
[20:21:12.107] Build status: SCHEDULED
[20:21:15.478] Received PubSub notification, asking Buildbucket for the build status
[20:21:15.547] Build status: STARTED
[20:30:49.040] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8863987638698625808:2:0)
[20:30:49.057] Build status: STARTED
[20:30:49.057] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8863987638698625808:5:0) after 2m15s
[20:33:04.074] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8863987638698625808:5:0)
[20:33:04.117] Build status: STARTED
[20:33:04.117] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8863987638698625808:6:0) after 6m54s
[20:39:58.138] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8863987638698625808:6:0)
[20:39:58.166] Build status: STARTED
[20:39:58.166] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8863987638698625808:7:0) after 2m44s
[20:42:42.179] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8863987638698625808:7:0)
[20:42:42.195] Build status: STARTED
[20:42:42.195] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8863987638698625808:8:0) after 7m15s
[20:49:57.225] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8863987638698625808:8:0)
[20:49:57.240] Build status: STARTED
[20:49:57.240] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8863987638698625808:9:0) after 4m8s
[20:54:05.257] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8863987638698625808:9:0)
[20:54:05.365] Build status: STARTED
[20:54:05.365] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8863987638698625808:10:0) after 5m45s
[20:59:50.391] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8863987638698625808:10:0)
[20:59:50.407] Build status: STARTED
[20:59:50.407] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8863987638698625808:11:0) after 4m11s
[21:04:01.394] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8863987638698625808:11:0)
[21:04:01.418] Build status: STARTED
[21:04:01.418] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8863987638698625808:12:0) after 4m32s
[21:08:33.431] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8863987638698625808:12:0)
[21:08:33.448] Build status: STARTED
[21:08:33.448] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8863987638698625808:13:0) after 2m2s
[21:10:35.462] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8863987638698625808:13:0)
[21:10:35.477] Build status: STARTED
[21:10:35.477] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8863987638698625808:14:0) after 1m9s
[21:11:44.491] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8863987638698625808:14:0)
[21:11:44.512] Build status: STARTED
[21:11:44.513] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8863987638698625808:15:0) after 9m16s
[21:21:00.535] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8863987638698625808:15:0)
[21:21:00.561] Build status: STARTED
[21:21:00.561] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8863987638698625808:16:0) after 3m14s
[21:24:14.581] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8863987638698625808:16:0)
[21:24:14.643] Build status: STARTED
[21:24:14.643] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8863987638698625808:17:0) after 2m40s
[21:26:54.700] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8863987638698625808:17:0)
[21:26:54.716] Build status: STARTED
[21:26:54.716] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8863987638698625808:18:0) after 1m20s
[21:28:14.729] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8863987638698625808:18:0)
[21:28:14.744] Build status: STARTED
[21:28:14.744] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8863987638698625808:19:0) after 5m45s
[21:33:59.850] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8863987638698625808:19:0)
[21:33:59.868] Build status: STARTED
[21:33:59.868] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8863987638698625808:20:0) after 1m8s
[21:35:07.883] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8863987638698625808:20:0)
[21:35:07.925] Build status: STARTED
[21:35:07.925] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8863987638698625808:21:0) after 3m13s
[21:38:20.943] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8863987638698625808:21:0)
[21:38:21.032] Build status: STARTED
[21:38:21.032] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8863987638698625808:22:0) after 6m50s
[21:45:11.077] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8863987638698625808:22:0)
[21:45:11.127] Build status: STARTED
[21:45:11.127] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8863987638698625808:23:0) after 4m37s
[21:49:48.143] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8863987638698625808:23:0)
[21:49:48.158] Build status: STARTED
[21:49:48.158] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8863987638698625808:24:0) after 7m2s
[21:56:50.187] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8863987638698625808:24:0)
[21:56:50.208] Build status: STARTED
[21:56:50.208] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8863987638698625808:25:0) after 6m16s
[22:00:13.408] Received PubSub notification, asking Buildbucket for the build status
[22:00:13.426] Build:
{
"id": "8698557576733139089",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-windows-x64"
},
"createdBy": "project:fuchsia",
"createTime": "2025-11-10T20:21:11.496663929Z",
"startTime": "2025-11-10T20:21:15.294144181Z",
"endTime": "2025-11-10T22:00:12.809411831Z",
"updateTime": "2025-11-10T22:00:12.809411831Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "f2f04c363cc131493fdb679cf4809d4dadd32780",
"ref": "refs/heads/main"
}
}
}
[22:00:13.426] Invocation finished in 1h39m3.187821803s with status SUCCEEDED