[01:46:14.795] New invocation is queued and will start shortly
[01:46:15.918] Starting the invocation (attempt 1)
[01:46:15.941] Popped buildset tag "buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/e60d62b90f83210f43816fb528e6557ab1770683"
[01:46:15.941] Popped gitiles commit info from properties and tags
[01:46:15.941] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[01:46:15.941] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[01:46:15.942] Buildbucket request:
{
"requestId": "8861883456478245120",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-windows-x64"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8861883456478245120",
"job": "fuchsia/toolchain.ci-clang-windows-x64-40be1bb5",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "e71717c2f9e8e4cc580e2b21aeddf1fe10aea67e"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@e71717c2f9e8e4cc580e2b21aeddf1fe10aea67e",
"title": "e71717c2f9e8e4cc580e2b21aeddf1fe10aea67e",
"url": "https://llvm.googlesource.com/llvm-project/+/e71717c2f9e8e4cc580e2b21aeddf1fe10aea67e"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "d7fb086668dff682fd2693a3df87a90b2b15a3c6"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@d7fb086668dff682fd2693a3df87a90b2b15a3c6",
"title": "d7fb086668dff682fd2693a3df87a90b2b15a3c6",
"url": "https://llvm.googlesource.com/llvm-project/+/d7fb086668dff682fd2693a3df87a90b2b15a3c6"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "1a09ac584cee84eb79c0bc4f3b25c1c6e206078f"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@1a09ac584cee84eb79c0bc4f3b25c1c6e206078f",
"title": "1a09ac584cee84eb79c0bc4f3b25c1c6e206078f",
"url": "https://llvm.googlesource.com/llvm-project/+/1a09ac584cee84eb79c0bc4f3b25c1c6e206078f"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "efbbca62d15271b07c54b22a0014339f350c857f"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@efbbca62d15271b07c54b22a0014339f350c857f",
"title": "efbbca62d15271b07c54b22a0014339f350c857f",
"url": "https://llvm.googlesource.com/llvm-project/+/efbbca62d15271b07c54b22a0014339f350c857f"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "8d431974c65e35464ce1bf5245172553560edc8c"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@8d431974c65e35464ce1bf5245172553560edc8c",
"title": "8d431974c65e35464ce1bf5245172553560edc8c",
"url": "https://llvm.googlesource.com/llvm-project/+/8d431974c65e35464ce1bf5245172553560edc8c"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "e60a69ab8a9e75e730c3c93335f6366b747488d5"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@e60a69ab8a9e75e730c3c93335f6366b747488d5",
"title": "e60a69ab8a9e75e730c3c93335f6366b747488d5",
"url": "https://llvm.googlesource.com/llvm-project/+/e60a69ab8a9e75e730c3c93335f6366b747488d5"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "b8a5888d8d32246fd36d2f65bd917f03aa296e48"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@b8a5888d8d32246fd36d2f65bd917f03aa296e48",
"title": "b8a5888d8d32246fd36d2f65bd917f03aa296e48",
"url": "https://llvm.googlesource.com/llvm-project/+/b8a5888d8d32246fd36d2f65bd917f03aa296e48"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "c2409b4bcaca6662f86f7c9956f27413a7aecf0e"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@c2409b4bcaca6662f86f7c9956f27413a7aecf0e",
"title": "c2409b4bcaca6662f86f7c9956f27413a7aecf0e",
"url": "https://llvm.googlesource.com/llvm-project/+/c2409b4bcaca6662f86f7c9956f27413a7aecf0e"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "4afc2562fb79eecb218777fe85cbc420b903a70e"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@4afc2562fb79eecb218777fe85cbc420b903a70e",
"title": "4afc2562fb79eecb218777fe85cbc420b903a70e",
"url": "https://llvm.googlesource.com/llvm-project/+/4afc2562fb79eecb218777fe85cbc420b903a70e"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "e60d62b90f83210f43816fb528e6557ab1770683"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@e60d62b90f83210f43816fb528e6557ab1770683",
"title": "e60d62b90f83210f43816fb528e6557ab1770683",
"url": "https://llvm.googlesource.com/llvm-project/+/e60d62b90f83210f43816fb528e6557ab1770683"
}
]
}
},
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "e60d62b90f83210f43816fb528e6557ab1770683",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8861883456478245120"
},
{
"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"
}
}
[01:46:16.270] Scheduled build:
{
"id": "8696453394556109329",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-windows-x64"
},
"createdBy": "project:fuchsia",
"createTime": "2025-12-04T01:46:15.995258301Z",
"updateTime": "2025-12-04T01:46:15.995258301Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "e60d62b90f83210f43816fb528e6557ab1770683",
"ref": "refs/heads/main"
}
}
}
[01:46:16.270] Task URL: https://cr-buildbucket.appspot.com/build/8696453394556109329
[01:46:16.270] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8861883456478245120:2:0) after 2m11s
[01:46:28.956] Received PubSub notification, asking Buildbucket for the build status
[01:46:28.975] Build status: STARTED
[01:46:34.915] Received PubSub notification, asking Buildbucket for the build status
[01:46:34.961] Build status: STARTED
[01:48:27.285] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8861883456478245120:2:0)
[01:48:27.309] Build status: STARTED
[01:48:27.309] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8861883456478245120:5:0) after 3m36s
[01:52:03.549] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8861883456478245120:5:0)
[01:52:03.587] Build status: STARTED
[01:52:03.588] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8861883456478245120:6:0) after 2m36s
[01:54:39.653] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8861883456478245120:6:0)
[01:54:39.802] Build status: STARTED
[01:54:39.802] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8861883456478245120:7:0) after 3m45s
[01:58:24.861] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8861883456478245120:7:0)
[01:58:24.884] Build status: STARTED
[01:58:24.884] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8861883456478245120:8:0) after 2m3s
[02:00:27.901] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8861883456478245120:8:0)
[02:00:27.918] Build status: STARTED
[02:00:27.918] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8861883456478245120:9:0) after 6m37s
[02:07:04.979] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8861883456478245120:9:0)
[02:07:04.991] Build status: STARTED
[02:07:04.991] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8861883456478245120:10:0) after 7m33s
[02:14:38.051] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8861883456478245120:10:0)
[02:14:38.068] Build status: STARTED
[02:14:38.068] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8861883456478245120:11:0) after 9m19s
[02:23:57.109] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8861883456478245120:11:0)
[02:23:57.144] Build status: STARTED
[02:23:57.144] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8861883456478245120:12:0) after 7m45s
[02:31:42.161] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8861883456478245120:12:0)
[02:31:42.183] Build status: STARTED
[02:31:42.183] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8861883456478245120:13:0) after 8m30s
[02:40:12.198] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8861883456478245120:13:0)
[02:40:12.221] Build status: STARTED
[02:40:12.221] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8861883456478245120:14:0) after 1m4s
[02:41:16.340] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8861883456478245120:14:0)
[02:41:16.368] Build status: STARTED
[02:41:16.369] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8861883456478245120:15:0) after 9m52s
[02:51:08.522] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8861883456478245120:15:0)
[02:51:08.540] Build status: STARTED
[02:51:08.540] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8861883456478245120:16:0) after 1m5s
[02:52:13.518] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8861883456478245120:16:0)
[02:52:13.537] Build status: STARTED
[02:52:13.537] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8861883456478245120:17:0) after 9m56s
[03:02:09.550] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8861883456478245120:17:0)
[03:02:09.565] Build status: STARTED
[03:02:09.565] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8861883456478245120:18:0) after 2m22s
[03:04:31.607] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8861883456478245120:18:0)
[03:04:31.629] Build status: STARTED
[03:04:31.629] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8861883456478245120:19:0) after 2m15s
[03:06:46.631] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8861883456478245120:19:0)
[03:06:46.646] Build status: STARTED
[03:06:46.646] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8861883456478245120:20:0) after 8m53s
[03:15:39.722] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8861883456478245120:20:0)
[03:15:39.781] Build status: STARTED
[03:15:39.781] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8861883456478245120:21:0) after 8m4s
[03:20:16.140] Received PubSub notification, asking Buildbucket for the build status
[03:20:16.183] Build:
{
"id": "8696453394556109329",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-windows-x64"
},
"createdBy": "project:fuchsia",
"createTime": "2025-12-04T01:46:15.995258301Z",
"startTime": "2025-12-04T01:46:19.363059162Z",
"endTime": "2025-12-04T03:20:15.895231122Z",
"updateTime": "2025-12-04T03:20:15.895231122Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "e60d62b90f83210f43816fb528e6557ab1770683",
"ref": "refs/heads/main"
}
}
}
[03:20:16.183] Invocation finished in 1h34m1.403966303s with status SUCCEEDED