[11:19:09.510] New invocation is queued and will start shortly
[11:19:10.583] Starting the invocation (attempt 1)
[11:19:10.610] Popped buildset tag "buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/820aa438a6ec5e028d96bf6b345f41c585f91572"
[11:19:10.611] Popped gitiles commit info from properties and tags
[11:19:10.611] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[11:19:10.611] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[11:19:10.611] Buildbucket request:
{
"requestId": "8887395756498077984",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-mac-x64"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8887395756498077984",
"job": "fuchsia/toolchain.ci-clang-mac-x64-40be1bb5",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "b36a18df96f9b8f206ec4b7f1036bdd4701c117e"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@b36a18df96f9b8f206ec4b7f1036bdd4701c117e",
"title": "b36a18df96f9b8f206ec4b7f1036bdd4701c117e",
"url": "https://llvm.googlesource.com/llvm-project/+/b36a18df96f9b8f206ec4b7f1036bdd4701c117e"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "547a8bc2365d9f1dc7bce52580a3ab64d69c80ed"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@547a8bc2365d9f1dc7bce52580a3ab64d69c80ed",
"title": "547a8bc2365d9f1dc7bce52580a3ab64d69c80ed",
"url": "https://llvm.googlesource.com/llvm-project/+/547a8bc2365d9f1dc7bce52580a3ab64d69c80ed"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "85cf95876c4b21ee6ecd0253a2c9de0e90c4a521"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@85cf95876c4b21ee6ecd0253a2c9de0e90c4a521",
"title": "85cf95876c4b21ee6ecd0253a2c9de0e90c4a521",
"url": "https://llvm.googlesource.com/llvm-project/+/85cf95876c4b21ee6ecd0253a2c9de0e90c4a521"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "2a0946bc0dffca89d16cd9d5208ec9416ed8100e"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@2a0946bc0dffca89d16cd9d5208ec9416ed8100e",
"title": "2a0946bc0dffca89d16cd9d5208ec9416ed8100e",
"url": "https://llvm.googlesource.com/llvm-project/+/2a0946bc0dffca89d16cd9d5208ec9416ed8100e"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "7ff87af533a7acf47134eabe656702180d8ad171"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@7ff87af533a7acf47134eabe656702180d8ad171",
"title": "7ff87af533a7acf47134eabe656702180d8ad171",
"url": "https://llvm.googlesource.com/llvm-project/+/7ff87af533a7acf47134eabe656702180d8ad171"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "88163ca79cab1a9a2be1cfa71000f43fd642d91e"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@88163ca79cab1a9a2be1cfa71000f43fd642d91e",
"title": "88163ca79cab1a9a2be1cfa71000f43fd642d91e",
"url": "https://llvm.googlesource.com/llvm-project/+/88163ca79cab1a9a2be1cfa71000f43fd642d91e"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "9fc2f786934599c51427cf6f581450ee951ece4a"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@9fc2f786934599c51427cf6f581450ee951ece4a",
"title": "9fc2f786934599c51427cf6f581450ee951ece4a",
"url": "https://llvm.googlesource.com/llvm-project/+/9fc2f786934599c51427cf6f581450ee951ece4a"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "446899e7bed5555c2bacfe0d09c4f4f00c41bc0f"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@446899e7bed5555c2bacfe0d09c4f4f00c41bc0f",
"title": "446899e7bed5555c2bacfe0d09c4f4f00c41bc0f",
"url": "https://llvm.googlesource.com/llvm-project/+/446899e7bed5555c2bacfe0d09c4f4f00c41bc0f"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "48397fe41ee67557e00f13f35d60c3c9b8485e89"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@48397fe41ee67557e00f13f35d60c3c9b8485e89",
"title": "48397fe41ee67557e00f13f35d60c3c9b8485e89",
"url": "https://llvm.googlesource.com/llvm-project/+/48397fe41ee67557e00f13f35d60c3c9b8485e89"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "56975b4ecd188a77b4f9420ff8aa5d5a72e4e076"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@56975b4ecd188a77b4f9420ff8aa5d5a72e4e076",
"title": "56975b4ecd188a77b4f9420ff8aa5d5a72e4e076",
"url": "https://llvm.googlesource.com/llvm-project/+/56975b4ecd188a77b4f9420ff8aa5d5a72e4e076"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "29e14958090cb01150bda068f721a09d4bb1c36b"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@29e14958090cb01150bda068f721a09d4bb1c36b",
"title": "29e14958090cb01150bda068f721a09d4bb1c36b",
"url": "https://llvm.googlesource.com/llvm-project/+/29e14958090cb01150bda068f721a09d4bb1c36b"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "25c19eb1178a26b09e8ee58c825d4ed0260b70da"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@25c19eb1178a26b09e8ee58c825d4ed0260b70da",
"title": "25c19eb1178a26b09e8ee58c825d4ed0260b70da",
"url": "https://llvm.googlesource.com/llvm-project/+/25c19eb1178a26b09e8ee58c825d4ed0260b70da"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "dfa3af9255fd542fed5149021289404e92a8a6f3"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@dfa3af9255fd542fed5149021289404e92a8a6f3",
"title": "dfa3af9255fd542fed5149021289404e92a8a6f3",
"url": "https://llvm.googlesource.com/llvm-project/+/dfa3af9255fd542fed5149021289404e92a8a6f3"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "820aa438a6ec5e028d96bf6b345f41c585f91572"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@820aa438a6ec5e028d96bf6b345f41c585f91572",
"title": "820aa438a6ec5e028d96bf6b345f41c585f91572",
"url": "https://llvm.googlesource.com/llvm-project/+/820aa438a6ec5e028d96bf6b345f41c585f91572"
}
]
}
},
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "820aa438a6ec5e028d96bf6b345f41c585f91572",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8887395756498077984"
},
{
"key": "scheduler_job_id",
"value": "fuchsia/toolchain.ci-clang-mac-x64-40be1bb5"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[11:19:11.174] Scheduled build:
{
"id": "8721965694573553761",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-mac-x64"
},
"createdBy": "project:fuchsia",
"createTime": "2025-02-25T11:19:10.716488865Z",
"updateTime": "2025-02-25T11:19:10.716488865Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "820aa438a6ec5e028d96bf6b345f41c585f91572",
"ref": "refs/heads/main"
}
}
}
[11:19:11.175] Task URL: https://cr-buildbucket.appspot.com/build/8721965694573553761
[11:19:11.175] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8887395756498077984:2:0) after 9m55s
[11:19:12.189] Received PubSub notification, asking Buildbucket for the build status
[11:19:12.213] Build status: SCHEDULED
[11:21:35.222] Received PubSub notification, asking Buildbucket for the build status
[11:21:35.319] Build status: STARTED
[11:29:06.199] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8887395756498077984:2:0)
[11:29:06.213] Build status: STARTED
[11:29:06.213] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8887395756498077984:5:0) after 1m26s
[11:30:32.229] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8887395756498077984:5:0)
[11:30:32.255] Build status: STARTED
[11:30:32.255] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8887395756498077984:6:0) after 2m21s
[11:32:53.611] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8887395756498077984:6:0)
[11:32:53.645] Build status: STARTED
[11:32:53.645] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8887395756498077984:7:0) after 5m37s
[11:38:30.664] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8887395756498077984:7:0)
[11:38:30.693] Build status: STARTED
[11:38:30.693] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8887395756498077984:8:0) after 7m7s
[11:45:37.767] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8887395756498077984:8:0)
[11:45:37.848] Build status: STARTED
[11:45:37.848] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8887395756498077984:9:0) after 1m34s
[11:47:11.886] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8887395756498077984:9:0)
[11:47:11.913] Build status: STARTED
[11:47:11.913] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8887395756498077984:10:0) after 2m44s
[11:49:56.602] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8887395756498077984:10:0)
[11:49:56.622] Build status: STARTED
[11:49:56.622] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8887395756498077984:11:0) after 6m48s
[11:56:44.871] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8887395756498077984:11:0)
[11:56:44.925] Build status: STARTED
[11:56:44.925] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8887395756498077984:12:0) after 1m9s
[11:57:53.967] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8887395756498077984:12:0)
[11:57:53.988] Build status: STARTED
[11:57:53.988] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8887395756498077984:13:0) after 2m26s
[12:00:20.015] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8887395756498077984:13:0)
[12:00:20.047] Build status: STARTED
[12:00:20.047] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8887395756498077984:14:0) after 3m21s
[12:03:41.114] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8887395756498077984:14:0)
[12:03:41.136] Build status: STARTED
[12:03:41.136] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8887395756498077984:15:0) after 5m43s
[12:09:24.701] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8887395756498077984:15:0)
[12:09:24.717] Build status: STARTED
[12:09:24.717] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8887395756498077984:16:0) after 2m28s
[12:11:52.844] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8887395756498077984:16:0)
[12:11:52.866] Build status: STARTED
[12:11:52.866] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8887395756498077984:17:0) after 2m56s
[12:14:48.881] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8887395756498077984:17:0)
[12:14:48.911] Build status: STARTED
[12:14:48.911] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8887395756498077984:18:0) after 8m35s
[12:23:23.934] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8887395756498077984:18:0)
[12:23:23.961] Build status: STARTED
[12:23:23.961] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8887395756498077984:19:0) after 2m5s
[12:25:29.153] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8887395756498077984:19:0)
[12:25:29.172] Build status: STARTED
[12:25:29.172] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8887395756498077984:20:0) after 5m48s
[12:31:17.198] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8887395756498077984:20:0)
[12:31:17.215] Build status: STARTED
[12:31:17.215] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8887395756498077984:21:0) after 1m25s
[12:32:42.238] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8887395756498077984:21:0)
[12:32:42.317] Build status: STARTED
[12:32:42.317] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8887395756498077984:22:0) after 7m22s
[12:40:04.341] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8887395756498077984:22:0)
[12:40:04.362] Build status: STARTED
[12:40:04.362] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8887395756498077984:23:0) after 1m30s
[12:41:34.414] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8887395756498077984:23:0)
[12:41:34.448] Build status: STARTED
[12:41:34.448] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8887395756498077984:24:0) after 3m46s
[12:45:20.466] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8887395756498077984:24:0)
[12:45:20.486] Build status: STARTED
[12:45:20.486] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8887395756498077984:25:0) after 1m5s
[12:46:25.500] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8887395756498077984:25:0)
[12:46:25.519] Build status: STARTED
[12:46:25.519] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8887395756498077984:26:0) after 4m58s
[12:51:23.547] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8887395756498077984:26:0)
[12:51:23.562] Build status: STARTED
[12:51:23.562] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8887395756498077984:27:0) after 3m17s
[12:54:40.631] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8887395756498077984:27:0)
[12:54:40.647] Build status: STARTED
[12:54:40.647] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8887395756498077984:28:0) after 5m42s
[12:57:48.411] Received PubSub notification, asking Buildbucket for the build status
[12:57:48.435] Build:
{
"id": "8721965694573553761",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-mac-x64"
},
"createdBy": "project:fuchsia",
"createTime": "2025-02-25T11:19:10.716488865Z",
"startTime": "2025-02-25T11:21:34.959520018Z",
"endTime": "2025-02-25T12:57:48.042039375Z",
"updateTime": "2025-02-25T12:57:48.042039375Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "820aa438a6ec5e028d96bf6b345f41c585f91572",
"ref": "refs/heads/main"
}
}
}
[12:57:48.435] Invocation finished in 1h38m38.93798033s with status SUCCEEDED