[21:26:52.907] New invocation is queued and will start shortly
[21:26:54.297] Starting the invocation (attempt 1)
[21:26:54.319] Ignoring gitiles_ref tag without the buildset tag
[21:26:54.319] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[21:26:54.321] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[21:26:54.321] Buildbucket request:
{
"requestId": "8861265595532602208",
"builder": {
"project": "pigweed",
"bucket": "infra.dev.ci",
"builder": "bisector"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8861265595532602208",
"job": "pigweed/infra.dev.ci-bisector",
"triggers": [
{
"cron": {
"generation": "1747"
},
"id": "cron:v1:1747"
}
]
}
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8861265595532602208"
},
{
"key": "scheduler_job_id",
"value": "pigweed/infra.dev.ci-bisector"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[21:26:54.622] Scheduled build:
{
"id": "8695835533340768801",
"builder": {
"project": "pigweed",
"bucket": "infra.dev.ci",
"builder": "bisector"
},
"createdBy": "project:pigweed",
"createTime": "2025-12-10T21:26:54.368974924Z",
"updateTime": "2025-12-10T21:26:54.368974924Z",
"status": "SCHEDULED",
"input": {
}
}
[21:26:54.622] Task URL: https://cr-buildbucket.appspot.com/build/8695835533340768801
[21:26:54.622] Scheduling timer "check-buildbucket-build-status" (pigweed/infra.dev.ci-bisector:8861265595532602208:2:0) after 5m56s
[21:26:54.954] Received PubSub notification, asking Buildbucket for the build status
[21:26:54.979] Build status: SCHEDULED
[21:32:50.664] Handling timer "check-buildbucket-build-status" (pigweed/infra.dev.ci-bisector:8861265595532602208:2:0)
[21:32:50.680] Build status: SCHEDULED
[21:32:50.680] Scheduling timer "check-buildbucket-build-status" (pigweed/infra.dev.ci-bisector:8861265595532602208:4:0) after 6m31s
[21:39:21.647] Handling timer "check-buildbucket-build-status" (pigweed/infra.dev.ci-bisector:8861265595532602208:4:0)
[21:39:21.791] Build status: SCHEDULED
[21:39:21.791] Scheduling timer "check-buildbucket-build-status" (pigweed/infra.dev.ci-bisector:8861265595532602208:5:0) after 4m13s
[21:43:34.843] Handling timer "check-buildbucket-build-status" (pigweed/infra.dev.ci-bisector:8861265595532602208:5:0)
[21:43:34.880] Build status: SCHEDULED
[21:43:34.880] Scheduling timer "check-buildbucket-build-status" (pigweed/infra.dev.ci-bisector:8861265595532602208:6:0) after 1m2s
[21:44:36.886] Handling timer "check-buildbucket-build-status" (pigweed/infra.dev.ci-bisector:8861265595532602208:6:0)
[21:44:36.905] Build status: SCHEDULED
[21:44:36.905] Scheduling timer "check-buildbucket-build-status" (pigweed/infra.dev.ci-bisector:8861265595532602208:7:0) after 2m6s
[21:46:42.930] Handling timer "check-buildbucket-build-status" (pigweed/infra.dev.ci-bisector:8861265595532602208:7:0)
[21:46:42.974] Build status: SCHEDULED
[21:46:42.974] Scheduling timer "check-buildbucket-build-status" (pigweed/infra.dev.ci-bisector:8861265595532602208:8:0) after 7m15s
[21:53:57.990] Handling timer "check-buildbucket-build-status" (pigweed/infra.dev.ci-bisector:8861265595532602208:8:0)
[21:53:58.039] Build status: SCHEDULED
[21:53:58.039] Scheduling timer "check-buildbucket-build-status" (pigweed/infra.dev.ci-bisector:8861265595532602208:9:0) after 7m35s
[22:01:33.050] Handling timer "check-buildbucket-build-status" (pigweed/infra.dev.ci-bisector:8861265595532602208:9:0)
[22:01:33.136] Build status: SCHEDULED
[22:01:33.136] Scheduling timer "check-buildbucket-build-status" (pigweed/infra.dev.ci-bisector:8861265595532602208:10:0) after 2m16s
[22:03:49.323] Handling timer "check-buildbucket-build-status" (pigweed/infra.dev.ci-bisector:8861265595532602208:10:0)
[22:03:49.342] Build status: SCHEDULED
[22:03:49.342] Scheduling timer "check-buildbucket-build-status" (pigweed/infra.dev.ci-bisector:8861265595532602208:11:0) after 8m31s
[22:12:20.451] Handling timer "check-buildbucket-build-status" (pigweed/infra.dev.ci-bisector:8861265595532602208:11:0)
[22:12:20.589] Build status: SCHEDULED
[22:12:20.589] Scheduling timer "check-buildbucket-build-status" (pigweed/infra.dev.ci-bisector:8861265595532602208:12:0) after 4m29s
[22:16:49.609] Handling timer "check-buildbucket-build-status" (pigweed/infra.dev.ci-bisector:8861265595532602208:12:0)
[22:16:49.630] Build status: SCHEDULED
[22:16:49.630] Scheduling timer "check-buildbucket-build-status" (pigweed/infra.dev.ci-bisector:8861265595532602208:13:0) after 8m32s
[22:25:21.745] Handling timer "check-buildbucket-build-status" (pigweed/infra.dev.ci-bisector:8861265595532602208:13:0)
[22:25:21.887] Build status: SCHEDULED
[22:25:21.888] Scheduling timer "check-buildbucket-build-status" (pigweed/infra.dev.ci-bisector:8861265595532602208:14:0) after 7m59s
[22:33:20.856] Handling timer "check-buildbucket-build-status" (pigweed/infra.dev.ci-bisector:8861265595532602208:14:0)
[22:33:20.878] Build status: SCHEDULED
[22:33:20.878] Scheduling timer "check-buildbucket-build-status" (pigweed/infra.dev.ci-bisector:8861265595532602208:15:0) after 3m24s
[22:36:44.980] Handling timer "check-buildbucket-build-status" (pigweed/infra.dev.ci-bisector:8861265595532602208:15:0)
[22:36:44.997] Build status: SCHEDULED
[22:36:44.997] Scheduling timer "check-buildbucket-build-status" (pigweed/infra.dev.ci-bisector:8861265595532602208:16:0) after 7m36s
[22:44:21.030] Handling timer "check-buildbucket-build-status" (pigweed/infra.dev.ci-bisector:8861265595532602208:16:0)
[22:44:21.045] Build status: SCHEDULED
[22:44:21.046] Scheduling timer "check-buildbucket-build-status" (pigweed/infra.dev.ci-bisector:8861265595532602208:17:0) after 2m59s
[22:47:20.056] Handling timer "check-buildbucket-build-status" (pigweed/infra.dev.ci-bisector:8861265595532602208:17:0)
[22:47:20.140] Build status: SCHEDULED
[22:47:20.140] Scheduling timer "check-buildbucket-build-status" (pigweed/infra.dev.ci-bisector:8861265595532602208:18:0) after 3m25s
[22:50:45.103] Handling timer "check-buildbucket-build-status" (pigweed/infra.dev.ci-bisector:8861265595532602208:18:0)
[22:50:45.121] Build status: SCHEDULED
[22:50:45.121] Scheduling timer "check-buildbucket-build-status" (pigweed/infra.dev.ci-bisector:8861265595532602208:19:0) after 8m55s
[22:59:40.366] Handling timer "check-buildbucket-build-status" (pigweed/infra.dev.ci-bisector:8861265595532602208:19:0)
[22:59:40.477] Build status: SCHEDULED
[22:59:40.477] Scheduling timer "check-buildbucket-build-status" (pigweed/infra.dev.ci-bisector:8861265595532602208:20:0) after 4m34s
[23:04:14.549] Handling timer "check-buildbucket-build-status" (pigweed/infra.dev.ci-bisector:8861265595532602208:20:0)
[23:04:14.565] Build status: SCHEDULED
[23:04:14.565] Scheduling timer "check-buildbucket-build-status" (pigweed/infra.dev.ci-bisector:8861265595532602208:21:0) after 5m55s
[23:10:09.614] Handling timer "check-buildbucket-build-status" (pigweed/infra.dev.ci-bisector:8861265595532602208:21:0)
[23:10:09.632] Build status: SCHEDULED
[23:10:09.632] Scheduling timer "check-buildbucket-build-status" (pigweed/infra.dev.ci-bisector:8861265595532602208:22:0) after 1m2s
[23:11:11.618] Handling timer "check-buildbucket-build-status" (pigweed/infra.dev.ci-bisector:8861265595532602208:22:0)
[23:11:11.678] Build status: SCHEDULED
[23:11:11.678] Scheduling timer "check-buildbucket-build-status" (pigweed/infra.dev.ci-bisector:8861265595532602208:23:0) after 7m20s
[23:18:31.711] Handling timer "check-buildbucket-build-status" (pigweed/infra.dev.ci-bisector:8861265595532602208:23:0)
[23:18:31.786] Build status: SCHEDULED
[23:18:31.786] Scheduling timer "check-buildbucket-build-status" (pigweed/infra.dev.ci-bisector:8861265595532602208:24:0) after 7m15s
[23:25:46.847] Handling timer "check-buildbucket-build-status" (pigweed/infra.dev.ci-bisector:8861265595532602208:24:0)
[23:25:46.865] Build status: SCHEDULED
[23:25:46.865] Scheduling timer "check-buildbucket-build-status" (pigweed/infra.dev.ci-bisector:8861265595532602208:25:0) after 2m20s
[23:28:06.924] Handling timer "check-buildbucket-build-status" (pigweed/infra.dev.ci-bisector:8861265595532602208:25:0)
[23:28:06.942] Build status: SCHEDULED
[23:28:06.942] Scheduling timer "check-buildbucket-build-status" (pigweed/infra.dev.ci-bisector:8861265595532602208:26:0) after 9m35s
[23:37:41.966] Handling timer "check-buildbucket-build-status" (pigweed/infra.dev.ci-bisector:8861265595532602208:26:0)
[23:37:41.980] Build status: SCHEDULED
[23:37:41.980] Scheduling timer "check-buildbucket-build-status" (pigweed/infra.dev.ci-bisector:8861265595532602208:27:0) after 7m37s
[23:45:19.034] Handling timer "check-buildbucket-build-status" (pigweed/infra.dev.ci-bisector:8861265595532602208:27:0)
[23:45:19.095] Build status: SCHEDULED
[23:45:19.095] Scheduling timer "check-buildbucket-build-status" (pigweed/infra.dev.ci-bisector:8861265595532602208:28:0) after 8m45s
[23:54:04.110] Handling timer "check-buildbucket-build-status" (pigweed/infra.dev.ci-bisector:8861265595532602208:28:0)
[23:54:04.132] Build status: SCHEDULED
[23:54:04.132] Scheduling timer "check-buildbucket-build-status" (pigweed/infra.dev.ci-bisector:8861265595532602208:29:0) after 7m3s
[00:01:07.118] Handling timer "check-buildbucket-build-status" (pigweed/infra.dev.ci-bisector:8861265595532602208:29:0)
[00:01:07.152] Build status: SCHEDULED
[00:01:07.152] Scheduling timer "check-buildbucket-build-status" (pigweed/infra.dev.ci-bisector:8861265595532602208:30:0) after 2m46s
[00:03:53.165] Handling timer "check-buildbucket-build-status" (pigweed/infra.dev.ci-bisector:8861265595532602208:30:0)
[00:03:53.195] Build status: SCHEDULED
[00:03:53.195] Scheduling timer "check-buildbucket-build-status" (pigweed/infra.dev.ci-bisector:8861265595532602208:31:0) after 5m17s
[00:09:10.219] Handling timer "check-buildbucket-build-status" (pigweed/infra.dev.ci-bisector:8861265595532602208:31:0)
[00:09:10.238] Build status: SCHEDULED
[00:09:10.238] Scheduling timer "check-buildbucket-build-status" (pigweed/infra.dev.ci-bisector:8861265595532602208:32:0) after 4m18s
[00:12:26.549] Received PubSub notification, asking Buildbucket for the build status
[00:12:26.584] Build status: STARTED
[00:13:28.248] Handling timer "check-buildbucket-build-status" (pigweed/infra.dev.ci-bisector:8861265595532602208:32:0)
[00:13:28.287] Build status: STARTED
[00:13:28.287] Scheduling timer "check-buildbucket-build-status" (pigweed/infra.dev.ci-bisector:8861265595532602208:34:0) after 5m6s
[00:18:22.237] Received PubSub notification, asking Buildbucket for the build status
[00:18:22.276] Build:
{
"id": "8695835533340768801",
"builder": {
"project": "pigweed",
"bucket": "infra.dev.ci",
"builder": "bisector"
},
"createdBy": "project:pigweed",
"createTime": "2025-12-10T21:26:54.368974924Z",
"startTime": "2025-12-11T00:12:26.153959683Z",
"endTime": "2025-12-11T00:18:21.618973455Z",
"updateTime": "2025-12-11T00:18:21.618973455Z",
"status": "SUCCESS",
"input": {
}
}
[00:18:22.276] Invocation finished in 2h51m29.381666746s with status SUCCEEDED