[01:57:08.447] New invocation is queued and will start shortly
[01:57:09.806] Starting the invocation (attempt 1)
[01:57:09.833] Popped buildset tag "buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/f0befb0dcda4e908f6cd0b771753a36cc5fb980f"
[01:57:09.833] Popped gitiles commit info from properties and tags
[01:57:09.833] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[01:57:09.833] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[01:57:09.834] Buildbucket request:
{
"requestId": "8875109928159875408",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-mac-arm64"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8875109928159875408",
"job": "fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "c0b82df5f3484870d3728156da7d7e3720ef53ad"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@c0b82df5f3484870d3728156da7d7e3720ef53ad",
"title": "c0b82df5f3484870d3728156da7d7e3720ef53ad",
"url": "https://llvm.googlesource.com/llvm-project/+/c0b82df5f3484870d3728156da7d7e3720ef53ad"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "7d510b7f21d1b5da2d84c8e3f7003a27b34e021d"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@7d510b7f21d1b5da2d84c8e3f7003a27b34e021d",
"title": "7d510b7f21d1b5da2d84c8e3f7003a27b34e021d",
"url": "https://llvm.googlesource.com/llvm-project/+/7d510b7f21d1b5da2d84c8e3f7003a27b34e021d"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "1f990f0c2d33a1ed230306b3678d1f1d0d5db995"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@1f990f0c2d33a1ed230306b3678d1f1d0d5db995",
"title": "1f990f0c2d33a1ed230306b3678d1f1d0d5db995",
"url": "https://llvm.googlesource.com/llvm-project/+/1f990f0c2d33a1ed230306b3678d1f1d0d5db995"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "eba513054417bd3d7b68724fb564d3e2f4e1bd31"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@eba513054417bd3d7b68724fb564d3e2f4e1bd31",
"title": "eba513054417bd3d7b68724fb564d3e2f4e1bd31",
"url": "https://llvm.googlesource.com/llvm-project/+/eba513054417bd3d7b68724fb564d3e2f4e1bd31"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "34a1daae8390184a7f7072c49a5f47ce24287d59"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@34a1daae8390184a7f7072c49a5f47ce24287d59",
"title": "34a1daae8390184a7f7072c49a5f47ce24287d59",
"url": "https://llvm.googlesource.com/llvm-project/+/34a1daae8390184a7f7072c49a5f47ce24287d59"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "7704f817d0a60596c4c8883c8a8ece67f0a8255a"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@7704f817d0a60596c4c8883c8a8ece67f0a8255a",
"title": "7704f817d0a60596c4c8883c8a8ece67f0a8255a",
"url": "https://llvm.googlesource.com/llvm-project/+/7704f817d0a60596c4c8883c8a8ece67f0a8255a"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "cb52efb8936c0da0a03958daa95d45eaaf8806fb"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@cb52efb8936c0da0a03958daa95d45eaaf8806fb",
"title": "cb52efb8936c0da0a03958daa95d45eaaf8806fb",
"url": "https://llvm.googlesource.com/llvm-project/+/cb52efb8936c0da0a03958daa95d45eaaf8806fb"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "aa4c8564c5df217bf589fed21dc009e21c3e9ca5"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@aa4c8564c5df217bf589fed21dc009e21c3e9ca5",
"title": "aa4c8564c5df217bf589fed21dc009e21c3e9ca5",
"url": "https://llvm.googlesource.com/llvm-project/+/aa4c8564c5df217bf589fed21dc009e21c3e9ca5"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "f0befb0dcda4e908f6cd0b771753a36cc5fb980f"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@f0befb0dcda4e908f6cd0b771753a36cc5fb980f",
"title": "f0befb0dcda4e908f6cd0b771753a36cc5fb980f",
"url": "https://llvm.googlesource.com/llvm-project/+/f0befb0dcda4e908f6cd0b771753a36cc5fb980f"
}
]
}
},
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "f0befb0dcda4e908f6cd0b771753a36cc5fb980f",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8875109928159875408"
},
{
"key": "scheduler_job_id",
"value": "fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[01:57:10.299] Scheduled build:
{
"id": "8709679865934783201",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-mac-arm64"
},
"createdBy": "project:fuchsia",
"createTime": "2025-07-11T01:57:09.945238915Z",
"updateTime": "2025-07-11T01:57:09.945238915Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "f0befb0dcda4e908f6cd0b771753a36cc5fb980f",
"ref": "refs/heads/main"
}
}
}
[01:57:10.299] Task URL: https://cr-buildbucket.appspot.com/build/8709679865934783201
[01:57:10.299] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8875109928159875408:2:0) after 8m29s
[01:57:11.333] Received PubSub notification, asking Buildbucket for the build status
[01:57:11.354] Build status: SCHEDULED
[01:57:13.367] Received PubSub notification, asking Buildbucket for the build status
[01:57:13.416] Build status: STARTED
[02:05:39.322] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8875109928159875408:2:0)
[02:05:39.346] Build status: STARTED
[02:05:39.346] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8875109928159875408:5:0) after 4m46s
[02:10:25.470] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8875109928159875408:5:0)
[02:10:25.500] Build status: STARTED
[02:10:25.500] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8875109928159875408:6:0) after 4m25s
[02:14:50.527] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8875109928159875408:6:0)
[02:14:50.562] Build status: STARTED
[02:14:50.562] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8875109928159875408:7:0) after 3m3s
[02:17:53.691] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8875109928159875408:7:0)
[02:17:53.734] Build status: STARTED
[02:17:53.734] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8875109928159875408:8:0) after 2m57s
[02:20:50.806] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8875109928159875408:8:0)
[02:20:50.872] Build status: STARTED
[02:20:50.872] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8875109928159875408:9:0) after 5m1s
[02:25:51.895] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8875109928159875408:9:0)
[02:25:51.927] Build status: STARTED
[02:25:51.927] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8875109928159875408:10:0) after 4m25s
[02:30:16.900] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8875109928159875408:10:0)
[02:30:16.929] Build status: STARTED
[02:30:16.929] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8875109928159875408:11:0) after 9m8s
[02:39:24.942] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8875109928159875408:11:0)
[02:39:24.967] Build status: STARTED
[02:39:24.967] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8875109928159875408:12:0) after 4m40s
[02:44:04.972] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8875109928159875408:12:0)
[02:44:05.007] Build status: STARTED
[02:44:05.008] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8875109928159875408:13:0) after 8m20s
[02:52:24.997] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8875109928159875408:13:0)
[02:52:25.017] Build status: STARTED
[02:52:25.017] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8875109928159875408:14:0) after 7m44s
[03:00:09.155] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8875109928159875408:14:0)
[03:00:09.225] Build status: STARTED
[03:00:09.225] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8875109928159875408:15:0) after 3m58s
[03:04:07.243] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8875109928159875408:15:0)
[03:04:07.321] Build status: STARTED
[03:04:07.322] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8875109928159875408:16:0) after 9m24s
[03:13:31.543] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8875109928159875408:16:0)
[03:13:31.584] Build status: STARTED
[03:13:31.584] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8875109928159875408:17:0) after 1m18s
[03:14:49.605] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8875109928159875408:17:0)
[03:14:49.624] Build status: STARTED
[03:14:49.624] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8875109928159875408:18:0) after 9m0s
[03:23:49.639] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8875109928159875408:18:0)
[03:23:49.659] Build status: STARTED
[03:23:49.659] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8875109928159875408:19:0) after 1m12s
[03:25:01.686] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8875109928159875408:19:0)
[03:25:01.716] Build status: STARTED
[03:25:01.716] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8875109928159875408:20:0) after 8m46s
[03:33:47.702] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8875109928159875408:20:0)
[03:33:47.834] Build status: STARTED
[03:33:47.834] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8875109928159875408:21:0) after 2m42s
[03:36:29.962] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8875109928159875408:21:0)
[03:36:29.984] Build status: STARTED
[03:36:29.984] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8875109928159875408:22:0) after 8m41s
[03:39:44.407] Received PubSub notification, asking Buildbucket for the build status
[03:39:44.439] Build:
{
"id": "8709679865934783201",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-mac-arm64"
},
"createdBy": "project:fuchsia",
"createTime": "2025-07-11T01:57:09.945238915Z",
"startTime": "2025-07-11T01:57:13.141533296Z",
"endTime": "2025-07-11T03:39:44.078131638Z",
"updateTime": "2025-07-11T03:39:44.078131638Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "f0befb0dcda4e908f6cd0b771753a36cc5fb980f",
"ref": "refs/heads/main"
}
}
}
[03:39:44.439] Invocation finished in 1h42m36.000188072s with status SUCCEEDED