[19:30:00.829] New invocation is queued and will start shortly
[19:30:02.045] Starting the invocation (attempt 1)
[19:30:02.073] Popped buildset tag "buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/55e508c1339d0bb33b8012e16b93b7ae3a53a419"
[19:30:02.073] Popped gitiles commit info from properties and tags
[19:30:02.073] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[19:30:02.074] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[19:30:02.074] Buildbucket request:
{
"requestId": "8858645636198929248",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-mac-x64"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8858645636198929248",
"job": "fuchsia/toolchain.ci-clang-mac-x64-40be1bb5",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "057c7a79e3add4630e5d0fdce8b38491df5a230b"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@057c7a79e3add4630e5d0fdce8b38491df5a230b",
"title": "057c7a79e3add4630e5d0fdce8b38491df5a230b",
"url": "https://llvm.googlesource.com/llvm-project/+/057c7a79e3add4630e5d0fdce8b38491df5a230b"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "3d6a96c0916fb0b238c2fae0e1791d3663415529"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@3d6a96c0916fb0b238c2fae0e1791d3663415529",
"title": "3d6a96c0916fb0b238c2fae0e1791d3663415529",
"url": "https://llvm.googlesource.com/llvm-project/+/3d6a96c0916fb0b238c2fae0e1791d3663415529"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "4bd84a9f335e2847a96d5ed4eac04576e811a963"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@4bd84a9f335e2847a96d5ed4eac04576e811a963",
"title": "4bd84a9f335e2847a96d5ed4eac04576e811a963",
"url": "https://llvm.googlesource.com/llvm-project/+/4bd84a9f335e2847a96d5ed4eac04576e811a963"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "f8b68c7b74704892ce308049fbc045e4b8b30d4d"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@f8b68c7b74704892ce308049fbc045e4b8b30d4d",
"title": "f8b68c7b74704892ce308049fbc045e4b8b30d4d",
"url": "https://llvm.googlesource.com/llvm-project/+/f8b68c7b74704892ce308049fbc045e4b8b30d4d"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "4f7da2f1363d7e7dcabba13965621a70e32d246d"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@4f7da2f1363d7e7dcabba13965621a70e32d246d",
"title": "4f7da2f1363d7e7dcabba13965621a70e32d246d",
"url": "https://llvm.googlesource.com/llvm-project/+/4f7da2f1363d7e7dcabba13965621a70e32d246d"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "65945ec2ccac5a974cf918e5bde035b7a551ef9b"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@65945ec2ccac5a974cf918e5bde035b7a551ef9b",
"title": "65945ec2ccac5a974cf918e5bde035b7a551ef9b",
"url": "https://llvm.googlesource.com/llvm-project/+/65945ec2ccac5a974cf918e5bde035b7a551ef9b"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "ad73bacf7aa02bc4ed1655dff6c9864ea24affde"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@ad73bacf7aa02bc4ed1655dff6c9864ea24affde",
"title": "ad73bacf7aa02bc4ed1655dff6c9864ea24affde",
"url": "https://llvm.googlesource.com/llvm-project/+/ad73bacf7aa02bc4ed1655dff6c9864ea24affde"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "65f39fde2bb97ef9e7d4a59c4d08a9df77be985e"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@65f39fde2bb97ef9e7d4a59c4d08a9df77be985e",
"title": "65f39fde2bb97ef9e7d4a59c4d08a9df77be985e",
"url": "https://llvm.googlesource.com/llvm-project/+/65f39fde2bb97ef9e7d4a59c4d08a9df77be985e"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "8ab6b38dab63fda49e6294e3b0d847ae491d7701"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@8ab6b38dab63fda49e6294e3b0d847ae491d7701",
"title": "8ab6b38dab63fda49e6294e3b0d847ae491d7701",
"url": "https://llvm.googlesource.com/llvm-project/+/8ab6b38dab63fda49e6294e3b0d847ae491d7701"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "ff617bce04cc05b1348bd2d68edabbd315a38a22"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@ff617bce04cc05b1348bd2d68edabbd315a38a22",
"title": "ff617bce04cc05b1348bd2d68edabbd315a38a22",
"url": "https://llvm.googlesource.com/llvm-project/+/ff617bce04cc05b1348bd2d68edabbd315a38a22"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "672a4c3f34ef0ecbef8966050b4d2105f4b6d088"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@672a4c3f34ef0ecbef8966050b4d2105f4b6d088",
"title": "672a4c3f34ef0ecbef8966050b4d2105f4b6d088",
"url": "https://llvm.googlesource.com/llvm-project/+/672a4c3f34ef0ecbef8966050b4d2105f4b6d088"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "39dd1fd5e163dd9c3f626377ed55faecd592f803"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@39dd1fd5e163dd9c3f626377ed55faecd592f803",
"title": "39dd1fd5e163dd9c3f626377ed55faecd592f803",
"url": "https://llvm.googlesource.com/llvm-project/+/39dd1fd5e163dd9c3f626377ed55faecd592f803"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "fcec9ced47c5b1e2479fa86f7b51a73ba6feb3f7"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@fcec9ced47c5b1e2479fa86f7b51a73ba6feb3f7",
"title": "fcec9ced47c5b1e2479fa86f7b51a73ba6feb3f7",
"url": "https://llvm.googlesource.com/llvm-project/+/fcec9ced47c5b1e2479fa86f7b51a73ba6feb3f7"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "4deb16c481c44288bc6a960d36c829d34a378015"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@4deb16c481c44288bc6a960d36c829d34a378015",
"title": "4deb16c481c44288bc6a960d36c829d34a378015",
"url": "https://llvm.googlesource.com/llvm-project/+/4deb16c481c44288bc6a960d36c829d34a378015"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "f0275bd6ba888d409cf677d498233d3be75cbf6b"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@f0275bd6ba888d409cf677d498233d3be75cbf6b",
"title": "f0275bd6ba888d409cf677d498233d3be75cbf6b",
"url": "https://llvm.googlesource.com/llvm-project/+/f0275bd6ba888d409cf677d498233d3be75cbf6b"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "43cb4631c1f42dbfce78288b8ae30b5840ed59b3"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@43cb4631c1f42dbfce78288b8ae30b5840ed59b3",
"title": "43cb4631c1f42dbfce78288b8ae30b5840ed59b3",
"url": "https://llvm.googlesource.com/llvm-project/+/43cb4631c1f42dbfce78288b8ae30b5840ed59b3"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "4c171a202f0e7fa685793fb9dc57d7c7ed7e0e97"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@4c171a202f0e7fa685793fb9dc57d7c7ed7e0e97",
"title": "4c171a202f0e7fa685793fb9dc57d7c7ed7e0e97",
"url": "https://llvm.googlesource.com/llvm-project/+/4c171a202f0e7fa685793fb9dc57d7c7ed7e0e97"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "55e508c1339d0bb33b8012e16b93b7ae3a53a419"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@55e508c1339d0bb33b8012e16b93b7ae3a53a419",
"title": "55e508c1339d0bb33b8012e16b93b7ae3a53a419",
"url": "https://llvm.googlesource.com/llvm-project/+/55e508c1339d0bb33b8012e16b93b7ae3a53a419"
}
]
}
},
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "55e508c1339d0bb33b8012e16b93b7ae3a53a419",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8858645636198929248"
},
{
"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"
}
}
[19:30:02.645] Scheduled build:
{
"id": "8693215574136362017",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-mac-x64"
},
"createdBy": "project:fuchsia",
"createTime": "2026-01-08T19:30:02.171116113Z",
"updateTime": "2026-01-08T19:30:02.171116113Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "55e508c1339d0bb33b8012e16b93b7ae3a53a419",
"ref": "refs/heads/main"
}
}
}
[19:30:02.645] Task URL: https://cr-buildbucket.appspot.com/build/8693215574136362017
[19:30:02.645] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8858645636198929248:2:0) after 6m42s
[19:30:03.446] Received PubSub notification, asking Buildbucket for the build status
[19:30:03.483] Build status: SCHEDULED
[19:30:07.376] Received PubSub notification, asking Buildbucket for the build status
[19:30:07.450] Build status: STARTED
[19:36:44.677] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8858645636198929248:2:0)
[19:36:44.705] Build status: STARTED
[19:36:44.705] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8858645636198929248:5:0) after 3m5s
[19:39:49.961] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8858645636198929248:5:0)
[19:39:50.028] Build status: STARTED
[19:39:50.028] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8858645636198929248:6:0) after 5m15s
[19:45:05.043] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8858645636198929248:6:0)
[19:45:05.105] Build status: STARTED
[19:45:05.105] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8858645636198929248:7:0) after 3m55s
[19:49:00.126] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8858645636198929248:7:0)
[19:49:00.141] Build status: STARTED
[19:49:00.141] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8858645636198929248:8:0) after 8m15s
[19:57:15.188] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8858645636198929248:8:0)
[19:57:15.249] Build status: STARTED
[19:57:15.249] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8858645636198929248:9:0) after 1m22s
[19:58:37.272] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8858645636198929248:9:0)
[19:58:37.294] Build status: STARTED
[19:58:37.294] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8858645636198929248:10:0) after 2m56s
[20:01:33.309] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8858645636198929248:10:0)
[20:01:33.341] Build status: STARTED
[20:01:33.341] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8858645636198929248:11:0) after 7m59s
[20:09:32.351] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8858645636198929248:11:0)
[20:09:32.375] Build status: STARTED
[20:09:32.375] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8858645636198929248:12:0) after 8m53s
[20:18:25.389] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8858645636198929248:12:0)
[20:18:25.404] Build status: STARTED
[20:18:25.405] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8858645636198929248:13:0) after 6m16s
[20:24:41.517] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8858645636198929248:13:0)
[20:24:41.530] Build status: STARTED
[20:24:41.530] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8858645636198929248:14:0) after 3m4s
[20:27:45.561] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8858645636198929248:14:0)
[20:27:45.594] Build status: STARTED
[20:27:45.594] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8858645636198929248:15:0) after 5m18s
[20:33:03.663] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8858645636198929248:15:0)
[20:33:03.684] Build status: STARTED
[20:33:03.685] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8858645636198929248:16:0) after 9m35s
[20:42:38.811] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8858645636198929248:16:0)
[20:42:38.835] Build status: STARTED
[20:42:38.835] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8858645636198929248:17:0) after 2m17s
[20:44:55.876] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8858645636198929248:17:0)
[20:44:55.900] Build status: STARTED
[20:44:55.900] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8858645636198929248:18:0) after 8m46s
[20:53:41.992] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8858645636198929248:18:0)
[20:53:42.160] Build status: STARTED
[20:53:42.195] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8858645636198929248:19:0) after 6m54s
[21:00:36.316] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8858645636198929248:19:0)
[21:00:36.334] Build status: STARTED
[21:00:36.334] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8858645636198929248:20:0) after 1m11s
[21:01:47.353] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8858645636198929248:20:0)
[21:01:47.371] Build status: STARTED
[21:01:47.371] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8858645636198929248:21:0) after 1m50s
[21:03:37.343] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8858645636198929248:21:0)
[21:03:37.366] Build status: STARTED
[21:03:37.366] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8858645636198929248:22:0) after 8m58s
[21:09:49.039] Received PubSub notification, asking Buildbucket for the build status
[21:09:49.180] Build:
{
"id": "8693215574136362017",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-mac-x64"
},
"createdBy": "project:fuchsia",
"createTime": "2026-01-08T19:30:02.171116113Z",
"startTime": "2026-01-08T19:30:07.115238888Z",
"endTime": "2026-01-08T21:09:48.698977037Z",
"updateTime": "2026-01-08T21:09:48.698977037Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "55e508c1339d0bb33b8012e16b93b7ae3a53a419",
"ref": "refs/heads/main"
}
}
}
[21:09:49.180] Invocation finished in 1h39m48.359487975s with status SUCCEEDED