[18:40:11.137] New invocation is queued and will start shortly
[18:40:12.445] Starting the invocation (attempt 1)
[18:40:12.485] Popped buildset tag "buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/d93788fcbf585e7cd3866b514bad972765b17e8d"
[18:40:12.485] Popped gitiles commit info from properties and tags
[18:40:12.485] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[18:40:12.485] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[18:40:12.486] Buildbucket request:
{
"requestId": "8878942491594845968",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-host-mac-x64"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8878942491594845968",
"job": "fuchsia/toolchain.ci-clang-host-mac-x64-40be1bb5",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "b411f70c3b83b0b25eee67d666d42cf50f78a6b8"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@b411f70c3b83b0b25eee67d666d42cf50f78a6b8",
"title": "b411f70c3b83b0b25eee67d666d42cf50f78a6b8",
"url": "https://llvm.googlesource.com/llvm-project/+/b411f70c3b83b0b25eee67d666d42cf50f78a6b8"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "9ca41b6b65680c9eceb938c0e27d8d054114e680"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@9ca41b6b65680c9eceb938c0e27d8d054114e680",
"title": "9ca41b6b65680c9eceb938c0e27d8d054114e680",
"url": "https://llvm.googlesource.com/llvm-project/+/9ca41b6b65680c9eceb938c0e27d8d054114e680"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "8f4fd864033601aad99a10c2b878769b84df7537"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@8f4fd864033601aad99a10c2b878769b84df7537",
"title": "8f4fd864033601aad99a10c2b878769b84df7537",
"url": "https://llvm.googlesource.com/llvm-project/+/8f4fd864033601aad99a10c2b878769b84df7537"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "cb065a578a9d152603c2ea66a616c1cbbc702d63"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@cb065a578a9d152603c2ea66a616c1cbbc702d63",
"title": "cb065a578a9d152603c2ea66a616c1cbbc702d63",
"url": "https://llvm.googlesource.com/llvm-project/+/cb065a578a9d152603c2ea66a616c1cbbc702d63"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "159646cd39eb6451c8906a999965e04d2566882f"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@159646cd39eb6451c8906a999965e04d2566882f",
"title": "159646cd39eb6451c8906a999965e04d2566882f",
"url": "https://llvm.googlesource.com/llvm-project/+/159646cd39eb6451c8906a999965e04d2566882f"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "dd56693451ba31d1e82a79bf460cdf85b728a246"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@dd56693451ba31d1e82a79bf460cdf85b728a246",
"title": "dd56693451ba31d1e82a79bf460cdf85b728a246",
"url": "https://llvm.googlesource.com/llvm-project/+/dd56693451ba31d1e82a79bf460cdf85b728a246"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "d93788fcbf585e7cd3866b514bad972765b17e8d"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@d93788fcbf585e7cd3866b514bad972765b17e8d",
"title": "d93788fcbf585e7cd3866b514bad972765b17e8d",
"url": "https://llvm.googlesource.com/llvm-project/+/d93788fcbf585e7cd3866b514bad972765b17e8d"
}
]
}
},
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "d93788fcbf585e7cd3866b514bad972765b17e8d",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8878942491594845968"
},
{
"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"
}
}
[18:40:12.943] Scheduled build:
{
"id": "8713512429445507553",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-host-mac-x64"
},
"createdBy": "project:fuchsia",
"createTime": "2025-05-29T18:40:12.559193326Z",
"updateTime": "2025-05-29T18:40:12.559193326Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "d93788fcbf585e7cd3866b514bad972765b17e8d",
"ref": "refs/heads/main"
}
}
}
[18:40:12.943] Task URL: https://cr-buildbucket.appspot.com/build/8713512429445507553
[18:40:12.943] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-host-mac-x64-40be1bb5:8878942491594845968:2:0) after 5m56s
[18:40:13.982] Received PubSub notification, asking Buildbucket for the build status
[18:40:14.006] Build status: SCHEDULED
[18:40:16.800] Received PubSub notification, asking Buildbucket for the build status
[18:40:16.826] Build status: STARTED
[18:46:09.086] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-host-mac-x64-40be1bb5:8878942491594845968:2:0)
[18:46:09.234] Build status: STARTED
[18:46:09.234] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-host-mac-x64-40be1bb5:8878942491594845968:5:0) after 8m25s
[18:54:34.306] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-host-mac-x64-40be1bb5:8878942491594845968:5:0)
[18:54:34.338] Build status: STARTED
[18:54:34.338] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-host-mac-x64-40be1bb5:8878942491594845968:6:0) after 4m56s
[18:59:30.453] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-host-mac-x64-40be1bb5:8878942491594845968:6:0)
[18:59:30.482] Build status: STARTED
[18:59:30.482] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-host-mac-x64-40be1bb5:8878942491594845968:7:0) after 5m16s
[19:04:46.601] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-host-mac-x64-40be1bb5:8878942491594845968:7:0)
[19:04:46.621] Build status: STARTED
[19:04:46.622] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-host-mac-x64-40be1bb5:8878942491594845968:8:0) after 2m55s
[19:07:41.657] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-host-mac-x64-40be1bb5:8878942491594845968:8:0)
[19:07:41.684] Build status: STARTED
[19:07:41.684] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-host-mac-x64-40be1bb5:8878942491594845968:9:0) after 4m53s
[19:12:34.737] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-host-mac-x64-40be1bb5:8878942491594845968:9:0)
[19:12:34.762] Build status: STARTED
[19:12:34.762] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-host-mac-x64-40be1bb5:8878942491594845968:10:0) after 1m24s
[19:13:58.796] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-host-mac-x64-40be1bb5:8878942491594845968:10:0)
[19:13:58.833] Build status: STARTED
[19:13:58.833] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-host-mac-x64-40be1bb5:8878942491594845968:11:0) after 6m18s
[19:20:17.045] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-host-mac-x64-40be1bb5:8878942491594845968:11:0)
[19:20:17.080] Build status: STARTED
[19:20:17.080] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-host-mac-x64-40be1bb5:8878942491594845968:12:0) after 7m29s
[19:22:41.552] Received PubSub notification, asking Buildbucket for the build status
[19:22:41.580] Build:
{
"id": "8713512429445507553",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-host-mac-x64"
},
"createdBy": "project:fuchsia",
"createTime": "2025-05-29T18:40:12.559193326Z",
"startTime": "2025-05-29T18:40:16.540941444Z",
"endTime": "2025-05-29T19:22:41.038332691Z",
"updateTime": "2025-05-29T19:22:41.038332691Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "d93788fcbf585e7cd3866b514bad972765b17e8d",
"ref": "refs/heads/main"
}
}
}
[19:22:41.580] Invocation finished in 42m30.454664855s with status SUCCEEDED