[19:27:26.857] New invocation is queued and will start shortly
[19:27:28.151] Starting the invocation (attempt 1)
[19:27:28.185] Popped buildset tag "buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/93cac97d7d4e5259cb544caab54e9902d3d84dbe"
[19:27:28.185] Popped gitiles commit info from properties and tags
[19:27:28.185] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[19:27:28.186] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[19:27:28.186] Buildbucket request:
{
"requestId": "8868158479126835616",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-host-mac-x64"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8868158479126835616",
"job": "fuchsia/toolchain.ci-clang-host-mac-x64-40be1bb5",
"triggers": [
{
"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"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "04258fe3b15c9ecf78848c9b1470e1048844989e"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@04258fe3b15c9ecf78848c9b1470e1048844989e",
"title": "04258fe3b15c9ecf78848c9b1470e1048844989e",
"url": "https://llvm.googlesource.com/llvm-project/+/04258fe3b15c9ecf78848c9b1470e1048844989e"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "3e7e60ae5ce80b00602506e007b02e7195373f35"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@3e7e60ae5ce80b00602506e007b02e7195373f35",
"title": "3e7e60ae5ce80b00602506e007b02e7195373f35",
"url": "https://llvm.googlesource.com/llvm-project/+/3e7e60ae5ce80b00602506e007b02e7195373f35"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "223cfa8018595ff2a809b4e10701bfea884af709"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@223cfa8018595ff2a809b4e10701bfea884af709",
"title": "223cfa8018595ff2a809b4e10701bfea884af709",
"url": "https://llvm.googlesource.com/llvm-project/+/223cfa8018595ff2a809b4e10701bfea884af709"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "90a6884f2d088547f7b2650d2151a316b9694f59"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@90a6884f2d088547f7b2650d2151a316b9694f59",
"title": "90a6884f2d088547f7b2650d2151a316b9694f59",
"url": "https://llvm.googlesource.com/llvm-project/+/90a6884f2d088547f7b2650d2151a316b9694f59"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "93cac97d7d4e5259cb544caab54e9902d3d84dbe"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@93cac97d7d4e5259cb544caab54e9902d3d84dbe",
"title": "93cac97d7d4e5259cb544caab54e9902d3d84dbe",
"url": "https://llvm.googlesource.com/llvm-project/+/93cac97d7d4e5259cb544caab54e9902d3d84dbe"
}
]
}
},
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "93cac97d7d4e5259cb544caab54e9902d3d84dbe",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8868158479126835616"
},
{
"key": "scheduler_job_id",
"value": "fuchsia/toolchain.ci-clang-host-mac-x64-40be1bb5"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[19:27:28.794] Scheduled build:
{
"id": "8702728416892657249",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-host-mac-x64"
},
"createdBy": "project:fuchsia",
"createTime": "2025-09-25T19:27:28.358042211Z",
"updateTime": "2025-09-25T19:27:28.358042211Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "93cac97d7d4e5259cb544caab54e9902d3d84dbe",
"ref": "refs/heads/main"
}
}
}
[19:27:28.794] Task URL: https://cr-buildbucket.appspot.com/build/8702728416892657249
[19:27:28.794] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-host-mac-x64-40be1bb5:8868158479126835616:2:0) after 3m24s
[19:27:29.308] Received PubSub notification, asking Buildbucket for the build status
[19:27:29.324] Build status: SCHEDULED
[19:30:52.807] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-host-mac-x64-40be1bb5:8868158479126835616:2:0)
[19:30:52.849] Build status: SCHEDULED
[19:30:52.849] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-host-mac-x64-40be1bb5:8868158479126835616:4:0) after 6m45s
[19:37:37.918] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-host-mac-x64-40be1bb5:8868158479126835616:4:0)
[19:37:37.942] Build status: SCHEDULED
[19:37:37.942] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-host-mac-x64-40be1bb5:8868158479126835616:5:0) after 8m54s
[19:46:31.924] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-host-mac-x64-40be1bb5:8868158479126835616:5:0)
[19:46:31.952] Build status: SCHEDULED
[19:46:31.952] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-host-mac-x64-40be1bb5:8868158479126835616:6:0) after 8m55s
[19:55:27.049] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-host-mac-x64-40be1bb5:8868158479126835616:6:0)
[19:55:27.068] Build status: SCHEDULED
[19:55:27.068] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-host-mac-x64-40be1bb5:8868158479126835616:7:0) after 7m25s
[20:02:52.186] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-host-mac-x64-40be1bb5:8868158479126835616:7:0)
[20:02:52.212] Build status: SCHEDULED
[20:02:52.212] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-host-mac-x64-40be1bb5:8868158479126835616:8:0) after 4m0s
[20:06:52.221] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-host-mac-x64-40be1bb5:8868158479126835616:8:0)
[20:06:52.317] Build status: SCHEDULED
[20:06:52.317] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-host-mac-x64-40be1bb5:8868158479126835616:9:0) after 1m26s
[20:08:18.332] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-host-mac-x64-40be1bb5:8868158479126835616:9:0)
[20:08:18.406] Build status: SCHEDULED
[20:08:18.407] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-host-mac-x64-40be1bb5:8868158479126835616:10:0) after 2m10s
[20:10:28.511] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-host-mac-x64-40be1bb5:8868158479126835616:10:0)
[20:10:28.571] Build status: SCHEDULED
[20:10:28.571] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-host-mac-x64-40be1bb5:8868158479126835616:11:0) after 6m56s
[20:15:47.897] Received PubSub notification, asking Buildbucket for the build status
[20:15:47.914] Build status: STARTED
[20:17:24.647] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-host-mac-x64-40be1bb5:8868158479126835616:11:0)
[20:17:24.665] Build status: STARTED
[20:17:24.665] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-host-mac-x64-40be1bb5:8868158479126835616:13:0) after 8m31s
[20:25:55.685] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-host-mac-x64-40be1bb5:8868158479126835616:13:0)
[20:25:55.702] Build status: STARTED
[20:25:55.702] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-host-mac-x64-40be1bb5:8868158479126835616:14:0) after 7m45s
[20:33:40.740] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-host-mac-x64-40be1bb5:8868158479126835616:14:0)
[20:33:40.770] Build status: STARTED
[20:33:40.770] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-host-mac-x64-40be1bb5:8868158479126835616:15:0) after 7m39s
[20:41:19.808] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-host-mac-x64-40be1bb5:8868158479126835616:15:0)
[20:41:19.832] Build status: STARTED
[20:41:19.832] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-host-mac-x64-40be1bb5:8868158479126835616:16:0) after 2m14s
[20:43:33.972] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-host-mac-x64-40be1bb5:8868158479126835616:16:0)
[20:43:33.990] Build status: STARTED
[20:43:33.991] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-host-mac-x64-40be1bb5:8868158479126835616:17:0) after 4m33s
[20:48:07.066] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-host-mac-x64-40be1bb5:8868158479126835616:17:0)
[20:48:07.083] Build status: STARTED
[20:48:07.083] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-host-mac-x64-40be1bb5:8868158479126835616:18:0) after 8m41s
[20:56:48.102] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-host-mac-x64-40be1bb5:8868158479126835616:18:0)
[20:56:48.119] Build status: STARTED
[20:56:48.119] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-host-mac-x64-40be1bb5:8868158479126835616:19:0) after 4m58s
[21:01:46.233] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-host-mac-x64-40be1bb5:8868158479126835616:19:0)
[21:01:46.288] Build status: STARTED
[21:01:46.288] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-host-mac-x64-40be1bb5:8868158479126835616:20:0) after 9m1s
[21:10:47.411] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-host-mac-x64-40be1bb5:8868158479126835616:20:0)
[21:10:47.429] Build status: STARTED
[21:10:47.429] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-host-mac-x64-40be1bb5:8868158479126835616:21:0) after 4m22s
[21:15:09.490] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-host-mac-x64-40be1bb5:8868158479126835616:21:0)
[21:15:09.506] Build status: STARTED
[21:15:09.506] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-host-mac-x64-40be1bb5:8868158479126835616:22:0) after 1m42s
[21:16:42.368] Received PubSub notification, asking Buildbucket for the build status
[21:16:42.388] Build:
{
"id": "8702728416892657249",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-host-mac-x64"
},
"createdBy": "project:fuchsia",
"createTime": "2025-09-25T19:27:28.358042211Z",
"startTime": "2025-09-25T20:15:47.700230973Z",
"endTime": "2025-09-25T21:16:42.050159892Z",
"updateTime": "2025-09-25T21:16:42.050159892Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "93cac97d7d4e5259cb544caab54e9902d3d84dbe",
"ref": "refs/heads/main"
}
}
}
[21:16:42.388] Invocation finished in 1h49m15.543561614s with status SUCCEEDED