[00:08:54.772] New invocation is queued and will start shortly
[00:08:56.167] Starting the invocation (attempt 1)
[00:08:56.193] Popped buildset tag "buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/f671e1698cbdfe02108486ae567f87eea7a05d61"
[00:08:56.193] Popped gitiles commit info from properties and tags
[00:08:56.193] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[00:08:56.193] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[00:08:56.193] Buildbucket request:
{
"requestId": "8877925243235958496",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-mac-arm64"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8877925243235958496",
"job": "fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "f5e499a3383c1e3b9f60e60151075e8d9c1c3166"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@f5e499a3383c1e3b9f60e60151075e8d9c1c3166",
"title": "f5e499a3383c1e3b9f60e60151075e8d9c1c3166",
"url": "https://llvm.googlesource.com/llvm-project/+/f5e499a3383c1e3b9f60e60151075e8d9c1c3166"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "55858527da9e33063b45e60fd90619df85ea6f7e"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@55858527da9e33063b45e60fd90619df85ea6f7e",
"title": "55858527da9e33063b45e60fd90619df85ea6f7e",
"url": "https://llvm.googlesource.com/llvm-project/+/55858527da9e33063b45e60fd90619df85ea6f7e"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "ba7c6468a527415f330e162d7d88f0a70185e711"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@ba7c6468a527415f330e162d7d88f0a70185e711",
"title": "ba7c6468a527415f330e162d7d88f0a70185e711",
"url": "https://llvm.googlesource.com/llvm-project/+/ba7c6468a527415f330e162d7d88f0a70185e711"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "a8c2b431c7bccceff11fe961fe22974826b46667"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@a8c2b431c7bccceff11fe961fe22974826b46667",
"title": "a8c2b431c7bccceff11fe961fe22974826b46667",
"url": "https://llvm.googlesource.com/llvm-project/+/a8c2b431c7bccceff11fe961fe22974826b46667"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "4e6896244f4129a22e311f7f6290a595b6f03b75"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@4e6896244f4129a22e311f7f6290a595b6f03b75",
"title": "4e6896244f4129a22e311f7f6290a595b6f03b75",
"url": "https://llvm.googlesource.com/llvm-project/+/4e6896244f4129a22e311f7f6290a595b6f03b75"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "c9cf5c26d8d71bf58cb7ae759a615b6de1074e53"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@c9cf5c26d8d71bf58cb7ae759a615b6de1074e53",
"title": "c9cf5c26d8d71bf58cb7ae759a615b6de1074e53",
"url": "https://llvm.googlesource.com/llvm-project/+/c9cf5c26d8d71bf58cb7ae759a615b6de1074e53"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "d099d953ef7c9ad24512068f579cc868e1ee468f"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@d099d953ef7c9ad24512068f579cc868e1ee468f",
"title": "d099d953ef7c9ad24512068f579cc868e1ee468f",
"url": "https://llvm.googlesource.com/llvm-project/+/d099d953ef7c9ad24512068f579cc868e1ee468f"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "474db6a85257612a2e878320d0bae51cb884d4f9"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@474db6a85257612a2e878320d0bae51cb884d4f9",
"title": "474db6a85257612a2e878320d0bae51cb884d4f9",
"url": "https://llvm.googlesource.com/llvm-project/+/474db6a85257612a2e878320d0bae51cb884d4f9"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "ce4a7c4a66c86010927e54e5bf760c5a88de5396"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@ce4a7c4a66c86010927e54e5bf760c5a88de5396",
"title": "ce4a7c4a66c86010927e54e5bf760c5a88de5396",
"url": "https://llvm.googlesource.com/llvm-project/+/ce4a7c4a66c86010927e54e5bf760c5a88de5396"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "b3837f139235fe943ff9b7ccef44d11d568c4b81"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@b3837f139235fe943ff9b7ccef44d11d568c4b81",
"title": "b3837f139235fe943ff9b7ccef44d11d568c4b81",
"url": "https://llvm.googlesource.com/llvm-project/+/b3837f139235fe943ff9b7ccef44d11d568c4b81"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "f671e1698cbdfe02108486ae567f87eea7a05d61"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@f671e1698cbdfe02108486ae567f87eea7a05d61",
"title": "f671e1698cbdfe02108486ae567f87eea7a05d61",
"url": "https://llvm.googlesource.com/llvm-project/+/f671e1698cbdfe02108486ae567f87eea7a05d61"
}
]
}
},
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "f671e1698cbdfe02108486ae567f87eea7a05d61",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8877925243235958496"
},
{
"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"
}
}
[00:08:56.623] Scheduled build:
{
"id": "8712495180970420497",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-mac-arm64"
},
"createdBy": "project:fuchsia",
"createTime": "2025-06-10T00:08:56.303087342Z",
"updateTime": "2025-06-10T00:08:56.303087342Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "f671e1698cbdfe02108486ae567f87eea7a05d61",
"ref": "refs/heads/main"
}
}
}
[00:08:56.623] Task URL: https://cr-buildbucket.appspot.com/build/8712495180970420497
[00:08:56.623] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8877925243235958496:2:0) after 4m20s
[00:08:56.705] Received PubSub notification, asking Buildbucket for the build status
[00:08:56.730] Build status: SCHEDULED
[00:09:00.007] Received PubSub notification, asking Buildbucket for the build status
[00:09:00.037] Build status: STARTED
[00:13:16.690] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8877925243235958496:2:0)
[00:13:16.713] Build status: STARTED
[00:13:16.713] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8877925243235958496:5:0) after 1m6s
[00:14:22.881] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8877925243235958496:5:0)
[00:14:22.910] Build status: STARTED
[00:14:22.910] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8877925243235958496:6:0) after 8m46s
[00:23:08.940] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8877925243235958496:6:0)
[00:23:09.005] Build status: STARTED
[00:23:09.005] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8877925243235958496:7:0) after 5m30s
[00:28:39.027] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8877925243235958496:7:0)
[00:28:39.066] Build status: STARTED
[00:28:39.066] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8877925243235958496:8:0) after 7m41s
[00:36:20.082] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8877925243235958496:8:0)
[00:36:20.112] Build status: STARTED
[00:36:20.113] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8877925243235958496:9:0) after 1m45s
[00:38:05.148] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8877925243235958496:9:0)
[00:38:05.174] Build status: STARTED
[00:38:05.174] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8877925243235958496:10:0) after 5m40s
[00:43:45.198] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8877925243235958496:10:0)
[00:43:45.235] Build status: STARTED
[00:43:45.235] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8877925243235958496:11:0) after 3m57s
[00:47:42.261] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8877925243235958496:11:0)
[00:47:42.308] Build status: STARTED
[00:47:42.308] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8877925243235958496:12:0) after 1m48s
[00:49:30.321] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8877925243235958496:12:0)
[00:49:30.347] Build status: STARTED
[00:49:30.347] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8877925243235958496:13:0) after 4m27s
[00:53:57.557] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8877925243235958496:13:0)
[00:53:57.585] Build status: STARTED
[00:53:57.585] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8877925243235958496:14:0) after 2m27s
[00:56:24.624] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8877925243235958496:14:0)
[00:56:24.715] Build status: STARTED
[00:56:24.715] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8877925243235958496:15:0) after 4m29s
[01:00:53.729] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8877925243235958496:15:0)
[01:00:53.748] Build status: STARTED
[01:00:53.748] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8877925243235958496:16:0) after 8m51s
[01:09:44.774] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8877925243235958496:16:0)
[01:09:44.816] Build status: STARTED
[01:09:44.816] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8877925243235958496:17:0) after 6m53s
[01:16:37.874] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8877925243235958496:17:0)
[01:16:37.891] Build status: STARTED
[01:16:37.891] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8877925243235958496:18:0) after 7m50s
[01:24:27.966] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8877925243235958496:18:0)
[01:24:28.037] Build status: STARTED
[01:24:28.037] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8877925243235958496:19:0) after 4m59s
[01:29:27.056] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8877925243235958496:19:0)
[01:29:27.412] Build status: STARTED
[01:29:27.412] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8877925243235958496:20:0) after 4m0s
[01:33:27.433] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8877925243235958496:20:0)
[01:33:27.450] Build status: STARTED
[01:33:27.450] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8877925243235958496:21:0) after 8m20s
[01:41:47.463] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8877925243235958496:21:0)
[01:41:47.482] Build status: STARTED
[01:41:47.482] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8877925243235958496:22:0) after 3m15s
[01:45:02.528] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8877925243235958496:22:0)
[01:45:02.573] Build status: STARTED
[01:45:02.573] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8877925243235958496:23:0) after 1m15s
[01:46:17.767] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8877925243235958496:23:0)
[01:46:17.792] Build status: STARTED
[01:46:17.792] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8877925243235958496:24:0) after 1m37s
[01:47:54.816] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8877925243235958496:24:0)
[01:47:54.836] Build status: STARTED
[01:47:54.836] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8877925243235958496:25:0) after 7m39s
[01:55:33.863] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8877925243235958496:25:0)
[01:55:33.934] Build status: STARTED
[01:55:33.934] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8877925243235958496:26:0) after 7m33s
[02:00:51.707] Received PubSub notification, asking Buildbucket for the build status
[02:00:51.727] Build:
{
"id": "8712495180970420497",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-mac-arm64"
},
"createdBy": "project:fuchsia",
"createTime": "2025-06-10T00:08:56.303087342Z",
"startTime": "2025-06-10T00:08:59.808741265Z",
"endTime": "2025-06-10T02:00:51.406706714Z",
"updateTime": "2025-06-10T02:00:51.406706714Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "f671e1698cbdfe02108486ae567f87eea7a05d61",
"ref": "refs/heads/main"
}
}
}
[02:00:51.727] Invocation finished in 1h51m56.96839494s with status SUCCEEDED