[03:30:04.132] New invocation is queued and will start shortly
[03:30:05.260] Starting the invocation (attempt 1)
[03:30:05.285] Popped buildset tag "buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/1d4801f22ab1fd6205b1cf625b690aefc554cd4c"
[03:30:05.285] Popped gitiles commit info from properties and tags
[03:30:05.286] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[03:30:05.286] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[03:30:05.286] Buildbucket request:
{
"requestId": "8884526166144051648",
"builder": {
"project": "fuchsia",
"bucket": "prod",
"builder": "clang-prod-unbounded-trigger"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8884526166144051648",
"job": "fuchsia/prod-clang-prod-unbounded-trigger-40be1bb5",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "1d4801f22ab1fd6205b1cf625b690aefc554cd4c"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@1d4801f22ab1fd6205b1cf625b690aefc554cd4c",
"title": "1d4801f22ab1fd6205b1cf625b690aefc554cd4c",
"url": "https://llvm.googlesource.com/llvm-project/+/1d4801f22ab1fd6205b1cf625b690aefc554cd4c"
}
]
}
},
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "1d4801f22ab1fd6205b1cf625b690aefc554cd4c",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8884526166144051648"
},
{
"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"
}
}
[03:30:05.849] Scheduled build:
{
"id": "8719096104194780833",
"builder": {
"project": "fuchsia",
"bucket": "prod",
"builder": "clang-prod-unbounded-trigger"
},
"createdBy": "project:fuchsia",
"createTime": "2025-03-29T03:30:05.359735980Z",
"updateTime": "2025-03-29T03:30:05.359735980Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "1d4801f22ab1fd6205b1cf625b690aefc554cd4c",
"ref": "refs/heads/main"
}
}
}
[03:30:05.849] Task URL: https://cr-buildbucket.appspot.com/build/8719096104194780833
[03:30:05.849] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-prod-unbounded-trigger-40be1bb5:8884526166144051648:2:0) after 3m52s
[03:30:05.967] Received PubSub notification, asking Buildbucket for the build status
[03:30:06.047] Build status: SCHEDULED
[03:30:13.101] Received PubSub notification, asking Buildbucket for the build status
[03:30:13.121] Build status: STARTED
[03:33:57.876] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-prod-unbounded-trigger-40be1bb5:8884526166144051648:2:0)
[03:33:57.928] Build status: STARTED
[03:33:57.929] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-prod-unbounded-trigger-40be1bb5:8884526166144051648:5:0) after 1m6s
[03:35:03.997] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-prod-unbounded-trigger-40be1bb5:8884526166144051648:5:0)
[03:35:04.019] Build status: STARTED
[03:35:04.019] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-prod-unbounded-trigger-40be1bb5:8884526166144051648:6:0) after 8m55s
[03:43:59.197] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-prod-unbounded-trigger-40be1bb5:8884526166144051648:6:0)
[03:43:59.218] Build status: STARTED
[03:43:59.218] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-prod-unbounded-trigger-40be1bb5:8884526166144051648:7:0) after 9m57s
[03:53:56.398] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-prod-unbounded-trigger-40be1bb5:8884526166144051648:7:0)
[03:53:56.425] Build status: STARTED
[03:53:56.425] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-prod-unbounded-trigger-40be1bb5:8884526166144051648:8:0) after 8m16s
[04:02:12.559] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-prod-unbounded-trigger-40be1bb5:8884526166144051648:8:0)
[04:02:12.585] Build status: STARTED
[04:02:12.585] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-prod-unbounded-trigger-40be1bb5:8884526166144051648:9:0) after 7m32s
[04:09:44.786] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-prod-unbounded-trigger-40be1bb5:8884526166144051648:9:0)
[04:09:44.841] Build status: STARTED
[04:09:44.841] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-prod-unbounded-trigger-40be1bb5:8884526166144051648:10:0) after 8m41s
[04:18:25.918] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-prod-unbounded-trigger-40be1bb5:8884526166144051648:10:0)
[04:18:25.943] Build status: STARTED
[04:18:25.943] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-prod-unbounded-trigger-40be1bb5:8884526166144051648:11:0) after 3m2s
[04:21:28.360] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-prod-unbounded-trigger-40be1bb5:8884526166144051648:11:0)
[04:21:28.377] Build status: STARTED
[04:21:28.377] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-prod-unbounded-trigger-40be1bb5:8884526166144051648:12:0) after 8m18s
[04:29:46.751] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-prod-unbounded-trigger-40be1bb5:8884526166144051648:12:0)
[04:29:46.775] Build status: STARTED
[04:29:46.775] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-prod-unbounded-trigger-40be1bb5:8884526166144051648:13:0) after 9m35s
[04:39:22.168] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-prod-unbounded-trigger-40be1bb5:8884526166144051648:13:0)
[04:39:22.247] Build status: STARTED
[04:39:22.247] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-prod-unbounded-trigger-40be1bb5:8884526166144051648:14:0) after 8m38s
[04:48:00.520] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-prod-unbounded-trigger-40be1bb5:8884526166144051648:14:0)
[04:48:00.543] Build status: STARTED
[04:48:00.543] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-prod-unbounded-trigger-40be1bb5:8884526166144051648:15:0) after 4m44s
[04:52:44.577] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-prod-unbounded-trigger-40be1bb5:8884526166144051648:15:0)
[04:52:44.592] Build status: STARTED
[04:52:44.592] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-prod-unbounded-trigger-40be1bb5:8884526166144051648:16:0) after 7m25s
[05:00:09.693] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-prod-unbounded-trigger-40be1bb5:8884526166144051648:16:0)
[05:00:09.788] Build status: STARTED
[05:00:09.788] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-prod-unbounded-trigger-40be1bb5:8884526166144051648:17:0) after 4m23s
[05:04:32.812] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-prod-unbounded-trigger-40be1bb5:8884526166144051648:17:0)
[05:04:32.837] Build status: STARTED
[05:04:32.837] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-prod-unbounded-trigger-40be1bb5:8884526166144051648:18:0) after 4m59s
[05:09:31.909] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-prod-unbounded-trigger-40be1bb5:8884526166144051648:18:0)
[05:09:31.959] Build status: STARTED
[05:09:31.959] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-prod-unbounded-trigger-40be1bb5:8884526166144051648:19:0) after 3m57s
[05:13:29.073] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-prod-unbounded-trigger-40be1bb5:8884526166144051648:19:0)
[05:13:29.090] Build status: STARTED
[05:13:29.090] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-prod-unbounded-trigger-40be1bb5:8884526166144051648:20:0) after 6m27s
[05:19:56.187] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-prod-unbounded-trigger-40be1bb5:8884526166144051648:20:0)
[05:19:56.208] Build status: STARTED
[05:19:56.208] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-prod-unbounded-trigger-40be1bb5:8884526166144051648:21:0) after 2m29s
[05:22:25.224] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-prod-unbounded-trigger-40be1bb5:8884526166144051648:21:0)
[05:22:25.243] Build status: STARTED
[05:22:25.243] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-prod-unbounded-trigger-40be1bb5:8884526166144051648:22:0) after 8m56s
[05:31:21.651] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-prod-unbounded-trigger-40be1bb5:8884526166144051648:22:0)
[05:31:21.667] Build status: STARTED
[05:31:21.667] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-prod-unbounded-trigger-40be1bb5:8884526166144051648:23:0) after 7m18s
[05:38:39.976] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-prod-unbounded-trigger-40be1bb5:8884526166144051648:23:0)
[05:38:39.995] Build status: STARTED
[05:38:39.995] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-prod-unbounded-trigger-40be1bb5:8884526166144051648:24:0) after 9m1s
[05:47:41.640] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-prod-unbounded-trigger-40be1bb5:8884526166144051648:24:0)
[05:47:41.653] Build status: STARTED
[05:47:41.653] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-prod-unbounded-trigger-40be1bb5:8884526166144051648:25:0) after 2m31s
[05:50:12.820] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-prod-unbounded-trigger-40be1bb5:8884526166144051648:25:0)
[05:50:12.847] Build status: STARTED
[05:50:12.847] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-prod-unbounded-trigger-40be1bb5:8884526166144051648:26:0) after 3m2s
[05:53:14.872] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-prod-unbounded-trigger-40be1bb5:8884526166144051648:26:0)
[05:53:14.894] Build status: STARTED
[05:53:14.894] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-prod-unbounded-trigger-40be1bb5:8884526166144051648:27:0) after 1m22s
[05:54:36.915] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-prod-unbounded-trigger-40be1bb5:8884526166144051648:27:0)
[05:54:36.933] Build status: STARTED
[05:54:36.933] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-prod-unbounded-trigger-40be1bb5:8884526166144051648:28:0) after 1m28s
[05:56:05.130] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-prod-unbounded-trigger-40be1bb5:8884526166144051648:28:0)
[05:56:05.150] Build status: STARTED
[05:56:05.150] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-prod-unbounded-trigger-40be1bb5:8884526166144051648:29:0) after 2m49s
[05:58:54.273] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-prod-unbounded-trigger-40be1bb5:8884526166144051648:29:0)
[05:58:54.290] Build status: STARTED
[05:58:54.290] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-prod-unbounded-trigger-40be1bb5:8884526166144051648:30:0) after 1m10s
[06:00:04.344] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-prod-unbounded-trigger-40be1bb5:8884526166144051648:30:0)
[06:00:04.370] Build status: STARTED
[06:00:04.370] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-prod-unbounded-trigger-40be1bb5:8884526166144051648:31:0) after 8m16s
[06:08:20.401] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-prod-unbounded-trigger-40be1bb5:8884526166144051648:31:0)
[06:08:20.496] Build status: STARTED
[06:08:20.496] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-prod-unbounded-trigger-40be1bb5:8884526166144051648:32:0) after 1m58s
[06:10:18.611] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-prod-unbounded-trigger-40be1bb5:8884526166144051648:32:0)
[06:10:18.662] Build status: STARTED
[06:10:18.662] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-prod-unbounded-trigger-40be1bb5:8884526166144051648:33:0) after 5m38s
[06:15:56.689] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-prod-unbounded-trigger-40be1bb5:8884526166144051648:33:0)
[06:15:56.719] Build status: STARTED
[06:15:56.719] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-prod-unbounded-trigger-40be1bb5:8884526166144051648:34:0) after 8m36s
[06:24:32.937] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-prod-unbounded-trigger-40be1bb5:8884526166144051648:34:0)
[06:24:32.964] Build status: STARTED
[06:24:32.964] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-prod-unbounded-trigger-40be1bb5:8884526166144051648:35:0) after 7m4s
[06:31:36.986] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-prod-unbounded-trigger-40be1bb5:8884526166144051648:35:0)
[06:31:37.046] Build status: STARTED
[06:31:37.046] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-prod-unbounded-trigger-40be1bb5:8884526166144051648:36:0) after 6m48s
[06:38:25.224] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-prod-unbounded-trigger-40be1bb5:8884526166144051648:36:0)
[06:38:25.242] Build status: STARTED
[06:38:25.242] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-prod-unbounded-trigger-40be1bb5:8884526166144051648:37:0) after 2m40s
[06:41:05.394] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-prod-unbounded-trigger-40be1bb5:8884526166144051648:37:0)
[06:41:05.416] Build status: STARTED
[06:41:05.416] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-prod-unbounded-trigger-40be1bb5:8884526166144051648:38:0) after 4m31s
[06:45:36.567] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-prod-unbounded-trigger-40be1bb5:8884526166144051648:38:0)
[06:45:36.647] Build status: STARTED
[06:45:36.647] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-prod-unbounded-trigger-40be1bb5:8884526166144051648:39:0) after 8m45s
[06:54:21.662] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-prod-unbounded-trigger-40be1bb5:8884526166144051648:39:0)
[06:54:21.736] Build status: STARTED
[06:54:21.736] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-prod-unbounded-trigger-40be1bb5:8884526166144051648:40:0) after 2m52s
[06:57:14.200] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-prod-unbounded-trigger-40be1bb5:8884526166144051648:40:0)
[06:57:14.216] Build status: STARTED
[06:57:14.216] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-prod-unbounded-trigger-40be1bb5:8884526166144051648:41:0) after 6m50s
[07:04:04.336] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-prod-unbounded-trigger-40be1bb5:8884526166144051648:41:0)
[07:04:04.355] Build status: STARTED
[07:04:04.355] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-prod-unbounded-trigger-40be1bb5:8884526166144051648:42:0) after 6m36s
[07:10:40.488] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-prod-unbounded-trigger-40be1bb5:8884526166144051648:42:0)
[07:10:40.572] Build status: STARTED
[07:10:40.572] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-prod-unbounded-trigger-40be1bb5:8884526166144051648:43:0) after 6m6s
[07:16:46.695] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-prod-unbounded-trigger-40be1bb5:8884526166144051648:43:0)
[07:16:46.719] Build status: STARTED
[07:16:46.719] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-prod-unbounded-trigger-40be1bb5:8884526166144051648:44:0) after 2m18s
[07:19:04.877] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-prod-unbounded-trigger-40be1bb5:8884526166144051648:44:0)
[07:19:04.901] Build status: STARTED
[07:19:04.901] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-prod-unbounded-trigger-40be1bb5:8884526166144051648:45:0) after 2m53s
[07:21:33.831] Received PubSub notification, asking Buildbucket for the build status
[07:21:33.847] Build:
{
"id": "8719096104194780833",
"builder": {
"project": "fuchsia",
"bucket": "prod",
"builder": "clang-prod-unbounded-trigger"
},
"createdBy": "project:fuchsia",
"createTime": "2025-03-29T03:30:05.359735980Z",
"startTime": "2025-03-29T03:30:12.517311186Z",
"endTime": "2025-03-29T07:21:33.556160983Z",
"updateTime": "2025-03-29T07:21:33.556160983Z",
"status": "INFRA_FAILURE",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "1d4801f22ab1fd6205b1cf625b690aefc554cd4c",
"ref": "refs/heads/main"
}
}
}
[07:21:33.847] Invocation finished in 3h51m29.729822932s with status FAILED