[18:33:44.909] New invocation is queued and will start shortly
[18:33:46.033] Starting the invocation (attempt 1)
[18:33:46.066] Popped buildset tag "buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/ca61a9d96027a34750149b856ffba746999b4e16"
[18:33:46.067] Popped gitiles commit info from properties and tags
[18:33:46.067] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[18:33:46.067] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[18:33:46.067] Buildbucket request:
{
"requestId": "8868161857586076128",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-windows-x64"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8868161857586076128",
"job": "fuchsia/toolchain.ci-clang-windows-x64-40be1bb5",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "62450ba905fecc0821f3a08db81f756c8b1f7b7c"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@62450ba905fecc0821f3a08db81f756c8b1f7b7c",
"title": "62450ba905fecc0821f3a08db81f756c8b1f7b7c",
"url": "https://llvm.googlesource.com/llvm-project/+/62450ba905fecc0821f3a08db81f756c8b1f7b7c"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "35c14c4cc32f97bd82d5bab458cf53b941b4f2dc"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@35c14c4cc32f97bd82d5bab458cf53b941b4f2dc",
"title": "35c14c4cc32f97bd82d5bab458cf53b941b4f2dc",
"url": "https://llvm.googlesource.com/llvm-project/+/35c14c4cc32f97bd82d5bab458cf53b941b4f2dc"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "a5569b4bd7f8d2696f962e4edaa5179895228e42"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@a5569b4bd7f8d2696f962e4edaa5179895228e42",
"title": "a5569b4bd7f8d2696f962e4edaa5179895228e42",
"url": "https://llvm.googlesource.com/llvm-project/+/a5569b4bd7f8d2696f962e4edaa5179895228e42"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "50a7eb6fc2977d3a5c2d71d91a799d4275f5a595"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@50a7eb6fc2977d3a5c2d71d91a799d4275f5a595",
"title": "50a7eb6fc2977d3a5c2d71d91a799d4275f5a595",
"url": "https://llvm.googlesource.com/llvm-project/+/50a7eb6fc2977d3a5c2d71d91a799d4275f5a595"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "f07cedbdc6887b02f5ae4188b92ab85e510d964b"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@f07cedbdc6887b02f5ae4188b92ab85e510d964b",
"title": "f07cedbdc6887b02f5ae4188b92ab85e510d964b",
"url": "https://llvm.googlesource.com/llvm-project/+/f07cedbdc6887b02f5ae4188b92ab85e510d964b"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "c924e7a8672fb1098c695d652697946cd69343b6"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@c924e7a8672fb1098c695d652697946cd69343b6",
"title": "c924e7a8672fb1098c695d652697946cd69343b6",
"url": "https://llvm.googlesource.com/llvm-project/+/c924e7a8672fb1098c695d652697946cd69343b6"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "9e7b21afaaf1b165ac7a9f4bc4afd67a7d1b4687"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@9e7b21afaaf1b165ac7a9f4bc4afd67a7d1b4687",
"title": "9e7b21afaaf1b165ac7a9f4bc4afd67a7d1b4687",
"url": "https://llvm.googlesource.com/llvm-project/+/9e7b21afaaf1b165ac7a9f4bc4afd67a7d1b4687"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "80d3a8015513e2a64c47e173addda6ce816bf85c"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@80d3a8015513e2a64c47e173addda6ce816bf85c",
"title": "80d3a8015513e2a64c47e173addda6ce816bf85c",
"url": "https://llvm.googlesource.com/llvm-project/+/80d3a8015513e2a64c47e173addda6ce816bf85c"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "30402c7dea57d35ead80387c061cda6977ba98ef"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@30402c7dea57d35ead80387c061cda6977ba98ef",
"title": "30402c7dea57d35ead80387c061cda6977ba98ef",
"url": "https://llvm.googlesource.com/llvm-project/+/30402c7dea57d35ead80387c061cda6977ba98ef"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "96a7c9b9858ac4eb366e443b00784488c190688c"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@96a7c9b9858ac4eb366e443b00784488c190688c",
"title": "96a7c9b9858ac4eb366e443b00784488c190688c",
"url": "https://llvm.googlesource.com/llvm-project/+/96a7c9b9858ac4eb366e443b00784488c190688c"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "cc95c5680e9fd1a3697822407a9857caeca32dba"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@cc95c5680e9fd1a3697822407a9857caeca32dba",
"title": "cc95c5680e9fd1a3697822407a9857caeca32dba",
"url": "https://llvm.googlesource.com/llvm-project/+/cc95c5680e9fd1a3697822407a9857caeca32dba"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "62660e59d9365a2c77724c7cf05986eef7c2354a"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@62660e59d9365a2c77724c7cf05986eef7c2354a",
"title": "62660e59d9365a2c77724c7cf05986eef7c2354a",
"url": "https://llvm.googlesource.com/llvm-project/+/62660e59d9365a2c77724c7cf05986eef7c2354a"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "c3cbd27d005b86ea5c5a375c21b86e6c2110e198"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@c3cbd27d005b86ea5c5a375c21b86e6c2110e198",
"title": "c3cbd27d005b86ea5c5a375c21b86e6c2110e198",
"url": "https://llvm.googlesource.com/llvm-project/+/c3cbd27d005b86ea5c5a375c21b86e6c2110e198"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "321a7c3caf7c5c6a208501e1406fcab14f8b54f9"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@321a7c3caf7c5c6a208501e1406fcab14f8b54f9",
"title": "321a7c3caf7c5c6a208501e1406fcab14f8b54f9",
"url": "https://llvm.googlesource.com/llvm-project/+/321a7c3caf7c5c6a208501e1406fcab14f8b54f9"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "57330c8514c78e7032975961badf5fa59091f059"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@57330c8514c78e7032975961badf5fa59091f059",
"title": "57330c8514c78e7032975961badf5fa59091f059",
"url": "https://llvm.googlesource.com/llvm-project/+/57330c8514c78e7032975961badf5fa59091f059"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "39ed57c0888dd9b76d63757357a8d5a742850ab6"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@39ed57c0888dd9b76d63757357a8d5a742850ab6",
"title": "39ed57c0888dd9b76d63757357a8d5a742850ab6",
"url": "https://llvm.googlesource.com/llvm-project/+/39ed57c0888dd9b76d63757357a8d5a742850ab6"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "1685a6a602c529d3615e2c2d98b7ef060f192eb7"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@1685a6a602c529d3615e2c2d98b7ef060f192eb7",
"title": "1685a6a602c529d3615e2c2d98b7ef060f192eb7",
"url": "https://llvm.googlesource.com/llvm-project/+/1685a6a602c529d3615e2c2d98b7ef060f192eb7"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "1b0553c9fa8d61010a43b1a2dcb649d1aab7d8ae"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@1b0553c9fa8d61010a43b1a2dcb649d1aab7d8ae",
"title": "1b0553c9fa8d61010a43b1a2dcb649d1aab7d8ae",
"url": "https://llvm.googlesource.com/llvm-project/+/1b0553c9fa8d61010a43b1a2dcb649d1aab7d8ae"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "ca61a9d96027a34750149b856ffba746999b4e16"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@ca61a9d96027a34750149b856ffba746999b4e16",
"title": "ca61a9d96027a34750149b856ffba746999b4e16",
"url": "https://llvm.googlesource.com/llvm-project/+/ca61a9d96027a34750149b856ffba746999b4e16"
}
]
}
},
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "ca61a9d96027a34750149b856ffba746999b4e16",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8868161857586076128"
},
{
"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:33:46.550] Scheduled build:
{
"id": "8702731795635887313",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-windows-x64"
},
"createdBy": "project:fuchsia",
"createTime": "2025-09-25T18:33:46.138099643Z",
"updateTime": "2025-09-25T18:33:46.138099643Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "ca61a9d96027a34750149b856ffba746999b4e16",
"ref": "refs/heads/main"
}
}
}
[18:33:46.550] Task URL: https://cr-buildbucket.appspot.com/build/8702731795635887313
[18:33:46.550] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8868161857586076128:2:0) after 8m31s
[18:33:47.502] Received PubSub notification, asking Buildbucket for the build status
[18:33:47.547] Build status: SCHEDULED
[18:33:50.559] Received PubSub notification, asking Buildbucket for the build status
[18:33:50.663] Build status: STARTED
[18:42:17.590] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8868161857586076128:2:0)
[18:42:17.605] Build status: STARTED
[18:42:17.605] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8868161857586076128:5:0) after 3m33s
[18:45:50.598] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8868161857586076128:5:0)
[18:45:50.616] Build status: STARTED
[18:45:50.616] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8868161857586076128:6:0) after 8m58s
[18:54:48.612] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8868161857586076128:6:0)
[18:54:48.763] Build status: STARTED
[18:54:48.763] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8868161857586076128:7:0) after 3m0s
[18:57:48.856] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8868161857586076128:7:0)
[18:57:48.928] Build status: STARTED
[18:57:48.928] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8868161857586076128:8:0) after 4m52s
[19:02:40.997] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8868161857586076128:8:0)
[19:02:41.021] Build status: STARTED
[19:02:41.021] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8868161857586076128:9:0) after 4m21s
[19:07:02.038] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8868161857586076128:9:0)
[19:07:02.076] Build status: STARTED
[19:07:02.076] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8868161857586076128:10:0) after 6m55s
[19:13:57.274] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8868161857586076128:10:0)
[19:13:57.385] Build status: STARTED
[19:13:57.385] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8868161857586076128:11:0) after 2m41s
[19:16:38.509] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8868161857586076128:11:0)
[19:16:38.531] Build status: STARTED
[19:16:38.531] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8868161857586076128:12:0) after 1m5s
[19:17:43.551] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8868161857586076128:12:0)
[19:17:43.576] Build status: STARTED
[19:17:43.577] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8868161857586076128:13:0) after 4m9s
[19:21:52.613] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8868161857586076128:13:0)
[19:21:52.647] Build status: STARTED
[19:21:52.647] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8868161857586076128:14:0) after 1m24s
[19:23:16.717] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8868161857586076128:14:0)
[19:23:16.750] Build status: STARTED
[19:23:16.750] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8868161857586076128:15:0) after 4m2s
[19:27:18.821] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8868161857586076128:15:0)
[19:27:18.841] Build status: STARTED
[19:27:18.841] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8868161857586076128:16:0) after 2m8s
[19:29:26.888] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8868161857586076128:16:0)
[19:29:26.904] Build status: STARTED
[19:29:26.904] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8868161857586076128:17:0) after 7m59s
[19:37:25.954] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8868161857586076128:17:0)
[19:37:25.970] Build status: STARTED
[19:37:25.970] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8868161857586076128:18:0) after 6m54s
[19:44:20.179] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8868161857586076128:18:0)
[19:44:20.197] Build status: STARTED
[19:44:20.197] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8868161857586076128:19:0) after 6m16s
[19:50:36.244] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8868161857586076128:19:0)
[19:50:36.261] Build status: STARTED
[19:50:36.262] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8868161857586076128:20:0) after 6m18s
[19:56:54.398] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8868161857586076128:20:0)
[19:56:54.416] Build status: STARTED
[19:56:54.416] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8868161857586076128:21:0) after 9m42s
[20:03:08.862] Received PubSub notification, asking Buildbucket for the build status
[20:03:09.003] Build:
{
"id": "8702731795635887313",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-windows-x64"
},
"createdBy": "project:fuchsia",
"createTime": "2025-09-25T18:33:46.138099643Z",
"startTime": "2025-09-25T18:33:49.694818697Z",
"endTime": "2025-09-25T20:03:08.391980605Z",
"updateTime": "2025-09-25T20:03:08.391980605Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "ca61a9d96027a34750149b856ffba746999b4e16",
"ref": "refs/heads/main"
}
}
}
[20:03:09.003] Invocation finished in 1h29m24.108478517s with status SUCCEEDED