[10:45:42.172] New invocation is queued and will start shortly
[10:45:43.251] Starting the invocation (attempt 1)
[10:45:43.279] Popped buildset tag "buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/fd8b84ea0fa1eb1da105257f419d926278dc0445"
[10:45:43.279] Popped gitiles commit info from properties and tags
[10:45:43.279] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[10:45:43.281] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[10:45:43.281] Buildbucket request:
{
"requestId": "8880784282789059840",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-mac-arm64"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8880784282789059840",
"job": "fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "95d440cc7c398dbba8ac27af8e1690460b4e88bf"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@95d440cc7c398dbba8ac27af8e1690460b4e88bf",
"title": "95d440cc7c398dbba8ac27af8e1690460b4e88bf",
"url": "https://llvm.googlesource.com/llvm-project/+/95d440cc7c398dbba8ac27af8e1690460b4e88bf"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "36bb17aa6544c1f62309a6162555262f282e1d13"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@36bb17aa6544c1f62309a6162555262f282e1d13",
"title": "36bb17aa6544c1f62309a6162555262f282e1d13",
"url": "https://llvm.googlesource.com/llvm-project/+/36bb17aa6544c1f62309a6162555262f282e1d13"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "cdde6a650a0773e672c81b61aa53d9af2c92d2b2"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@cdde6a650a0773e672c81b61aa53d9af2c92d2b2",
"title": "cdde6a650a0773e672c81b61aa53d9af2c92d2b2",
"url": "https://llvm.googlesource.com/llvm-project/+/cdde6a650a0773e672c81b61aa53d9af2c92d2b2"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "66d3980b53086f787d0236814c3cc34fc568e25e"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@66d3980b53086f787d0236814c3cc34fc568e25e",
"title": "66d3980b53086f787d0236814c3cc34fc568e25e",
"url": "https://llvm.googlesource.com/llvm-project/+/66d3980b53086f787d0236814c3cc34fc568e25e"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "370aecb9572477f7b6bdd6243c80b53f384e0b84"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@370aecb9572477f7b6bdd6243c80b53f384e0b84",
"title": "370aecb9572477f7b6bdd6243c80b53f384e0b84",
"url": "https://llvm.googlesource.com/llvm-project/+/370aecb9572477f7b6bdd6243c80b53f384e0b84"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "c255a313374384b8444c83ec33094d7c806d4b2a"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@c255a313374384b8444c83ec33094d7c806d4b2a",
"title": "c255a313374384b8444c83ec33094d7c806d4b2a",
"url": "https://llvm.googlesource.com/llvm-project/+/c255a313374384b8444c83ec33094d7c806d4b2a"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "e854c381c6344b2ff8d1b58aa97008b4ecd9a9c5"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@e854c381c6344b2ff8d1b58aa97008b4ecd9a9c5",
"title": "e854c381c6344b2ff8d1b58aa97008b4ecd9a9c5",
"url": "https://llvm.googlesource.com/llvm-project/+/e854c381c6344b2ff8d1b58aa97008b4ecd9a9c5"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "89d13f87c736d1a341959d03f3f9e5e65b95ebf5"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@89d13f87c736d1a341959d03f3f9e5e65b95ebf5",
"title": "89d13f87c736d1a341959d03f3f9e5e65b95ebf5",
"url": "https://llvm.googlesource.com/llvm-project/+/89d13f87c736d1a341959d03f3f9e5e65b95ebf5"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "234ae9bfd97e6942193d152ae57ebba5d1b7c584"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@234ae9bfd97e6942193d152ae57ebba5d1b7c584",
"title": "234ae9bfd97e6942193d152ae57ebba5d1b7c584",
"url": "https://llvm.googlesource.com/llvm-project/+/234ae9bfd97e6942193d152ae57ebba5d1b7c584"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "fd8b84ea0fa1eb1da105257f419d926278dc0445"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@fd8b84ea0fa1eb1da105257f419d926278dc0445",
"title": "fd8b84ea0fa1eb1da105257f419d926278dc0445",
"url": "https://llvm.googlesource.com/llvm-project/+/fd8b84ea0fa1eb1da105257f419d926278dc0445"
}
]
}
},
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "fd8b84ea0fa1eb1da105257f419d926278dc0445",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8880784282789059840"
},
{
"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"
}
}
[10:45:43.724] Scheduled build:
{
"id": "8715354220919007457",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-mac-arm64"
},
"createdBy": "project:fuchsia",
"createTime": "2025-05-09T10:45:43.334248366Z",
"updateTime": "2025-05-09T10:45:43.334248366Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "fd8b84ea0fa1eb1da105257f419d926278dc0445",
"ref": "refs/heads/main"
}
}
}
[10:45:43.724] Task URL: https://cr-buildbucket.appspot.com/build/8715354220919007457
[10:45:43.724] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8880784282789059840:2:0) after 5m15s
[10:45:44.685] Received PubSub notification, asking Buildbucket for the build status
[10:45:44.712] Build status: SCHEDULED
[10:45:48.218] Received PubSub notification, asking Buildbucket for the build status
[10:45:48.235] Build status: STARTED
[10:50:58.889] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8880784282789059840:2:0)
[10:50:58.913] Build status: STARTED
[10:50:58.914] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8880784282789059840:5:0) after 7m11s
[10:58:09.942] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8880784282789059840:5:0)
[10:58:09.964] Build status: STARTED
[10:58:09.964] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8880784282789059840:6:0) after 7m35s
[11:05:44.987] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8880784282789059840:6:0)
[11:05:45.018] Build status: STARTED
[11:05:45.018] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8880784282789059840:7:0) after 6m10s
[11:11:55.119] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8880784282789059840:7:0)
[11:11:55.149] Build status: STARTED
[11:11:55.149] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8880784282789059840:8:0) after 8m54s
[11:20:49.302] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8880784282789059840:8:0)
[11:20:49.328] Build status: STARTED
[11:20:49.328] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8880784282789059840:9:0) after 4m28s
[11:25:17.319] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8880784282789059840:9:0)
[11:25:17.481] Build status: STARTED
[11:25:17.481] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8880784282789059840:10:0) after 9m44s
[11:35:01.661] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8880784282789059840:10:0)
[11:35:01.688] Build status: STARTED
[11:35:01.688] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8880784282789059840:11:0) after 7m33s
[11:42:34.767] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8880784282789059840:11:0)
[11:42:34.801] Build status: STARTED
[11:42:34.801] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8880784282789059840:12:0) after 4m10s
[11:46:44.992] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8880784282789059840:12:0)
[11:46:45.015] Build status: STARTED
[11:46:45.015] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8880784282789059840:13:0) after 6m41s
[11:53:26.034] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8880784282789059840:13:0)
[11:53:26.052] Build status: STARTED
[11:53:26.052] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8880784282789059840:14:0) after 2m14s
[11:55:40.112] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8880784282789059840:14:0)
[11:55:40.128] Build status: STARTED
[11:55:40.128] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8880784282789059840:15:0) after 6m54s
[12:02:34.161] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8880784282789059840:15:0)
[12:02:34.194] Build status: STARTED
[12:02:34.194] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8880784282789059840:16:0) after 1m37s
[12:04:11.313] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8880784282789059840:16:0)
[12:04:11.345] Build status: STARTED
[12:04:11.345] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8880784282789059840:17:0) after 7m20s
[12:11:31.398] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8880784282789059840:17:0)
[12:11:31.421] Build status: STARTED
[12:11:31.421] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8880784282789059840:18:0) after 8m4s
[12:19:35.439] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8880784282789059840:18:0)
[12:19:35.460] Build status: STARTED
[12:19:35.460] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8880784282789059840:19:0) after 4m55s
[12:24:30.527] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8880784282789059840:19:0)
[12:24:30.546] Build status: STARTED
[12:24:30.546] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8880784282789059840:20:0) after 7m18s
[12:31:48.559] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8880784282789059840:20:0)
[12:31:48.581] Build status: STARTED
[12:31:48.581] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8880784282789059840:21:0) after 3m34s
[12:34:08.360] Received PubSub notification, asking Buildbucket for the build status
[12:34:08.375] Build:
{
"id": "8715354220919007457",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-mac-arm64"
},
"createdBy": "project:fuchsia",
"createTime": "2025-05-09T10:45:43.334248366Z",
"startTime": "2025-05-09T10:45:48.010378634Z",
"endTime": "2025-05-09T12:34:07.994018323Z",
"updateTime": "2025-05-09T12:34:07.994018323Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "fd8b84ea0fa1eb1da105257f419d926278dc0445",
"ref": "refs/heads/main"
}
}
}
[12:34:08.375] Invocation finished in 1h48m26.208695842s with status SUCCEEDED