[15:38:04.981] New invocation is queued and will start shortly
[15:38:06.326] Starting the invocation (attempt 1)
[15:38:06.351] Popped buildset tag "buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/f9f79d184d6059b19e31fc543b2d42d1af7ce6fe"
[15:38:06.351] Popped gitiles commit info from properties and tags
[15:38:06.351] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[15:38:06.352] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[15:38:06.352] Buildbucket request:
{
"requestId": "8831843525966791312",
"builder": {
"project": "fuchsia",
"bucket": "prod",
"builder": "clang-prod-unbounded-trigger"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8831843525966791312",
"job": "fuchsia/prod-clang-prod-unbounded-trigger-40be1bb5",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "33e1c2c1b8a6fea5aaf6067fde636dee648df794"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@33e1c2c1b8a6fea5aaf6067fde636dee648df794",
"title": "33e1c2c1b8a6fea5aaf6067fde636dee648df794",
"url": "https://llvm.googlesource.com/llvm-project/+/33e1c2c1b8a6fea5aaf6067fde636dee648df794"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "9c1973b594cddf493acd90f5cdb31da26db3c4cc"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@9c1973b594cddf493acd90f5cdb31da26db3c4cc",
"title": "9c1973b594cddf493acd90f5cdb31da26db3c4cc",
"url": "https://llvm.googlesource.com/llvm-project/+/9c1973b594cddf493acd90f5cdb31da26db3c4cc"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "530e9be2aac2f919e8ea8502a586f6584ac96365"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@530e9be2aac2f919e8ea8502a586f6584ac96365",
"title": "530e9be2aac2f919e8ea8502a586f6584ac96365",
"url": "https://llvm.googlesource.com/llvm-project/+/530e9be2aac2f919e8ea8502a586f6584ac96365"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "4343046327dc3831748300ed0bec3acd0ec6f72b"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@4343046327dc3831748300ed0bec3acd0ec6f72b",
"title": "4343046327dc3831748300ed0bec3acd0ec6f72b",
"url": "https://llvm.googlesource.com/llvm-project/+/4343046327dc3831748300ed0bec3acd0ec6f72b"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "b77090d12084b7bc4dfff5904c3644b4ff0b2c35"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@b77090d12084b7bc4dfff5904c3644b4ff0b2c35",
"title": "b77090d12084b7bc4dfff5904c3644b4ff0b2c35",
"url": "https://llvm.googlesource.com/llvm-project/+/b77090d12084b7bc4dfff5904c3644b4ff0b2c35"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "24ea9d257831ee5d6f827511b35ddb09036859b8"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@24ea9d257831ee5d6f827511b35ddb09036859b8",
"title": "24ea9d257831ee5d6f827511b35ddb09036859b8",
"url": "https://llvm.googlesource.com/llvm-project/+/24ea9d257831ee5d6f827511b35ddb09036859b8"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "eb8f4f21abd763c3736c098c1309ffe5f1bef0e7"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@eb8f4f21abd763c3736c098c1309ffe5f1bef0e7",
"title": "eb8f4f21abd763c3736c098c1309ffe5f1bef0e7",
"url": "https://llvm.googlesource.com/llvm-project/+/eb8f4f21abd763c3736c098c1309ffe5f1bef0e7"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "923c39724462818802c5cd5dfea8d9e12036c67d"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@923c39724462818802c5cd5dfea8d9e12036c67d",
"title": "923c39724462818802c5cd5dfea8d9e12036c67d",
"url": "https://llvm.googlesource.com/llvm-project/+/923c39724462818802c5cd5dfea8d9e12036c67d"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "df13cd932b1a57a7670513609b4f0bee1e5d0c84"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@df13cd932b1a57a7670513609b4f0bee1e5d0c84",
"title": "df13cd932b1a57a7670513609b4f0bee1e5d0c84",
"url": "https://llvm.googlesource.com/llvm-project/+/df13cd932b1a57a7670513609b4f0bee1e5d0c84"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "46be2fa731cf2c4e8d1faa66f7707888b5ab762c"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@46be2fa731cf2c4e8d1faa66f7707888b5ab762c",
"title": "46be2fa731cf2c4e8d1faa66f7707888b5ab762c",
"url": "https://llvm.googlesource.com/llvm-project/+/46be2fa731cf2c4e8d1faa66f7707888b5ab762c"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "8e92c097bed5645d44542ca164303924a87daae8"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@8e92c097bed5645d44542ca164303924a87daae8",
"title": "8e92c097bed5645d44542ca164303924a87daae8",
"url": "https://llvm.googlesource.com/llvm-project/+/8e92c097bed5645d44542ca164303924a87daae8"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "f9f79d184d6059b19e31fc543b2d42d1af7ce6fe"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@f9f79d184d6059b19e31fc543b2d42d1af7ce6fe",
"title": "f9f79d184d6059b19e31fc543b2d42d1af7ce6fe",
"url": "https://llvm.googlesource.com/llvm-project/+/f9f79d184d6059b19e31fc543b2d42d1af7ce6fe"
}
]
}
},
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "f9f79d184d6059b19e31fc543b2d42d1af7ce6fe",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8831843525966791312"
},
{
"key": "scheduler_job_id",
"value": "fuchsia/prod-clang-prod-unbounded-trigger-40be1bb5"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[15:38:06.888] Scheduled build:
{
"id": "8666413463767446545",
"builder": {
"project": "fuchsia",
"bucket": "prod",
"builder": "clang-prod-unbounded-trigger"
},
"createdBy": "project:fuchsia",
"createTime": "2026-10-31T15:38:06.455838394Z",
"updateTime": "2026-10-31T15:38:06.455838394Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "f9f79d184d6059b19e31fc543b2d42d1af7ce6fe",
"ref": "refs/heads/main"
}
}
}
[15:38:06.888] Task URL: https://cr-buildbucket.appspot.com/build/8666413463767446545
[15:38:06.888] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-prod-unbounded-trigger-40be1bb5:8831843525966791312:2:0) after 2m0s
[15:38:07.311] Received PubSub notification, asking Buildbucket for the build status
[15:38:07.403] Build status: SCHEDULED
[15:38:12.423] Received PubSub notification, asking Buildbucket for the build status
[15:38:12.454] Build status: STARTED
[15:40:06.903] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-prod-unbounded-trigger-40be1bb5:8831843525966791312:2:0)
[15:40:06.931] Build status: STARTED
[15:40:06.931] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-prod-unbounded-trigger-40be1bb5:8831843525966791312:5:0) after 8m25s
[15:48:32.119] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-prod-unbounded-trigger-40be1bb5:8831843525966791312:5:0)
[15:48:32.184] Build status: STARTED
[15:48:32.184] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-prod-unbounded-trigger-40be1bb5:8831843525966791312:6:0) after 3m26s
[15:51:58.371] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-prod-unbounded-trigger-40be1bb5:8831843525966791312:6:0)
[15:51:58.392] Build status: STARTED
[15:51:58.392] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-prod-unbounded-trigger-40be1bb5:8831843525966791312:7:0) after 4m45s
[15:56:43.411] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-prod-unbounded-trigger-40be1bb5:8831843525966791312:7:0)
[15:56:43.446] Build status: STARTED
[15:56:43.446] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-prod-unbounded-trigger-40be1bb5:8831843525966791312:8:0) after 6m16s
[16:02:59.502] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-prod-unbounded-trigger-40be1bb5:8831843525966791312:8:0)
[16:02:59.529] Build status: STARTED
[16:02:59.529] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-prod-unbounded-trigger-40be1bb5:8831843525966791312:9:0) after 2m55s
[16:05:54.849] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-prod-unbounded-trigger-40be1bb5:8831843525966791312:9:0)
[16:05:54.879] Build status: STARTED
[16:05:54.879] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-prod-unbounded-trigger-40be1bb5:8831843525966791312:10:0) after 9m31s
[16:15:26.002] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-prod-unbounded-trigger-40be1bb5:8831843525966791312:10:0)
[16:15:26.058] Build status: STARTED
[16:15:26.058] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-prod-unbounded-trigger-40be1bb5:8831843525966791312:11:0) after 3m16s
[16:18:42.248] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-prod-unbounded-trigger-40be1bb5:8831843525966791312:11:0)
[16:18:42.267] Build status: STARTED
[16:18:42.267] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-prod-unbounded-trigger-40be1bb5:8831843525966791312:12:0) after 2m44s
[16:21:26.287] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-prod-unbounded-trigger-40be1bb5:8831843525966791312:12:0)
[16:21:26.319] Build status: STARTED
[16:21:26.319] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-prod-unbounded-trigger-40be1bb5:8831843525966791312:13:0) after 9m20s
[16:30:46.396] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-prod-unbounded-trigger-40be1bb5:8831843525966791312:13:0)
[16:30:46.421] Build status: STARTED
[16:30:46.422] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-prod-unbounded-trigger-40be1bb5:8831843525966791312:14:0) after 4m20s
[16:35:06.742] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-prod-unbounded-trigger-40be1bb5:8831843525966791312:14:0)
[16:35:06.771] Build status: STARTED
[16:35:06.771] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-prod-unbounded-trigger-40be1bb5:8831843525966791312:15:0) after 7m54s
[16:43:00.917] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-prod-unbounded-trigger-40be1bb5:8831843525966791312:15:0)
[16:43:00.944] Build status: STARTED
[16:43:00.945] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-prod-unbounded-trigger-40be1bb5:8831843525966791312:16:0) after 5m7s
[16:48:07.973] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-prod-unbounded-trigger-40be1bb5:8831843525966791312:16:0)
[16:48:08.032] Build status: STARTED
[16:48:08.032] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-prod-unbounded-trigger-40be1bb5:8831843525966791312:17:0) after 8m55s
[16:57:03.064] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-prod-unbounded-trigger-40be1bb5:8831843525966791312:17:0)
[16:57:03.111] Build status: STARTED
[16:57:03.111] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-prod-unbounded-trigger-40be1bb5:8831843525966791312:18:0) after 9m46s
[17:06:49.321] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-prod-unbounded-trigger-40be1bb5:8831843525966791312:18:0)
[17:06:49.345] Build status: STARTED
[17:06:49.345] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-prod-unbounded-trigger-40be1bb5:8831843525966791312:19:0) after 1m39s
[17:08:28.363] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-prod-unbounded-trigger-40be1bb5:8831843525966791312:19:0)
[17:08:28.385] Build status: STARTED
[17:08:28.385] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-prod-unbounded-trigger-40be1bb5:8831843525966791312:20:0) after 6m36s
[17:15:04.584] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-prod-unbounded-trigger-40be1bb5:8831843525966791312:20:0)
[17:15:04.610] Build status: STARTED
[17:15:04.610] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-prod-unbounded-trigger-40be1bb5:8831843525966791312:21:0) after 7m44s
[17:22:48.643] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-prod-unbounded-trigger-40be1bb5:8831843525966791312:21:0)
[17:22:48.666] Build status: STARTED
[17:22:48.666] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-prod-unbounded-trigger-40be1bb5:8831843525966791312:22:0) after 1m8s
[17:23:56.832] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-prod-unbounded-trigger-40be1bb5:8831843525966791312:22:0)
[17:23:56.881] Build status: STARTED
[17:23:56.881] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-prod-unbounded-trigger-40be1bb5:8831843525966791312:23:0) after 4m34s
[17:28:31.216] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-prod-unbounded-trigger-40be1bb5:8831843525966791312:23:0)
[17:28:31.241] Build status: STARTED
[17:28:31.241] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-prod-unbounded-trigger-40be1bb5:8831843525966791312:24:0) after 2m44s
[17:31:15.428] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-prod-unbounded-trigger-40be1bb5:8831843525966791312:24:0)
[17:31:15.492] Build status: STARTED
[17:31:15.492] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-prod-unbounded-trigger-40be1bb5:8831843525966791312:25:0) after 6m50s
[17:38:05.509] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-prod-unbounded-trigger-40be1bb5:8831843525966791312:25:0)
[17:38:05.544] Build status: STARTED
[17:38:05.544] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-prod-unbounded-trigger-40be1bb5:8831843525966791312:26:0) after 2m33s
[17:40:38.561] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-prod-unbounded-trigger-40be1bb5:8831843525966791312:26:0)
[17:40:38.593] Build status: STARTED
[17:40:38.593] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-prod-unbounded-trigger-40be1bb5:8831843525966791312:27:0) after 7m36s
[17:48:14.614] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-prod-unbounded-trigger-40be1bb5:8831843525966791312:27:0)
[17:48:14.681] Build status: STARTED
[17:48:14.681] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-prod-unbounded-trigger-40be1bb5:8831843525966791312:28:0) after 1m40s
[17:49:54.700] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-prod-unbounded-trigger-40be1bb5:8831843525966791312:28:0)
[17:49:54.721] Build status: STARTED
[17:49:54.721] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-prod-unbounded-trigger-40be1bb5:8831843525966791312:29:0) after 6m33s
[17:56:27.869] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-prod-unbounded-trigger-40be1bb5:8831843525966791312:29:0)
[17:56:27.949] Build status: STARTED
[17:56:27.949] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-prod-unbounded-trigger-40be1bb5:8831843525966791312:30:0) after 6m49s
[18:03:17.141] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-prod-unbounded-trigger-40be1bb5:8831843525966791312:30:0)
[18:03:17.166] Build status: STARTED
[18:03:17.166] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-prod-unbounded-trigger-40be1bb5:8831843525966791312:31:0) after 8m1s
[18:11:18.195] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-prod-unbounded-trigger-40be1bb5:8831843525966791312:31:0)
[18:11:18.233] Build status: STARTED
[18:11:18.233] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-prod-unbounded-trigger-40be1bb5:8831843525966791312:32:0) after 9m41s
[18:20:59.252] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-prod-unbounded-trigger-40be1bb5:8831843525966791312:32:0)
[18:20:59.399] Build status: STARTED
[18:20:59.400] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-prod-unbounded-trigger-40be1bb5:8831843525966791312:33:0) after 5m47s
[18:26:46.435] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-prod-unbounded-trigger-40be1bb5:8831843525966791312:33:0)
[18:26:46.463] Build status: STARTED
[18:26:46.463] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-prod-unbounded-trigger-40be1bb5:8831843525966791312:34:0) after 1m51s
[18:28:37.481] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-prod-unbounded-trigger-40be1bb5:8831843525966791312:34:0)
[18:28:37.511] Build status: STARTED
[18:28:37.511] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-prod-unbounded-trigger-40be1bb5:8831843525966791312:35:0) after 2m49s
[18:31:26.583] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-prod-unbounded-trigger-40be1bb5:8831843525966791312:35:0)
[18:31:26.636] Build status: STARTED
[18:31:26.636] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-prod-unbounded-trigger-40be1bb5:8831843525966791312:36:0) after 4m59s
[18:36:25.633] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-prod-unbounded-trigger-40be1bb5:8831843525966791312:36:0)
[18:36:25.655] Build status: STARTED
[18:36:25.655] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-prod-unbounded-trigger-40be1bb5:8831843525966791312:37:0) after 7m46s
[18:42:17.160] Received PubSub notification, asking Buildbucket for the build status
[18:42:17.183] Build:
{
"id": "8666413463767446545",
"builder": {
"project": "fuchsia",
"bucket": "prod",
"builder": "clang-prod-unbounded-trigger"
},
"createdBy": "project:fuchsia",
"createTime": "2026-10-31T15:38:06.455838394Z",
"startTime": "2026-10-31T15:38:12.156631551Z",
"endTime": "2026-10-31T18:42:15.033949822Z",
"updateTime": "2026-10-31T18:42:15.033949822Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "f9f79d184d6059b19e31fc543b2d42d1af7ce6fe",
"ref": "refs/heads/main"
}
}
}
[18:42:17.183] Invocation finished in 3h4m12.209671208s with status SUCCEEDED