[15:51:22.288] New invocation is queued and will start shortly
[15:51:23.438] Starting the invocation (attempt 1)
[15:51:23.466] Popped buildset tag "buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/c5ea469f4dafe4c310ba26511575afda3569b0b5"
[15:51:23.466] Popped gitiles commit info from properties and tags
[15:51:23.466] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[15:51:23.466] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[15:51:23.466] Buildbucket request:
{
"requestId": "8888103406069084560",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-mac-arm64"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8888103406069084560",
"job": "fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "18ea6c928088cf9ad2a990bfcca546c608825a7f"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@18ea6c928088cf9ad2a990bfcca546c608825a7f",
"title": "18ea6c928088cf9ad2a990bfcca546c608825a7f",
"url": "https://llvm.googlesource.com/llvm-project/+/18ea6c928088cf9ad2a990bfcca546c608825a7f"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "4e41e9ac4c6fd1cb7f3aa3a42725727aff5aadd7"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@4e41e9ac4c6fd1cb7f3aa3a42725727aff5aadd7",
"title": "4e41e9ac4c6fd1cb7f3aa3a42725727aff5aadd7",
"url": "https://llvm.googlesource.com/llvm-project/+/4e41e9ac4c6fd1cb7f3aa3a42725727aff5aadd7"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "919e72f2513d57fc2105f6e3477c13eb1f0c6cba"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@919e72f2513d57fc2105f6e3477c13eb1f0c6cba",
"title": "919e72f2513d57fc2105f6e3477c13eb1f0c6cba",
"url": "https://llvm.googlesource.com/llvm-project/+/919e72f2513d57fc2105f6e3477c13eb1f0c6cba"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "9d487050a144b895950a6fd48b993513a714e69d"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@9d487050a144b895950a6fd48b993513a714e69d",
"title": "9d487050a144b895950a6fd48b993513a714e69d",
"url": "https://llvm.googlesource.com/llvm-project/+/9d487050a144b895950a6fd48b993513a714e69d"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "ab2d330feab3e1d9927a3c0de1a9d6e9bda5abe9"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@ab2d330feab3e1d9927a3c0de1a9d6e9bda5abe9",
"title": "ab2d330feab3e1d9927a3c0de1a9d6e9bda5abe9",
"url": "https://llvm.googlesource.com/llvm-project/+/ab2d330feab3e1d9927a3c0de1a9d6e9bda5abe9"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "fb29f19fdb0b2b3c8c87cc767482d941818e92a8"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@fb29f19fdb0b2b3c8c87cc767482d941818e92a8",
"title": "fb29f19fdb0b2b3c8c87cc767482d941818e92a8",
"url": "https://llvm.googlesource.com/llvm-project/+/fb29f19fdb0b2b3c8c87cc767482d941818e92a8"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "ec544035227bd88e3622b85ba70499cb0e62b2bc"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@ec544035227bd88e3622b85ba70499cb0e62b2bc",
"title": "ec544035227bd88e3622b85ba70499cb0e62b2bc",
"url": "https://llvm.googlesource.com/llvm-project/+/ec544035227bd88e3622b85ba70499cb0e62b2bc"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "788cb725d8b92a82e41e64540dccca97c9086a58"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@788cb725d8b92a82e41e64540dccca97c9086a58",
"title": "788cb725d8b92a82e41e64540dccca97c9086a58",
"url": "https://llvm.googlesource.com/llvm-project/+/788cb725d8b92a82e41e64540dccca97c9086a58"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "6c627831f9a4ba5d9680cc83d610c1894a84908a"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@6c627831f9a4ba5d9680cc83d610c1894a84908a",
"title": "6c627831f9a4ba5d9680cc83d610c1894a84908a",
"url": "https://llvm.googlesource.com/llvm-project/+/6c627831f9a4ba5d9680cc83d610c1894a84908a"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "c5ea469f4dafe4c310ba26511575afda3569b0b5"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@c5ea469f4dafe4c310ba26511575afda3569b0b5",
"title": "c5ea469f4dafe4c310ba26511575afda3569b0b5",
"url": "https://llvm.googlesource.com/llvm-project/+/c5ea469f4dafe4c310ba26511575afda3569b0b5"
}
]
}
},
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "c5ea469f4dafe4c310ba26511575afda3569b0b5",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8888103406069084560"
},
{
"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"
}
}
[15:51:23.826] Scheduled build:
{
"id": "8722673344123450065",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-mac-arm64"
},
"createdBy": "project:fuchsia",
"createTime": "2025-02-17T15:51:23.516268331Z",
"updateTime": "2025-02-17T15:51:23.516268331Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "c5ea469f4dafe4c310ba26511575afda3569b0b5",
"ref": "refs/heads/main"
}
}
}
[15:51:23.826] Task URL: https://cr-buildbucket.appspot.com/build/8722673344123450065
[15:51:23.826] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8888103406069084560:2:0) after 5m57s
[15:51:24.819] Received PubSub notification, asking Buildbucket for the build status
[15:51:24.843] Build status: SCHEDULED
[15:51:30.208] Received PubSub notification, asking Buildbucket for the build status
[15:51:30.233] Build status: STARTED
[15:57:20.979] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8888103406069084560:2:0)
[15:57:21.006] Build status: STARTED
[15:57:21.006] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8888103406069084560:5:0) after 1m50s
[15:59:11.425] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8888103406069084560:5:0)
[15:59:11.449] Build status: STARTED
[15:59:11.449] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8888103406069084560:6:0) after 2m39s
[16:01:50.552] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8888103406069084560:6:0)
[16:01:50.576] Build status: STARTED
[16:01:50.576] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8888103406069084560:7:0) after 9m25s
[16:11:15.696] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8888103406069084560:7:0)
[16:11:15.724] Build status: STARTED
[16:11:15.724] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8888103406069084560:8:0) after 3m27s
[16:14:42.745] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8888103406069084560:8:0)
[16:14:42.767] Build status: STARTED
[16:14:42.767] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8888103406069084560:9:0) after 8m39s
[16:23:21.976] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8888103406069084560:9:0)
[16:23:22.007] Build status: STARTED
[16:23:22.007] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8888103406069084560:10:0) after 2m26s
[16:25:48.037] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8888103406069084560:10:0)
[16:25:48.067] Build status: STARTED
[16:25:48.067] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8888103406069084560:11:0) after 6m54s
[16:32:42.215] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8888103406069084560:11:0)
[16:32:42.242] Build status: STARTED
[16:32:42.242] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8888103406069084560:12:0) after 9m35s
[16:42:17.268] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8888103406069084560:12:0)
[16:42:17.295] Build status: STARTED
[16:42:17.295] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8888103406069084560:13:0) after 6m23s
[16:48:40.314] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8888103406069084560:13:0)
[16:48:40.342] Build status: STARTED
[16:48:40.342] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8888103406069084560:14:0) after 2m57s
[16:51:37.453] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8888103406069084560:14:0)
[16:51:37.475] Build status: STARTED
[16:51:37.475] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8888103406069084560:15:0) after 9m58s
[17:01:35.610] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8888103406069084560:15:0)
[17:01:35.654] Build status: STARTED
[17:01:35.654] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8888103406069084560:16:0) after 6m3s
[17:07:38.903] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8888103406069084560:16:0)
[17:07:38.993] Build status: STARTED
[17:07:38.993] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8888103406069084560:17:0) after 4m50s
[17:12:29.010] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8888103406069084560:17:0)
[17:12:29.058] Build status: STARTED
[17:12:29.059] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8888103406069084560:18:0) after 7m28s
[17:19:57.779] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8888103406069084560:18:0)
[17:19:57.855] Build status: STARTED
[17:19:57.855] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8888103406069084560:19:0) after 8m12s
[17:28:10.257] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8888103406069084560:19:0)
[17:28:10.271] Build status: STARTED
[17:28:10.271] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8888103406069084560:20:0) after 7m52s
[17:36:02.292] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8888103406069084560:20:0)
[17:36:02.309] Build status: STARTED
[17:36:02.309] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8888103406069084560:21:0) after 5m7s
[17:38:08.208] Received PubSub notification, asking Buildbucket for the build status
[17:38:08.233] Build:
{
"id": "8722673344123450065",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-mac-arm64"
},
"createdBy": "project:fuchsia",
"createTime": "2025-02-17T15:51:23.516268331Z",
"startTime": "2025-02-17T15:51:29.750257655Z",
"endTime": "2025-02-17T17:38:07.301453886Z",
"updateTime": "2025-02-17T17:38:07.301453886Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "c5ea469f4dafe4c310ba26511575afda3569b0b5",
"ref": "refs/heads/main"
}
}
}
[17:38:08.233] Invocation finished in 1h46m45.955879802s with status SUCCEEDED