[20:13:15.028] New invocation is queued and will start shortly
[20:13:16.200] Starting the invocation (attempt 1)
[20:13:16.231] Popped buildset tag "buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/e5e3e4bdb57efbfc0b2709d198d4ced752794bcd"
[20:13:16.231] Popped gitiles commit info from properties and tags
[20:13:16.231] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[20:13:16.231] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[20:13:16.232] Buildbucket request:
{
"requestId": "8871960670047956176",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-host-mac-x64"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8871960670047956176",
"job": "fuchsia/toolchain.ci-clang-host-mac-x64-40be1bb5",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "a508ea2ad7d9ab8bad0ec8fa3db3397985d57841"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@a508ea2ad7d9ab8bad0ec8fa3db3397985d57841",
"title": "a508ea2ad7d9ab8bad0ec8fa3db3397985d57841",
"url": "https://llvm.googlesource.com/llvm-project/+/a508ea2ad7d9ab8bad0ec8fa3db3397985d57841"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "eeada0d30f41b2d680073e49246ac0388e6c5ec7"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@eeada0d30f41b2d680073e49246ac0388e6c5ec7",
"title": "eeada0d30f41b2d680073e49246ac0388e6c5ec7",
"url": "https://llvm.googlesource.com/llvm-project/+/eeada0d30f41b2d680073e49246ac0388e6c5ec7"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "334a046a3cd31aaec00c4e4bb8866242c6e38c98"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@334a046a3cd31aaec00c4e4bb8866242c6e38c98",
"title": "334a046a3cd31aaec00c4e4bb8866242c6e38c98",
"url": "https://llvm.googlesource.com/llvm-project/+/334a046a3cd31aaec00c4e4bb8866242c6e38c98"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "49f20934776cccbed82ccdca657d9111bf550286"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@49f20934776cccbed82ccdca657d9111bf550286",
"title": "49f20934776cccbed82ccdca657d9111bf550286",
"url": "https://llvm.googlesource.com/llvm-project/+/49f20934776cccbed82ccdca657d9111bf550286"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "5479b7ed4200a85de3aa9335110883a86715811d"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@5479b7ed4200a85de3aa9335110883a86715811d",
"title": "5479b7ed4200a85de3aa9335110883a86715811d",
"url": "https://llvm.googlesource.com/llvm-project/+/5479b7ed4200a85de3aa9335110883a86715811d"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "aa4805a09052c1b6298718eeb6d30c33dd0d695f"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@aa4805a09052c1b6298718eeb6d30c33dd0d695f",
"title": "aa4805a09052c1b6298718eeb6d30c33dd0d695f",
"url": "https://llvm.googlesource.com/llvm-project/+/aa4805a09052c1b6298718eeb6d30c33dd0d695f"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "e5e3e4bdb57efbfc0b2709d198d4ced752794bcd"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@e5e3e4bdb57efbfc0b2709d198d4ced752794bcd",
"title": "e5e3e4bdb57efbfc0b2709d198d4ced752794bcd",
"url": "https://llvm.googlesource.com/llvm-project/+/e5e3e4bdb57efbfc0b2709d198d4ced752794bcd"
}
]
}
},
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "e5e3e4bdb57efbfc0b2709d198d4ced752794bcd",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8871960670047956176"
},
{
"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"
}
}
[20:13:16.885] Scheduled build:
{
"id": "8706530608053746209",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-host-mac-x64"
},
"createdBy": "project:fuchsia",
"createTime": "2025-08-14T20:13:16.302141582Z",
"updateTime": "2025-08-14T20:13:16.302141582Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "e5e3e4bdb57efbfc0b2709d198d4ced752794bcd",
"ref": "refs/heads/main"
}
}
}
[20:13:16.886] Task URL: https://cr-buildbucket.appspot.com/build/8706530608053746209
[20:13:16.886] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-host-mac-x64-40be1bb5:8871960670047956176:2:0) after 8m22s
[20:13:17.946] Received PubSub notification, asking Buildbucket for the build status
[20:13:17.989] Build status: SCHEDULED
[20:14:12.008] Received PubSub notification, asking Buildbucket for the build status
[20:14:12.045] Build status: STARTED
[20:21:38.993] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-host-mac-x64-40be1bb5:8871960670047956176:2:0)
[20:21:39.040] Build status: STARTED
[20:21:39.040] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-host-mac-x64-40be1bb5:8871960670047956176:5:0) after 2m57s
[20:24:36.106] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-host-mac-x64-40be1bb5:8871960670047956176:5:0)
[20:24:36.175] Build status: STARTED
[20:24:36.175] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-host-mac-x64-40be1bb5:8871960670047956176:6:0) after 3m27s
[20:28:03.254] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-host-mac-x64-40be1bb5:8871960670047956176:6:0)
[20:28:03.283] Build status: STARTED
[20:28:03.283] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-host-mac-x64-40be1bb5:8871960670047956176:7:0) after 5m15s
[20:33:18.263] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-host-mac-x64-40be1bb5:8871960670047956176:7:0)
[20:33:18.304] Build status: STARTED
[20:33:18.304] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-host-mac-x64-40be1bb5:8871960670047956176:8:0) after 9m41s
[20:42:59.368] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-host-mac-x64-40be1bb5:8871960670047956176:8:0)
[20:42:59.460] Build status: STARTED
[20:42:59.460] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-host-mac-x64-40be1bb5:8871960670047956176:9:0) after 1m7s
[20:44:06.499] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-host-mac-x64-40be1bb5:8871960670047956176:9:0)
[20:44:06.529] Build status: STARTED
[20:44:06.529] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-host-mac-x64-40be1bb5:8871960670047956176:10:0) after 7m5s
[20:51:11.537] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-host-mac-x64-40be1bb5:8871960670047956176:10:0)
[20:51:11.557] Build status: STARTED
[20:51:11.557] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-host-mac-x64-40be1bb5:8871960670047956176:11:0) after 7m7s
[20:57:26.998] Received PubSub notification, asking Buildbucket for the build status
[20:57:27.022] Build:
{
"id": "8706530608053746209",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-host-mac-x64"
},
"createdBy": "project:fuchsia",
"createTime": "2025-08-14T20:13:16.302141582Z",
"startTime": "2025-08-14T20:14:11.812558466Z",
"endTime": "2025-08-14T20:57:25.370050847Z",
"updateTime": "2025-08-14T20:57:25.370050847Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "e5e3e4bdb57efbfc0b2709d198d4ced752794bcd",
"ref": "refs/heads/main"
}
}
}
[20:57:27.022] Invocation finished in 44m12.0054192s with status SUCCEEDED