[10:49:02.477] New invocation is queued and will start shortly
[10:49:03.583] Starting the invocation (attempt 1)
[10:49:03.609] Popped buildset tag "buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/3576f05db125006ffbe22bfc199a269bf2a4a06f"
[10:49:03.609] Popped gitiles commit info from properties and tags
[10:49:03.609] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[10:49:03.609] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[10:49:03.609] Buildbucket request:
{
"requestId": "8870184227692481392",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-host-mac-x64"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8870184227692481392",
"job": "fuchsia/toolchain.ci-clang-host-mac-x64-40be1bb5",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "7da91fa801d8bd490c8dcd9a29faba209feb2954"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@7da91fa801d8bd490c8dcd9a29faba209feb2954",
"title": "7da91fa801d8bd490c8dcd9a29faba209feb2954",
"url": "https://llvm.googlesource.com/llvm-project/+/7da91fa801d8bd490c8dcd9a29faba209feb2954"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "49ffe31defafd0cd87b2c194e57a02ad428fdae4"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@49ffe31defafd0cd87b2c194e57a02ad428fdae4",
"title": "49ffe31defafd0cd87b2c194e57a02ad428fdae4",
"url": "https://llvm.googlesource.com/llvm-project/+/49ffe31defafd0cd87b2c194e57a02ad428fdae4"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "47de90e285aeec1acc8595c4b327cd823c069c90"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@47de90e285aeec1acc8595c4b327cd823c069c90",
"title": "47de90e285aeec1acc8595c4b327cd823c069c90",
"url": "https://llvm.googlesource.com/llvm-project/+/47de90e285aeec1acc8595c4b327cd823c069c90"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "2f5500e4cf603ae080363f4f24df78d543972667"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@2f5500e4cf603ae080363f4f24df78d543972667",
"title": "2f5500e4cf603ae080363f4f24df78d543972667",
"url": "https://llvm.googlesource.com/llvm-project/+/2f5500e4cf603ae080363f4f24df78d543972667"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "3576f05db125006ffbe22bfc199a269bf2a4a06f"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@3576f05db125006ffbe22bfc199a269bf2a4a06f",
"title": "3576f05db125006ffbe22bfc199a269bf2a4a06f",
"url": "https://llvm.googlesource.com/llvm-project/+/3576f05db125006ffbe22bfc199a269bf2a4a06f"
}
]
}
},
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "3576f05db125006ffbe22bfc199a269bf2a4a06f",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8870184227692481392"
},
{
"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"
}
}
[10:49:04.062] Scheduled build:
{
"id": "8704754165795204705",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-host-mac-x64"
},
"createdBy": "project:fuchsia",
"createTime": "2025-09-03T10:49:03.658276806Z",
"updateTime": "2025-09-03T10:49:03.658276806Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "3576f05db125006ffbe22bfc199a269bf2a4a06f",
"ref": "refs/heads/main"
}
}
}
[10:49:04.062] Task URL: https://cr-buildbucket.appspot.com/build/8704754165795204705
[10:49:04.062] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-host-mac-x64-40be1bb5:8870184227692481392:2:0) after 3m39s
[10:49:04.957] Received PubSub notification, asking Buildbucket for the build status
[10:49:04.974] Build status: SCHEDULED
[10:49:59.965] Received PubSub notification, asking Buildbucket for the build status
[10:50:00.015] Build status: STARTED
[10:52:43.080] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-host-mac-x64-40be1bb5:8870184227692481392:2:0)
[10:52:43.114] Build status: STARTED
[10:52:43.114] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-host-mac-x64-40be1bb5:8870184227692481392:5:0) after 7m39s
[11:00:22.174] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-host-mac-x64-40be1bb5:8870184227692481392:5:0)
[11:00:22.200] Build status: STARTED
[11:00:22.200] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-host-mac-x64-40be1bb5:8870184227692481392:6:0) after 5m28s
[11:05:50.222] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-host-mac-x64-40be1bb5:8870184227692481392:6:0)
[11:05:50.237] Build status: STARTED
[11:05:50.237] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-host-mac-x64-40be1bb5:8870184227692481392:7:0) after 5m22s
[11:11:12.217] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-host-mac-x64-40be1bb5:8870184227692481392:7:0)
[11:11:12.234] Build status: STARTED
[11:11:12.234] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-host-mac-x64-40be1bb5:8870184227692481392:8:0) after 4m22s
[11:15:34.306] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-host-mac-x64-40be1bb5:8870184227692481392:8:0)
[11:15:34.326] Build status: STARTED
[11:15:34.326] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-host-mac-x64-40be1bb5:8870184227692481392:9:0) after 5m39s
[11:21:13.371] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-host-mac-x64-40be1bb5:8870184227692481392:9:0)
[11:21:13.400] Build status: STARTED
[11:21:13.400] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-host-mac-x64-40be1bb5:8870184227692481392:10:0) after 4m2s
[11:25:15.416] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-host-mac-x64-40be1bb5:8870184227692481392:10:0)
[11:25:15.436] Build status: STARTED
[11:25:15.436] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-host-mac-x64-40be1bb5:8870184227692481392:11:0) after 5m3s
[11:30:18.460] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-host-mac-x64-40be1bb5:8870184227692481392:11:0)
[11:30:18.477] Build status: STARTED
[11:30:18.477] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-host-mac-x64-40be1bb5:8870184227692481392:12:0) after 5m44s
[11:33:05.728] Received PubSub notification, asking Buildbucket for the build status
[11:33:05.746] Build:
{
"id": "8704754165795204705",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-host-mac-x64"
},
"createdBy": "project:fuchsia",
"createTime": "2025-09-03T10:49:03.658276806Z",
"startTime": "2025-09-03T10:49:59.792184108Z",
"endTime": "2025-09-03T11:33:05.419447893Z",
"updateTime": "2025-09-03T11:33:05.419447893Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "3576f05db125006ffbe22bfc199a269bf2a4a06f",
"ref": "refs/heads/main"
}
}
}
[11:33:05.746] Invocation finished in 44m3.280588826s with status SUCCEEDED