[13:20:58.905] New invocation is queued and will start shortly
[13:21:00.074] Starting the invocation (attempt 1)
[13:21:00.099] Popped buildset tag "buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/f572a5951a664d57e909928d5595285212ad6884"
[13:21:00.099] Popped gitiles commit info from properties and tags
[13:21:00.099] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[13:21:00.099] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[13:21:00.100] Buildbucket request:
{
"requestId": "8882133467984580800",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-host-mac-x64"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8882133467984580800",
"job": "fuchsia/toolchain.ci-clang-host-mac-x64-40be1bb5",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "bcdafc107e1fb68893036cfba14e761c7b37b0e9"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@bcdafc107e1fb68893036cfba14e761c7b37b0e9",
"title": "bcdafc107e1fb68893036cfba14e761c7b37b0e9",
"url": "https://llvm.googlesource.com/llvm-project/+/bcdafc107e1fb68893036cfba14e761c7b37b0e9"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "8b2d269db22d253ef07a48ef433bc94dc70f2c75"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@8b2d269db22d253ef07a48ef433bc94dc70f2c75",
"title": "8b2d269db22d253ef07a48ef433bc94dc70f2c75",
"url": "https://llvm.googlesource.com/llvm-project/+/8b2d269db22d253ef07a48ef433bc94dc70f2c75"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "d7f3c3129344b133859d89d962fcdd5058702f72"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@d7f3c3129344b133859d89d962fcdd5058702f72",
"title": "d7f3c3129344b133859d89d962fcdd5058702f72",
"url": "https://llvm.googlesource.com/llvm-project/+/d7f3c3129344b133859d89d962fcdd5058702f72"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "ecdd3fd71f41f600623e93bad08f9e41b1d0d8cc"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@ecdd3fd71f41f600623e93bad08f9e41b1d0d8cc",
"title": "ecdd3fd71f41f600623e93bad08f9e41b1d0d8cc",
"url": "https://llvm.googlesource.com/llvm-project/+/ecdd3fd71f41f600623e93bad08f9e41b1d0d8cc"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "224cd50e005a9215e8c528d5ce68d4fcdfcdb98f"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@224cd50e005a9215e8c528d5ce68d4fcdfcdb98f",
"title": "224cd50e005a9215e8c528d5ce68d4fcdfcdb98f",
"url": "https://llvm.googlesource.com/llvm-project/+/224cd50e005a9215e8c528d5ce68d4fcdfcdb98f"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "57530c23a53b5e003d389437637f61c5b9814e22"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@57530c23a53b5e003d389437637f61c5b9814e22",
"title": "57530c23a53b5e003d389437637f61c5b9814e22",
"url": "https://llvm.googlesource.com/llvm-project/+/57530c23a53b5e003d389437637f61c5b9814e22"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "f572a5951a664d57e909928d5595285212ad6884"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@f572a5951a664d57e909928d5595285212ad6884",
"title": "f572a5951a664d57e909928d5595285212ad6884",
"url": "https://llvm.googlesource.com/llvm-project/+/f572a5951a664d57e909928d5595285212ad6884"
}
]
}
},
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "f572a5951a664d57e909928d5595285212ad6884",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8882133467984580800"
},
{
"key": "scheduler_job_id",
"value": "fuchsia/toolchain.ci-clang-host-mac-x64-40be1bb5"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[13:21:00.453] Scheduled build:
{
"id": "8716703406020632993",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-host-mac-x64"
},
"createdBy": "project:fuchsia",
"createTime": "2025-04-24T13:21:00.155481981Z",
"updateTime": "2025-04-24T13:21:00.155481981Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "f572a5951a664d57e909928d5595285212ad6884",
"ref": "refs/heads/main"
}
}
}
[13:21:00.453] Task URL: https://cr-buildbucket.appspot.com/build/8716703406020632993
[13:21:00.453] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-host-mac-x64-40be1bb5:8882133467984580800:2:0) after 7m47s
[13:21:01.512] Received PubSub notification, asking Buildbucket for the build status
[13:21:01.535] Build status: SCHEDULED
[13:21:04.722] Received PubSub notification, asking Buildbucket for the build status
[13:21:04.749] Build status: STARTED
[13:28:47.469] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-host-mac-x64-40be1bb5:8882133467984580800:2:0)
[13:28:47.514] Build status: STARTED
[13:28:47.514] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-host-mac-x64-40be1bb5:8882133467984580800:5:0) after 4m25s
[13:33:12.525] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-host-mac-x64-40be1bb5:8882133467984580800:5:0)
[13:33:12.550] Build status: STARTED
[13:33:12.550] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-host-mac-x64-40be1bb5:8882133467984580800:6:0) after 9m11s
[13:42:23.569] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-host-mac-x64-40be1bb5:8882133467984580800:6:0)
[13:42:23.601] Build status: STARTED
[13:42:23.601] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-host-mac-x64-40be1bb5:8882133467984580800:7:0) after 5m50s
[13:48:13.750] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-host-mac-x64-40be1bb5:8882133467984580800:7:0)
[13:48:13.767] Build status: STARTED
[13:48:13.767] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-host-mac-x64-40be1bb5:8882133467984580800:8:0) after 3m31s
[13:51:44.812] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-host-mac-x64-40be1bb5:8882133467984580800:8:0)
[13:51:44.869] Build status: STARTED
[13:51:44.869] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-host-mac-x64-40be1bb5:8882133467984580800:9:0) after 6m4s
[13:57:48.957] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-host-mac-x64-40be1bb5:8882133467984580800:9:0)
[13:57:49.034] Build status: STARTED
[13:57:49.034] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-host-mac-x64-40be1bb5:8882133467984580800:10:0) after 5m27s
[14:03:16.054] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-host-mac-x64-40be1bb5:8882133467984580800:10:0)
[14:03:16.287] Build status: STARTED
[14:03:16.287] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-host-mac-x64-40be1bb5:8882133467984580800:11:0) after 3m44s
[14:03:59.522] Received PubSub notification, asking Buildbucket for the build status
[14:03:59.540] Build:
{
"id": "8716703406020632993",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-host-mac-x64"
},
"createdBy": "project:fuchsia",
"createTime": "2025-04-24T13:21:00.155481981Z",
"startTime": "2025-04-24T13:21:04.461078738Z",
"endTime": "2025-04-24T14:03:59.170365417Z",
"updateTime": "2025-04-24T14:03:59.170365417Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "f572a5951a664d57e909928d5595285212ad6884",
"ref": "refs/heads/main"
}
}
}
[14:03:59.540] Invocation finished in 43m0.641907072s with status SUCCEEDED