[13:38:35.561] New invocation is queued and will start shortly
[13:38:39.221] Starting the invocation (attempt 1)
[13:38:39.249] Popped buildset tag "buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/ecc70fdbe36b0b8994a57f8c213c2f2ce651563d"
[13:38:39.249] Popped gitiles commit info from properties and tags
[13:38:39.249] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[13:38:39.249] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[13:38:39.250] Buildbucket request:
{
"requestId": "8864647145487208304",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-mac-x64"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8864647145487208304",
"job": "fuchsia/toolchain.ci-clang-mac-x64-40be1bb5",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "e17bc1ec517f93ae6d70a66f1ce033499a76d690"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@e17bc1ec517f93ae6d70a66f1ce033499a76d690",
"title": "e17bc1ec517f93ae6d70a66f1ce033499a76d690",
"url": "https://llvm.googlesource.com/llvm-project/+/e17bc1ec517f93ae6d70a66f1ce033499a76d690"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "ef9ff15587cd0aa2676553b64ec3b11e36ebfd02"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@ef9ff15587cd0aa2676553b64ec3b11e36ebfd02",
"title": "ef9ff15587cd0aa2676553b64ec3b11e36ebfd02",
"url": "https://llvm.googlesource.com/llvm-project/+/ef9ff15587cd0aa2676553b64ec3b11e36ebfd02"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "df1d786c460e0e47c9074f3533f098190ebfbc1b"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@df1d786c460e0e47c9074f3533f098190ebfbc1b",
"title": "df1d786c460e0e47c9074f3533f098190ebfbc1b",
"url": "https://llvm.googlesource.com/llvm-project/+/df1d786c460e0e47c9074f3533f098190ebfbc1b"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "ca19ab97b9cb0104965319dda9400ad4955662ae"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@ca19ab97b9cb0104965319dda9400ad4955662ae",
"title": "ca19ab97b9cb0104965319dda9400ad4955662ae",
"url": "https://llvm.googlesource.com/llvm-project/+/ca19ab97b9cb0104965319dda9400ad4955662ae"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "ab049891cd7ce2f631a49ec830701dee4bd483a9"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@ab049891cd7ce2f631a49ec830701dee4bd483a9",
"title": "ab049891cd7ce2f631a49ec830701dee4bd483a9",
"url": "https://llvm.googlesource.com/llvm-project/+/ab049891cd7ce2f631a49ec830701dee4bd483a9"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "a3c4fe2ce7446b2439acf7fb1ca6ad5f2fb229d3"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@a3c4fe2ce7446b2439acf7fb1ca6ad5f2fb229d3",
"title": "a3c4fe2ce7446b2439acf7fb1ca6ad5f2fb229d3",
"url": "https://llvm.googlesource.com/llvm-project/+/a3c4fe2ce7446b2439acf7fb1ca6ad5f2fb229d3"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "6b8ca33e93022384bcbe5735b9410ca9b840a5d4"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@6b8ca33e93022384bcbe5735b9410ca9b840a5d4",
"title": "6b8ca33e93022384bcbe5735b9410ca9b840a5d4",
"url": "https://llvm.googlesource.com/llvm-project/+/6b8ca33e93022384bcbe5735b9410ca9b840a5d4"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "de2797c888e03d99c554d11e830ea1b3fbdae29f"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@de2797c888e03d99c554d11e830ea1b3fbdae29f",
"title": "de2797c888e03d99c554d11e830ea1b3fbdae29f",
"url": "https://llvm.googlesource.com/llvm-project/+/de2797c888e03d99c554d11e830ea1b3fbdae29f"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "1667feb0fd37b738c9134e60474741097daada25"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@1667feb0fd37b738c9134e60474741097daada25",
"title": "1667feb0fd37b738c9134e60474741097daada25",
"url": "https://llvm.googlesource.com/llvm-project/+/1667feb0fd37b738c9134e60474741097daada25"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "2ea1edbeea095b6baec25233c5076de6f5463e8b"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@2ea1edbeea095b6baec25233c5076de6f5463e8b",
"title": "2ea1edbeea095b6baec25233c5076de6f5463e8b",
"url": "https://llvm.googlesource.com/llvm-project/+/2ea1edbeea095b6baec25233c5076de6f5463e8b"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "ecc70fdbe36b0b8994a57f8c213c2f2ce651563d"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@ecc70fdbe36b0b8994a57f8c213c2f2ce651563d",
"title": "ecc70fdbe36b0b8994a57f8c213c2f2ce651563d",
"url": "https://llvm.googlesource.com/llvm-project/+/ecc70fdbe36b0b8994a57f8c213c2f2ce651563d"
}
]
}
},
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "ecc70fdbe36b0b8994a57f8c213c2f2ce651563d",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8864647145487208304"
},
{
"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"
}
}
[13:38:40.250] Scheduled build:
{
"id": "8699217080594645217",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-mac-x64"
},
"createdBy": "project:fuchsia",
"createTime": "2025-11-03T13:38:39.602825996Z",
"updateTime": "2025-11-03T13:38:39.602825996Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "ecc70fdbe36b0b8994a57f8c213c2f2ce651563d",
"ref": "refs/heads/main"
}
}
}
[13:38:40.279] Task URL: https://cr-buildbucket.appspot.com/build/8699217080594645217
[13:38:40.280] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8864647145487208304:2:0) after 8m45s
[13:38:41.106] Received PubSub notification, asking Buildbucket for the build status
[13:38:41.134] Build status: SCHEDULED
[13:38:49.170] Received PubSub notification, asking Buildbucket for the build status
[13:38:49.195] Build status: STARTED
[13:47:25.473] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8864647145487208304:2:0)
[13:47:25.515] Build status: STARTED
[13:47:25.515] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8864647145487208304:5:0) after 1m41s
[13:49:06.604] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8864647145487208304:5:0)
[13:49:06.631] Build status: STARTED
[13:49:06.631] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8864647145487208304:6:0) after 8m53s
[13:57:59.722] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8864647145487208304:6:0)
[13:57:59.739] Build status: STARTED
[13:57:59.739] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8864647145487208304:7:0) after 7m44s
[14:05:43.757] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8864647145487208304:7:0)
[14:05:43.831] Build status: STARTED
[14:05:43.831] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8864647145487208304:8:0) after 4m5s
[14:09:50.168] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8864647145487208304:8:0)
[14:09:50.185] Build status: STARTED
[14:09:50.185] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8864647145487208304:9:0) after 5m22s
[14:15:12.201] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8864647145487208304:9:0)
[14:15:12.217] Build status: STARTED
[14:15:12.217] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8864647145487208304:10:0) after 2m7s
[14:17:19.235] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8864647145487208304:10:0)
[14:17:19.253] Build status: STARTED
[14:17:19.253] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8864647145487208304:11:0) after 1m13s
[14:18:32.295] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8864647145487208304:11:0)
[14:18:32.341] Build status: STARTED
[14:18:32.341] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8864647145487208304:12:0) after 1m8s
[14:19:40.406] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8864647145487208304:12:0)
[14:19:40.425] Build status: STARTED
[14:19:40.425] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8864647145487208304:13:0) after 3m52s
[14:23:32.560] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8864647145487208304:13:0)
[14:23:32.578] Build status: STARTED
[14:23:32.578] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8864647145487208304:14:0) after 2m38s
[14:26:10.654] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8864647145487208304:14:0)
[14:26:10.672] Build status: STARTED
[14:26:10.672] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8864647145487208304:15:0) after 1m43s
[14:27:53.712] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8864647145487208304:15:0)
[14:27:53.730] Build status: STARTED
[14:27:53.730] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8864647145487208304:16:0) after 5m26s
[14:33:19.775] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8864647145487208304:16:0)
[14:33:19.793] Build status: STARTED
[14:33:19.793] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8864647145487208304:17:0) after 7m21s
[14:40:40.871] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8864647145487208304:17:0)
[14:40:40.889] Build status: STARTED
[14:40:40.889] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8864647145487208304:18:0) after 9m36s
[14:50:17.349] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8864647145487208304:18:0)
[14:50:17.379] Build status: STARTED
[14:50:17.379] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8864647145487208304:19:0) after 8m9s
[14:58:26.404] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8864647145487208304:19:0)
[14:58:26.422] Build status: STARTED
[14:58:26.422] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8864647145487208304:20:0) after 8m26s
[15:06:52.786] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8864647145487208304:20:0)
[15:06:52.806] Build status: STARTED
[15:06:52.806] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8864647145487208304:21:0) after 3m4s
[15:08:21.040] Received PubSub notification, asking Buildbucket for the build status
[15:08:21.057] Build:
{
"id": "8699217080594645217",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-mac-x64"
},
"createdBy": "project:fuchsia",
"createTime": "2025-11-03T13:38:39.602825996Z",
"startTime": "2025-11-03T13:38:48.933159019Z",
"endTime": "2025-11-03T15:08:20.533693407Z",
"updateTime": "2025-11-03T15:08:20.533693407Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "ecc70fdbe36b0b8994a57f8c213c2f2ce651563d",
"ref": "refs/heads/main"
}
}
}
[15:08:21.057] Invocation finished in 1h29m45.505287514s with status SUCCEEDED