[23:19:53.235] New invocation is queued and will start shortly
[23:19:54.310] Starting the invocation (attempt 1)
[23:19:54.338] Popped buildset tag "buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/9855d546a4bfc607631d0e2aa5bae366d9483351"
[23:19:54.338] Popped gitiles commit info from properties and tags
[23:19:54.338] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[23:19:54.339] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[23:19:54.339] Buildbucket request:
{
"requestId": "8868959227985073280",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-mac-arm64"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8868959227985073280",
"job": "fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "22625538cb13df55cc2ff71831f55b8042f9a26c"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@22625538cb13df55cc2ff71831f55b8042f9a26c",
"title": "22625538cb13df55cc2ff71831f55b8042f9a26c",
"url": "https://llvm.googlesource.com/llvm-project/+/22625538cb13df55cc2ff71831f55b8042f9a26c"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "66524ee7d0fd0f932924f1927459d68d6375fdc3"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@66524ee7d0fd0f932924f1927459d68d6375fdc3",
"title": "66524ee7d0fd0f932924f1927459d68d6375fdc3",
"url": "https://llvm.googlesource.com/llvm-project/+/66524ee7d0fd0f932924f1927459d68d6375fdc3"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "59e43fe5d8588d4b77b2ebd5683e6206428743c9"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@59e43fe5d8588d4b77b2ebd5683e6206428743c9",
"title": "59e43fe5d8588d4b77b2ebd5683e6206428743c9",
"url": "https://llvm.googlesource.com/llvm-project/+/59e43fe5d8588d4b77b2ebd5683e6206428743c9"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "4ab8dabc252f802134bfea6193f9a274f0bdc143"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@4ab8dabc252f802134bfea6193f9a274f0bdc143",
"title": "4ab8dabc252f802134bfea6193f9a274f0bdc143",
"url": "https://llvm.googlesource.com/llvm-project/+/4ab8dabc252f802134bfea6193f9a274f0bdc143"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "0e5c32bd6d305f417d1b4fc023616711206eccc4"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@0e5c32bd6d305f417d1b4fc023616711206eccc4",
"title": "0e5c32bd6d305f417d1b4fc023616711206eccc4",
"url": "https://llvm.googlesource.com/llvm-project/+/0e5c32bd6d305f417d1b4fc023616711206eccc4"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "7c861bcedf61607b6c087380ac711eb7ff918ca6"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@7c861bcedf61607b6c087380ac711eb7ff918ca6",
"title": "7c861bcedf61607b6c087380ac711eb7ff918ca6",
"url": "https://llvm.googlesource.com/llvm-project/+/7c861bcedf61607b6c087380ac711eb7ff918ca6"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "9855d546a4bfc607631d0e2aa5bae366d9483351"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@9855d546a4bfc607631d0e2aa5bae366d9483351",
"title": "9855d546a4bfc607631d0e2aa5bae366d9483351",
"url": "https://llvm.googlesource.com/llvm-project/+/9855d546a4bfc607631d0e2aa5bae366d9483351"
}
]
}
},
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "9855d546a4bfc607631d0e2aa5bae366d9483351",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8868959227985073280"
},
{
"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"
}
}
[23:19:54.895] Scheduled build:
{
"id": "8703529166038081585",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-mac-arm64"
},
"createdBy": "project:fuchsia",
"createTime": "2025-09-16T23:19:54.464352022Z",
"updateTime": "2025-09-16T23:19:54.464352022Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "9855d546a4bfc607631d0e2aa5bae366d9483351",
"ref": "refs/heads/main"
}
}
}
[23:19:54.895] Task URL: https://cr-buildbucket.appspot.com/build/8703529166038081585
[23:19:54.895] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8868959227985073280:2:0) after 4m31s
[23:19:55.922] Received PubSub notification, asking Buildbucket for the build status
[23:19:55.956] Build status: SCHEDULED
[23:19:58.034] Received PubSub notification, asking Buildbucket for the build status
[23:19:58.117] Build status: STARTED
[23:24:25.902] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8868959227985073280:2:0)
[23:24:25.925] Build status: STARTED
[23:24:25.925] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8868959227985073280:5:0) after 2m8s
[23:26:33.966] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8868959227985073280:5:0)
[23:26:33.986] Build status: STARTED
[23:26:33.986] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8868959227985073280:6:0) after 2m27s
[23:29:01.004] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8868959227985073280:6:0)
[23:29:01.030] Build status: STARTED
[23:29:01.030] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8868959227985073280:7:0) after 1m52s
[23:30:53.041] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8868959227985073280:7:0)
[23:30:53.058] Build status: STARTED
[23:30:53.059] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8868959227985073280:8:0) after 7m23s
[23:38:16.111] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8868959227985073280:8:0)
[23:38:16.654] Build status: STARTED
[23:38:16.654] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8868959227985073280:9:0) after 4m0s
[23:42:16.721] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8868959227985073280:9:0)
[23:42:16.746] Build status: STARTED
[23:42:16.746] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8868959227985073280:10:0) after 3m51s
[23:46:07.767] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8868959227985073280:10:0)
[23:46:07.802] Build status: STARTED
[23:46:07.802] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8868959227985073280:11:0) after 8m4s
[23:54:11.837] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8868959227985073280:11:0)
[23:54:11.890] Build status: STARTED
[23:54:11.890] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8868959227985073280:12:0) after 9m53s
[00:04:04.990] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8868959227985073280:12:0)
[00:04:05.050] Build status: STARTED
[00:04:05.050] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8868959227985073280:13:0) after 8m38s
[00:12:43.210] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8868959227985073280:13:0)
[00:12:43.251] Build status: STARTED
[00:12:43.251] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8868959227985073280:14:0) after 8m23s
[00:21:06.369] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8868959227985073280:14:0)
[00:21:06.407] Build status: STARTED
[00:21:06.407] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8868959227985073280:15:0) after 8m50s
[00:29:56.386] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8868959227985073280:15:0)
[00:29:56.408] Build status: STARTED
[00:29:56.408] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8868959227985073280:16:0) after 3m39s
[00:33:35.455] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8868959227985073280:16:0)
[00:33:35.471] Build status: STARTED
[00:33:35.471] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8868959227985073280:17:0) after 3m7s
[00:36:42.590] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8868959227985073280:17:0)
[00:36:42.608] Build status: STARTED
[00:36:42.609] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8868959227985073280:18:0) after 8m22s
[00:45:04.705] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8868959227985073280:18:0)
[00:45:04.729] Build status: STARTED
[00:45:04.729] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8868959227985073280:19:0) after 6m50s
[00:51:54.747] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8868959227985073280:19:0)
[00:51:54.796] Build status: STARTED
[00:51:54.796] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8868959227985073280:20:0) after 6m54s
[00:58:48.818] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8868959227985073280:20:0)
[00:58:48.837] Build status: STARTED
[00:58:48.837] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8868959227985073280:21:0) after 5m7s
[01:03:55.543] Received PubSub notification, asking Buildbucket for the build status
[01:03:55.564] Build:
{
"id": "8703529166038081585",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-mac-arm64"
},
"createdBy": "project:fuchsia",
"createTime": "2025-09-16T23:19:54.464352022Z",
"startTime": "2025-09-16T23:19:57.865306344Z",
"endTime": "2025-09-17T01:03:54.769806570Z",
"updateTime": "2025-09-17T01:03:54.769806570Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "9855d546a4bfc607631d0e2aa5bae366d9483351",
"ref": "refs/heads/main"
}
}
}
[01:03:55.564] Invocation finished in 1h44m2.34017802s with status SUCCEEDED