[02:34:30.483] New invocation is queued and will start shortly
[02:34:31.506] Starting the invocation (attempt 1)
[02:34:31.540] Popped buildset tag "buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/0f6a2db2594f5ffaf9bcd03f8233a850aa7d32af"
[02:34:31.540] Popped gitiles commit info from properties and tags
[02:34:31.540] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[02:34:31.542] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[02:34:31.542] Buildbucket request:
{
"requestId": "8874654592390399680",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-mac-arm64"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8874654592390399680",
"job": "fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "b1a93cfc32fbe912bb9b97796145501ea453d1bd"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@b1a93cfc32fbe912bb9b97796145501ea453d1bd",
"title": "b1a93cfc32fbe912bb9b97796145501ea453d1bd",
"url": "https://llvm.googlesource.com/llvm-project/+/b1a93cfc32fbe912bb9b97796145501ea453d1bd"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "386f73d4fb67649d5518d9a0cd5a49498bf608ca"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@386f73d4fb67649d5518d9a0cd5a49498bf608ca",
"title": "386f73d4fb67649d5518d9a0cd5a49498bf608ca",
"url": "https://llvm.googlesource.com/llvm-project/+/386f73d4fb67649d5518d9a0cd5a49498bf608ca"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "4b81dc75f4a5b8651d6a4c4ac8840049dc9ae289"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@4b81dc75f4a5b8651d6a4c4ac8840049dc9ae289",
"title": "4b81dc75f4a5b8651d6a4c4ac8840049dc9ae289",
"url": "https://llvm.googlesource.com/llvm-project/+/4b81dc75f4a5b8651d6a4c4ac8840049dc9ae289"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "01dd892734614cad30d7b50e5acc1c533a3fd39c"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@01dd892734614cad30d7b50e5acc1c533a3fd39c",
"title": "01dd892734614cad30d7b50e5acc1c533a3fd39c",
"url": "https://llvm.googlesource.com/llvm-project/+/01dd892734614cad30d7b50e5acc1c533a3fd39c"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "c962f2b29d55138d0b3849a7b8b557108188bb4f"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@c962f2b29d55138d0b3849a7b8b557108188bb4f",
"title": "c962f2b29d55138d0b3849a7b8b557108188bb4f",
"url": "https://llvm.googlesource.com/llvm-project/+/c962f2b29d55138d0b3849a7b8b557108188bb4f"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "36e4174989f866c9f97acb35c0d3b80ef61e9459"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@36e4174989f866c9f97acb35c0d3b80ef61e9459",
"title": "36e4174989f866c9f97acb35c0d3b80ef61e9459",
"url": "https://llvm.googlesource.com/llvm-project/+/36e4174989f866c9f97acb35c0d3b80ef61e9459"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "a87b8398f9e94ea363c170625e015074fecfd318"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@a87b8398f9e94ea363c170625e015074fecfd318",
"title": "a87b8398f9e94ea363c170625e015074fecfd318",
"url": "https://llvm.googlesource.com/llvm-project/+/a87b8398f9e94ea363c170625e015074fecfd318"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "5ff99f2757a62c52079397602dbd0c2e9d9f0ae7"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@5ff99f2757a62c52079397602dbd0c2e9d9f0ae7",
"title": "5ff99f2757a62c52079397602dbd0c2e9d9f0ae7",
"url": "https://llvm.googlesource.com/llvm-project/+/5ff99f2757a62c52079397602dbd0c2e9d9f0ae7"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "513a6465ba09d63ca179aa8122845e3abd5bd62b"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@513a6465ba09d63ca179aa8122845e3abd5bd62b",
"title": "513a6465ba09d63ca179aa8122845e3abd5bd62b",
"url": "https://llvm.googlesource.com/llvm-project/+/513a6465ba09d63ca179aa8122845e3abd5bd62b"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "0f6a2db2594f5ffaf9bcd03f8233a850aa7d32af"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@0f6a2db2594f5ffaf9bcd03f8233a850aa7d32af",
"title": "0f6a2db2594f5ffaf9bcd03f8233a850aa7d32af",
"url": "https://llvm.googlesource.com/llvm-project/+/0f6a2db2594f5ffaf9bcd03f8233a850aa7d32af"
}
]
}
},
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "0f6a2db2594f5ffaf9bcd03f8233a850aa7d32af",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8874654592390399680"
},
{
"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"
}
}
[02:34:31.969] Scheduled build:
{
"id": "8709224530547377377",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-mac-arm64"
},
"createdBy": "project:fuchsia",
"createTime": "2025-07-16T02:34:31.609344343Z",
"updateTime": "2025-07-16T02:34:31.609344343Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "0f6a2db2594f5ffaf9bcd03f8233a850aa7d32af",
"ref": "refs/heads/main"
}
}
}
[02:34:31.969] Task URL: https://cr-buildbucket.appspot.com/build/8709224530547377377
[02:34:31.969] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8874654592390399680:2:0) after 4m46s
[02:34:32.882] Received PubSub notification, asking Buildbucket for the build status
[02:34:32.908] Build status: SCHEDULED
[02:34:35.042] Received PubSub notification, asking Buildbucket for the build status
[02:34:35.066] Build status: STARTED
[02:39:17.987] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8874654592390399680:2:0)
[02:39:18.011] Build status: STARTED
[02:39:18.011] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8874654592390399680:5:0) after 1m27s
[02:40:45.029] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8874654592390399680:5:0)
[02:40:45.057] Build status: STARTED
[02:40:45.057] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8874654592390399680:6:0) after 3m44s
[02:44:29.085] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8874654592390399680:6:0)
[02:44:29.789] Build status: STARTED
[02:44:29.789] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8874654592390399680:7:0) after 1m43s
[02:46:12.859] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8874654592390399680:7:0)
[02:46:12.878] Build status: STARTED
[02:46:12.878] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8874654592390399680:8:0) after 9m37s
[02:55:49.971] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8874654592390399680:8:0)
[02:55:50.007] Build status: STARTED
[02:55:50.007] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8874654592390399680:9:0) after 3m15s
[02:59:05.026] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8874654592390399680:9:0)
[02:59:05.079] Build status: STARTED
[02:59:05.079] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8874654592390399680:10:0) after 3m26s
[03:02:31.215] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8874654592390399680:10:0)
[03:02:31.233] Build status: STARTED
[03:02:31.233] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8874654592390399680:11:0) after 7m2s
[03:09:33.256] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8874654592390399680:11:0)
[03:09:33.439] Build status: STARTED
[03:09:33.439] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8874654592390399680:12:0) after 6m13s
[03:15:46.467] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8874654592390399680:12:0)
[03:15:46.494] Build status: STARTED
[03:15:46.494] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8874654592390399680:13:0) after 9m45s
[03:25:31.512] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8874654592390399680:13:0)
[03:25:31.575] Build status: STARTED
[03:25:31.575] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8874654592390399680:14:0) after 3m3s
[03:28:34.597] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8874654592390399680:14:0)
[03:28:34.622] Build status: STARTED
[03:28:34.623] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8874654592390399680:15:0) after 3m40s
[03:32:14.649] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8874654592390399680:15:0)
[03:32:14.695] Build status: STARTED
[03:32:14.695] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8874654592390399680:16:0) after 3m16s
[03:35:30.773] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8874654592390399680:16:0)
[03:35:30.795] Build status: STARTED
[03:35:30.795] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8874654592390399680:17:0) after 8m20s
[03:43:50.822] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8874654592390399680:17:0)
[03:43:50.897] Build status: STARTED
[03:43:50.897] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8874654592390399680:18:0) after 1m6s
[03:44:56.922] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8874654592390399680:18:0)
[03:44:57.068] Build status: STARTED
[03:44:57.068] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8874654592390399680:19:0) after 3m15s
[03:48:12.092] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8874654592390399680:19:0)
[03:48:12.116] Build status: STARTED
[03:48:12.116] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8874654592390399680:20:0) after 2m22s
[03:50:34.113] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8874654592390399680:20:0)
[03:50:34.159] Build status: STARTED
[03:50:34.159] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8874654592390399680:21:0) after 9m58s
[04:00:32.211] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8874654592390399680:21:0)
[04:00:32.236] Build status: STARTED
[04:00:32.236] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8874654592390399680:22:0) after 7m17s
[04:07:49.283] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8874654592390399680:22:0)
[04:07:49.311] Build status: STARTED
[04:07:49.311] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8874654592390399680:23:0) after 6m8s
[04:13:57.314] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8874654592390399680:23:0)
[04:13:57.331] Build status: STARTED
[04:13:57.331] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8874654592390399680:24:0) after 4m8s
[04:17:11.181] Received PubSub notification, asking Buildbucket for the build status
[04:17:11.205] Build:
{
"id": "8709224530547377377",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-mac-arm64"
},
"createdBy": "project:fuchsia",
"createTime": "2025-07-16T02:34:31.609344343Z",
"startTime": "2025-07-16T02:34:34.805588621Z",
"endTime": "2025-07-16T04:17:10.614837805Z",
"updateTime": "2025-07-16T04:17:10.614837805Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "0f6a2db2594f5ffaf9bcd03f8233a850aa7d32af",
"ref": "refs/heads/main"
}
}
}
[04:17:11.205] Invocation finished in 1h42m40.738002533s with status SUCCEEDED