[09:57:07.019] New invocation is queued and will start shortly
[09:57:08.418] Starting the invocation (attempt 1)
[09:57:08.463] Popped buildset tag "buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/6f3efd80ab20d5ab4ac375da0d84d5999adbfcb9"
[09:57:08.463] Popped gitiles commit info from properties and tags
[09:57:08.463] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[09:57:08.464] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[09:57:08.464] Buildbucket request:
{
"requestId": "8879156594152270272",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-mac-x64"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8879156594152270272",
"job": "fuchsia/toolchain.ci-clang-mac-x64-40be1bb5",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "052c70451afb7323ef72f321f3b0b5abb024b302"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@052c70451afb7323ef72f321f3b0b5abb024b302",
"title": "052c70451afb7323ef72f321f3b0b5abb024b302",
"url": "https://llvm.googlesource.com/llvm-project/+/052c70451afb7323ef72f321f3b0b5abb024b302"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "8fe33a05b94d716830f7ad119d2afcb06e09cc4d"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@8fe33a05b94d716830f7ad119d2afcb06e09cc4d",
"title": "8fe33a05b94d716830f7ad119d2afcb06e09cc4d",
"url": "https://llvm.googlesource.com/llvm-project/+/8fe33a05b94d716830f7ad119d2afcb06e09cc4d"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "03fc480b9acde73f2cbd2ca216bf879b6b28a473"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@03fc480b9acde73f2cbd2ca216bf879b6b28a473",
"title": "03fc480b9acde73f2cbd2ca216bf879b6b28a473",
"url": "https://llvm.googlesource.com/llvm-project/+/03fc480b9acde73f2cbd2ca216bf879b6b28a473"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "58ee6e6c4bc59a1c960c24c782661cb1578af7c4"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@58ee6e6c4bc59a1c960c24c782661cb1578af7c4",
"title": "58ee6e6c4bc59a1c960c24c782661cb1578af7c4",
"url": "https://llvm.googlesource.com/llvm-project/+/58ee6e6c4bc59a1c960c24c782661cb1578af7c4"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "afd53edefa771e5e2136a4cb159843a74a586660"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@afd53edefa771e5e2136a4cb159843a74a586660",
"title": "afd53edefa771e5e2136a4cb159843a74a586660",
"url": "https://llvm.googlesource.com/llvm-project/+/afd53edefa771e5e2136a4cb159843a74a586660"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "7569de527298a52618239ef68b9374a5c35c8b97"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@7569de527298a52618239ef68b9374a5c35c8b97",
"title": "7569de527298a52618239ef68b9374a5c35c8b97",
"url": "https://llvm.googlesource.com/llvm-project/+/7569de527298a52618239ef68b9374a5c35c8b97"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "bf6cd24aaadd8310408d733c944f0d5f9cc14c0a"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@bf6cd24aaadd8310408d733c944f0d5f9cc14c0a",
"title": "bf6cd24aaadd8310408d733c944f0d5f9cc14c0a",
"url": "https://llvm.googlesource.com/llvm-project/+/bf6cd24aaadd8310408d733c944f0d5f9cc14c0a"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "fb27867bd5a04975516b099681587ea32f38f3d4"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@fb27867bd5a04975516b099681587ea32f38f3d4",
"title": "fb27867bd5a04975516b099681587ea32f38f3d4",
"url": "https://llvm.googlesource.com/llvm-project/+/fb27867bd5a04975516b099681587ea32f38f3d4"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "6da8f3bd5df2bb860f8cc32e9cfc739baf102295"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@6da8f3bd5df2bb860f8cc32e9cfc739baf102295",
"title": "6da8f3bd5df2bb860f8cc32e9cfc739baf102295",
"url": "https://llvm.googlesource.com/llvm-project/+/6da8f3bd5df2bb860f8cc32e9cfc739baf102295"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "ac9a466e39bf97ffeab127982aa7c405cb257551"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@ac9a466e39bf97ffeab127982aa7c405cb257551",
"title": "ac9a466e39bf97ffeab127982aa7c405cb257551",
"url": "https://llvm.googlesource.com/llvm-project/+/ac9a466e39bf97ffeab127982aa7c405cb257551"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "6f3efd80ab20d5ab4ac375da0d84d5999adbfcb9"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@6f3efd80ab20d5ab4ac375da0d84d5999adbfcb9",
"title": "6f3efd80ab20d5ab4ac375da0d84d5999adbfcb9",
"url": "https://llvm.googlesource.com/llvm-project/+/6f3efd80ab20d5ab4ac375da0d84d5999adbfcb9"
}
]
}
},
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "6f3efd80ab20d5ab4ac375da0d84d5999adbfcb9",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8879156594152270272"
},
{
"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"
}
}
[09:57:08.846] Scheduled build:
{
"id": "8713726531923659217",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-mac-x64"
},
"createdBy": "project:fuchsia",
"createTime": "2025-05-27T09:57:08.524689262Z",
"updateTime": "2025-05-27T09:57:08.524689262Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "6f3efd80ab20d5ab4ac375da0d84d5999adbfcb9",
"ref": "refs/heads/main"
}
}
}
[09:57:08.846] Task URL: https://cr-buildbucket.appspot.com/build/8713726531923659217
[09:57:08.846] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8879156594152270272:2:0) after 5m12s
[09:57:08.967] Received PubSub notification, asking Buildbucket for the build status
[09:57:09.008] Build status: SCHEDULED
[09:58:20.665] Received PubSub notification, asking Buildbucket for the build status
[09:58:20.740] Build status: STARTED
[10:02:20.858] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8879156594152270272:2:0)
[10:02:20.881] Build status: STARTED
[10:02:20.881] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8879156594152270272:5:0) after 2m6s
[10:04:26.955] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8879156594152270272:5:0)
[10:04:26.978] Build status: STARTED
[10:04:26.978] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8879156594152270272:6:0) after 9m10s
[10:13:37.053] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8879156594152270272:6:0)
[10:13:37.076] Build status: STARTED
[10:13:37.076] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8879156594152270272:7:0) after 7m10s
[10:20:47.144] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8879156594152270272:7:0)
[10:20:47.317] Build status: STARTED
[10:20:47.317] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8879156594152270272:8:0) after 1m32s
[10:22:19.381] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8879156594152270272:8:0)
[10:22:19.407] Build status: STARTED
[10:22:19.407] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8879156594152270272:9:0) after 9m43s
[10:32:02.525] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8879156594152270272:9:0)
[10:32:02.543] Build status: STARTED
[10:32:02.543] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8879156594152270272:10:0) after 2m4s
[10:34:06.566] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8879156594152270272:10:0)
[10:34:06.638] Build status: STARTED
[10:34:06.638] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8879156594152270272:11:0) after 9m15s
[10:43:21.659] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8879156594152270272:11:0)
[10:43:21.720] Build status: STARTED
[10:43:21.720] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8879156594152270272:12:0) after 8m3s
[10:51:25.070] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8879156594152270272:12:0)
[10:51:25.133] Build status: STARTED
[10:51:25.133] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8879156594152270272:13:0) after 9m11s
[11:00:36.738] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8879156594152270272:13:0)
[11:00:36.806] Build status: STARTED
[11:00:36.806] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8879156594152270272:14:0) after 9m51s
[11:10:28.115] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8879156594152270272:14:0)
[11:10:28.142] Build status: STARTED
[11:10:28.142] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8879156594152270272:15:0) after 6m37s
[11:17:05.337] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8879156594152270272:15:0)
[11:17:05.424] Build status: STARTED
[11:17:05.424] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8879156594152270272:16:0) after 5m9s
[11:22:14.445] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8879156594152270272:16:0)
[11:22:14.470] Build status: STARTED
[11:22:14.470] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8879156594152270272:17:0) after 1m9s
[11:23:23.523] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8879156594152270272:17:0)
[11:23:23.537] Build status: STARTED
[11:23:23.537] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8879156594152270272:18:0) after 8m9s
[11:31:32.644] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8879156594152270272:18:0)
[11:31:32.723] Build status: STARTED
[11:31:32.723] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8879156594152270272:19:0) after 2m3s
[11:33:35.834] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8879156594152270272:19:0)
[11:33:35.851] Build status: STARTED
[11:33:35.851] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8879156594152270272:20:0) after 8m16s
[11:34:05.795] Received PubSub notification, asking Buildbucket for the build status
[11:34:05.812] Build:
{
"id": "8713726531923659217",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-mac-x64"
},
"createdBy": "project:fuchsia",
"createTime": "2025-05-27T09:57:08.524689262Z",
"startTime": "2025-05-27T09:58:20.142133512Z",
"endTime": "2025-05-27T11:34:05.457964302Z",
"updateTime": "2025-05-27T11:34:05.457964302Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "6f3efd80ab20d5ab4ac375da0d84d5999adbfcb9",
"ref": "refs/heads/main"
}
}
}
[11:34:05.812] Invocation finished in 1h36m58.797088649s with status SUCCEEDED