[03:12:45.586] New invocation is queued and will start shortly
[03:12:46.666] Starting the invocation (attempt 1)
[03:12:46.700] Popped buildset tag "buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/768726163730dda5bb490a5e88d4463ab5d3d231"
[03:12:46.700] Popped gitiles commit info from properties and tags
[03:12:46.700] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[03:12:46.700] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[03:12:46.700] Buildbucket request:
{
"requestId": "8879363228050066352",
"builder": {
"project": "fuchsia",
"bucket": "prod",
"builder": "clang-prod-unbounded-trigger"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8879363228050066352",
"job": "fuchsia/prod-clang-prod-unbounded-trigger-40be1bb5",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "964aedbe20d4a91b1b3349ba9e81cfe9d49b4984"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@964aedbe20d4a91b1b3349ba9e81cfe9d49b4984",
"title": "964aedbe20d4a91b1b3349ba9e81cfe9d49b4984",
"url": "https://llvm.googlesource.com/llvm-project/+/964aedbe20d4a91b1b3349ba9e81cfe9d49b4984"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "9662a6039c0320eb4473d87b47f0ed891a0f111c"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@9662a6039c0320eb4473d87b47f0ed891a0f111c",
"title": "9662a6039c0320eb4473d87b47f0ed891a0f111c",
"url": "https://llvm.googlesource.com/llvm-project/+/9662a6039c0320eb4473d87b47f0ed891a0f111c"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "b754e4085541df750c51677e522dd939e2aa9e2d"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@b754e4085541df750c51677e522dd939e2aa9e2d",
"title": "b754e4085541df750c51677e522dd939e2aa9e2d",
"url": "https://llvm.googlesource.com/llvm-project/+/b754e4085541df750c51677e522dd939e2aa9e2d"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "768726163730dda5bb490a5e88d4463ab5d3d231"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@768726163730dda5bb490a5e88d4463ab5d3d231",
"title": "768726163730dda5bb490a5e88d4463ab5d3d231",
"url": "https://llvm.googlesource.com/llvm-project/+/768726163730dda5bb490a5e88d4463ab5d3d231"
}
]
}
},
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "768726163730dda5bb490a5e88d4463ab5d3d231",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8879363228050066352"
},
{
"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:12:47.160] Scheduled build:
{
"id": "8713933166162190721",
"builder": {
"project": "fuchsia",
"bucket": "prod",
"builder": "clang-prod-unbounded-trigger"
},
"createdBy": "project:fuchsia",
"createTime": "2025-05-25T03:12:46.758708528Z",
"updateTime": "2025-05-25T03:12:46.758708528Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "768726163730dda5bb490a5e88d4463ab5d3d231",
"ref": "refs/heads/main"
}
}
}
[03:12:47.160] Task URL: https://cr-buildbucket.appspot.com/build/8713933166162190721
[03:12:47.160] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-prod-unbounded-trigger-40be1bb5:8879363228050066352:2:0) after 7m34s
[03:12:48.141] Received PubSub notification, asking Buildbucket for the build status
[03:12:48.171] Build status: SCHEDULED
[03:12:52.169] Received PubSub notification, asking Buildbucket for the build status
[03:12:52.205] Build status: STARTED
[03:20:21.415] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-prod-unbounded-trigger-40be1bb5:8879363228050066352:2:0)
[03:20:21.438] Build status: STARTED
[03:20:21.438] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-prod-unbounded-trigger-40be1bb5:8879363228050066352:5:0) after 2m5s
[03:22:26.450] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-prod-unbounded-trigger-40be1bb5:8879363228050066352:5:0)
[03:22:26.472] Build status: STARTED
[03:22:26.472] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-prod-unbounded-trigger-40be1bb5:8879363228050066352:6:0) after 1m42s
[03:24:08.553] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-prod-unbounded-trigger-40be1bb5:8879363228050066352:6:0)
[03:24:08.582] Build status: STARTED
[03:24:08.583] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-prod-unbounded-trigger-40be1bb5:8879363228050066352:7:0) after 8m4s
[03:32:12.630] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-prod-unbounded-trigger-40be1bb5:8879363228050066352:7:0)
[03:32:12.651] Build status: STARTED
[03:32:12.651] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-prod-unbounded-trigger-40be1bb5:8879363228050066352:8:0) after 7m23s
[03:39:35.813] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-prod-unbounded-trigger-40be1bb5:8879363228050066352:8:0)
[03:39:35.835] Build status: STARTED
[03:39:35.835] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-prod-unbounded-trigger-40be1bb5:8879363228050066352:9:0) after 9m9s
[03:48:44.881] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-prod-unbounded-trigger-40be1bb5:8879363228050066352:9:0)
[03:48:44.906] Build status: STARTED
[03:48:44.906] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-prod-unbounded-trigger-40be1bb5:8879363228050066352:10:0) after 4m23s
[03:53:07.919] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-prod-unbounded-trigger-40be1bb5:8879363228050066352:10:0)
[03:53:07.939] Build status: STARTED
[03:53:07.939] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-prod-unbounded-trigger-40be1bb5:8879363228050066352:11:0) after 9m36s
[04:02:43.982] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-prod-unbounded-trigger-40be1bb5:8879363228050066352:11:0)
[04:02:44.009] Build status: STARTED
[04:02:44.009] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-prod-unbounded-trigger-40be1bb5:8879363228050066352:12:0) after 2m5s
[04:04:49.059] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-prod-unbounded-trigger-40be1bb5:8879363228050066352:12:0)
[04:04:49.079] Build status: STARTED
[04:04:49.079] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-prod-unbounded-trigger-40be1bb5:8879363228050066352:13:0) after 1m40s
[04:06:29.257] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-prod-unbounded-trigger-40be1bb5:8879363228050066352:13:0)
[04:06:29.281] Build status: STARTED
[04:06:29.281] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-prod-unbounded-trigger-40be1bb5:8879363228050066352:14:0) after 7m3s
[04:13:32.339] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-prod-unbounded-trigger-40be1bb5:8879363228050066352:14:0)
[04:13:32.369] Build status: STARTED
[04:13:32.369] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-prod-unbounded-trigger-40be1bb5:8879363228050066352:15:0) after 6m34s
[04:20:06.560] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-prod-unbounded-trigger-40be1bb5:8879363228050066352:15:0)
[04:20:06.582] Build status: STARTED
[04:20:06.583] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-prod-unbounded-trigger-40be1bb5:8879363228050066352:16:0) after 9m47s
[04:29:53.695] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-prod-unbounded-trigger-40be1bb5:8879363228050066352:16:0)
[04:29:53.720] Build status: STARTED
[04:29:53.720] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-prod-unbounded-trigger-40be1bb5:8879363228050066352:17:0) after 1m40s
[04:31:33.742] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-prod-unbounded-trigger-40be1bb5:8879363228050066352:17:0)
[04:31:33.788] Build status: STARTED
[04:31:33.788] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-prod-unbounded-trigger-40be1bb5:8879363228050066352:18:0) after 9m26s
[04:40:59.794] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-prod-unbounded-trigger-40be1bb5:8879363228050066352:18:0)
[04:40:59.819] Build status: STARTED
[04:40:59.819] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-prod-unbounded-trigger-40be1bb5:8879363228050066352:19:0) after 6m7s
[04:47:06.926] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-prod-unbounded-trigger-40be1bb5:8879363228050066352:19:0)
[04:47:06.947] Build status: STARTED
[04:47:06.947] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-prod-unbounded-trigger-40be1bb5:8879363228050066352:20:0) after 8m8s
[04:55:15.009] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-prod-unbounded-trigger-40be1bb5:8879363228050066352:20:0)
[04:55:15.031] Build status: STARTED
[04:55:15.031] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-prod-unbounded-trigger-40be1bb5:8879363228050066352:21:0) after 5m59s
[05:01:14.050] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-prod-unbounded-trigger-40be1bb5:8879363228050066352:21:0)
[05:01:14.066] Build status: STARTED
[05:01:14.066] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-prod-unbounded-trigger-40be1bb5:8879363228050066352:22:0) after 9m33s
[05:10:47.088] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-prod-unbounded-trigger-40be1bb5:8879363228050066352:22:0)
[05:10:47.110] Build status: STARTED
[05:10:47.110] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-prod-unbounded-trigger-40be1bb5:8879363228050066352:23:0) after 5m27s
[05:16:14.260] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-prod-unbounded-trigger-40be1bb5:8879363228050066352:23:0)
[05:16:14.323] Build status: STARTED
[05:16:14.323] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-prod-unbounded-trigger-40be1bb5:8879363228050066352:24:0) after 5m14s
[05:21:28.342] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-prod-unbounded-trigger-40be1bb5:8879363228050066352:24:0)
[05:21:28.375] Build status: STARTED
[05:21:28.375] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-prod-unbounded-trigger-40be1bb5:8879363228050066352:25:0) after 3m54s
[05:25:22.555] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-prod-unbounded-trigger-40be1bb5:8879363228050066352:25:0)
[05:25:22.589] Build status: STARTED
[05:25:22.589] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-prod-unbounded-trigger-40be1bb5:8879363228050066352:26:0) after 7m0s
[05:32:22.788] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-prod-unbounded-trigger-40be1bb5:8879363228050066352:26:0)
[05:32:22.809] Build status: STARTED
[05:32:22.809] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-prod-unbounded-trigger-40be1bb5:8879363228050066352:27:0) after 8m29s
[05:40:51.848] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-prod-unbounded-trigger-40be1bb5:8879363228050066352:27:0)
[05:40:51.893] Build status: STARTED
[05:40:51.893] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-prod-unbounded-trigger-40be1bb5:8879363228050066352:28:0) after 1m48s
[05:42:40.140] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-prod-unbounded-trigger-40be1bb5:8879363228050066352:28:0)
[05:42:40.168] Build status: STARTED
[05:42:40.168] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-prod-unbounded-trigger-40be1bb5:8879363228050066352:29:0) after 4m46s
[05:47:26.418] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-prod-unbounded-trigger-40be1bb5:8879363228050066352:29:0)
[05:47:26.482] Build status: STARTED
[05:47:26.482] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-prod-unbounded-trigger-40be1bb5:8879363228050066352:30:0) after 9m7s
[05:56:33.555] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-prod-unbounded-trigger-40be1bb5:8879363228050066352:30:0)
[05:56:33.568] Build status: STARTED
[05:56:33.568] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-prod-unbounded-trigger-40be1bb5:8879363228050066352:31:0) after 3m10s
[05:59:43.593] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-prod-unbounded-trigger-40be1bb5:8879363228050066352:31:0)
[05:59:43.617] Build status: STARTED
[05:59:43.617] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-prod-unbounded-trigger-40be1bb5:8879363228050066352:32:0) after 5m48s
[06:05:31.635] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-prod-unbounded-trigger-40be1bb5:8879363228050066352:32:0)
[06:05:31.660] Build status: STARTED
[06:05:31.660] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-prod-unbounded-trigger-40be1bb5:8879363228050066352:33:0) after 5m50s
[06:11:21.717] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-prod-unbounded-trigger-40be1bb5:8879363228050066352:33:0)
[06:11:21.746] Build status: STARTED
[06:11:21.747] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-prod-unbounded-trigger-40be1bb5:8879363228050066352:34:0) after 5m55s
[06:17:16.869] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-prod-unbounded-trigger-40be1bb5:8879363228050066352:34:0)
[06:17:16.896] Build status: STARTED
[06:17:16.896] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-prod-unbounded-trigger-40be1bb5:8879363228050066352:35:0) after 9m21s
[06:26:38.024] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-prod-unbounded-trigger-40be1bb5:8879363228050066352:35:0)
[06:26:38.048] Build status: STARTED
[06:26:38.048] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-prod-unbounded-trigger-40be1bb5:8879363228050066352:36:0) after 9m49s
[06:36:27.302] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-prod-unbounded-trigger-40be1bb5:8879363228050066352:36:0)
[06:36:27.353] Build status: STARTED
[06:36:27.353] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-prod-unbounded-trigger-40be1bb5:8879363228050066352:37:0) after 2m22s
[06:38:49.370] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-prod-unbounded-trigger-40be1bb5:8879363228050066352:37:0)
[06:38:49.397] Build status: STARTED
[06:38:49.397] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-prod-unbounded-trigger-40be1bb5:8879363228050066352:38:0) after 6m14s
[06:43:54.897] Received PubSub notification, asking Buildbucket for the build status
[06:43:54.932] Build:
{
"id": "8713933166162190721",
"builder": {
"project": "fuchsia",
"bucket": "prod",
"builder": "clang-prod-unbounded-trigger"
},
"createdBy": "project:fuchsia",
"createTime": "2025-05-25T03:12:46.758708528Z",
"startTime": "2025-05-25T03:12:51.819022206Z",
"endTime": "2025-05-25T06:43:04.585392262Z",
"updateTime": "2025-05-25T06:43:04.585392262Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "768726163730dda5bb490a5e88d4463ab5d3d231",
"ref": "refs/heads/main"
}
}
}
[06:43:54.932] Invocation finished in 3h31m9.358711644s with status SUCCEEDED