[15:41:38.533] New invocation is queued and will start shortly
[15:41:39.652] Starting the invocation (attempt 1)
[15:41:39.675] Ignoring gitiles_ref tag without the buildset tag
[15:41:39.675] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[15:41:39.675] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[15:41:39.676] Buildbucket request:
{
"requestId": "8892633866494130096",
"builder": {
"project": "infra",
"bucket": "cron",
"builder": "chromium-lkgr-finder"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8892633866494130096",
"job": "infra/chromium-lkgr-finder",
"triggers": [
{
"cron": {
"generation": "132915"
},
"id": "cron:v1:132915"
}
]
}
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8892633866494130096"
},
{
"key": "scheduler_job_id",
"value": "infra/chromium-lkgr-finder"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[15:41:40.285] Scheduled build:
{
"id": "8727203804499445793",
"builder": {
"project": "infra",
"bucket": "cron",
"builder": "chromium-lkgr-finder"
},
"createdBy": "project:infra",
"createTime": "2024-12-29T15:41:39.813722879Z",
"updateTime": "2024-12-29T15:41:39.813722879Z",
"status": "SCHEDULED",
"input": {
}
}
[15:41:40.285] Task URL: https://cr-buildbucket.appspot.com/build/8727203804499445793
[15:41:40.285] Scheduling timer "check-buildbucket-build-status" (infra/chromium-lkgr-finder:8892633866494130096:2:0) after 1m57s
[15:42:04.936] Received PubSub notification, asking Buildbucket for the build status
[15:42:04.960] Build status: SCHEDULED
[15:43:37.307] Handling timer "check-buildbucket-build-status" (infra/chromium-lkgr-finder:8892633866494130096:2:0)
[15:43:37.338] Build status: SCHEDULED
[15:43:37.338] Scheduling timer "check-buildbucket-build-status" (infra/chromium-lkgr-finder:8892633866494130096:4:0) after 8m38s
[15:45:49.663] Received PubSub notification, asking Buildbucket for the build status
[15:45:49.688] Build status: STARTED
[15:52:15.354] Handling timer "check-buildbucket-build-status" (infra/chromium-lkgr-finder:8892633866494130096:4:0)
[15:52:15.399] Build status: STARTED
[15:52:15.399] Scheduling timer "check-buildbucket-build-status" (infra/chromium-lkgr-finder:8892633866494130096:6:0) after 9m58s
[16:02:13.514] Handling timer "check-buildbucket-build-status" (infra/chromium-lkgr-finder:8892633866494130096:6:0)
[16:02:13.544] Build status: STARTED
[16:02:13.544] Scheduling timer "check-buildbucket-build-status" (infra/chromium-lkgr-finder:8892633866494130096:7:0) after 6m14s
[16:08:27.571] Handling timer "check-buildbucket-build-status" (infra/chromium-lkgr-finder:8892633866494130096:7:0)
[16:08:27.972] Build status: STARTED
[16:08:27.972] Scheduling timer "check-buildbucket-build-status" (infra/chromium-lkgr-finder:8892633866494130096:8:0) after 5m16s
[16:13:44.111] Handling timer "check-buildbucket-build-status" (infra/chromium-lkgr-finder:8892633866494130096:8:0)
[16:13:44.196] Build status: STARTED
[16:13:44.196] Scheduling timer "check-buildbucket-build-status" (infra/chromium-lkgr-finder:8892633866494130096:9:0) after 1m46s
[16:15:30.651] Handling timer "check-buildbucket-build-status" (infra/chromium-lkgr-finder:8892633866494130096:9:0)
[16:15:30.674] Build status: STARTED
[16:15:30.674] Scheduling timer "check-buildbucket-build-status" (infra/chromium-lkgr-finder:8892633866494130096:10:0) after 4m27s
[16:19:57.729] Handling timer "check-buildbucket-build-status" (infra/chromium-lkgr-finder:8892633866494130096:10:0)
[16:19:57.765] Build status: STARTED
[16:19:57.765] Scheduling timer "check-buildbucket-build-status" (infra/chromium-lkgr-finder:8892633866494130096:11:0) after 5m22s
[16:25:19.865] Handling timer "check-buildbucket-build-status" (infra/chromium-lkgr-finder:8892633866494130096:11:0)
[16:25:19.892] Build status: STARTED
[16:25:19.892] Scheduling timer "check-buildbucket-build-status" (infra/chromium-lkgr-finder:8892633866494130096:12:0) after 2m21s
[16:27:40.924] Handling timer "check-buildbucket-build-status" (infra/chromium-lkgr-finder:8892633866494130096:12:0)
[16:27:40.950] Build status: STARTED
[16:27:40.950] Scheduling timer "check-buildbucket-build-status" (infra/chromium-lkgr-finder:8892633866494130096:13:0) after 9m30s
[16:37:10.964] Handling timer "check-buildbucket-build-status" (infra/chromium-lkgr-finder:8892633866494130096:13:0)
[16:37:11.046] Build status: STARTED
[16:37:11.046] Scheduling timer "check-buildbucket-build-status" (infra/chromium-lkgr-finder:8892633866494130096:14:0) after 3m51s
[16:41:02.137] Handling timer "check-buildbucket-build-status" (infra/chromium-lkgr-finder:8892633866494130096:14:0)
[16:41:02.176] Build status: STARTED
[16:41:02.177] Scheduling timer "check-buildbucket-build-status" (infra/chromium-lkgr-finder:8892633866494130096:15:0) after 1m3s
[16:42:05.245] Handling timer "check-buildbucket-build-status" (infra/chromium-lkgr-finder:8892633866494130096:15:0)
[16:42:05.363] Build status: STARTED
[16:42:05.363] Scheduling timer "check-buildbucket-build-status" (infra/chromium-lkgr-finder:8892633866494130096:16:0) after 3m54s
[16:45:59.484] Handling timer "check-buildbucket-build-status" (infra/chromium-lkgr-finder:8892633866494130096:16:0)
[16:45:59.512] Build status: STARTED
[16:45:59.512] Scheduling timer "check-buildbucket-build-status" (infra/chromium-lkgr-finder:8892633866494130096:17:0) after 2m59s
[16:48:58.526] Handling timer "check-buildbucket-build-status" (infra/chromium-lkgr-finder:8892633866494130096:17:0)
[16:48:58.570] Build status: STARTED
[16:48:58.570] Scheduling timer "check-buildbucket-build-status" (infra/chromium-lkgr-finder:8892633866494130096:18:0) after 8m16s
[16:57:14.594] Handling timer "check-buildbucket-build-status" (infra/chromium-lkgr-finder:8892633866494130096:18:0)
[16:57:14.628] Build status: STARTED
[16:57:14.628] Scheduling timer "check-buildbucket-build-status" (infra/chromium-lkgr-finder:8892633866494130096:19:0) after 2m47s
[17:00:01.651] Handling timer "check-buildbucket-build-status" (infra/chromium-lkgr-finder:8892633866494130096:19:0)
[17:00:01.679] Build status: STARTED
[17:00:01.679] Scheduling timer "check-buildbucket-build-status" (infra/chromium-lkgr-finder:8892633866494130096:20:0) after 5m51s
[17:05:52.700] Handling timer "check-buildbucket-build-status" (infra/chromium-lkgr-finder:8892633866494130096:20:0)
[17:05:52.719] Build status: STARTED
[17:05:52.719] Scheduling timer "check-buildbucket-build-status" (infra/chromium-lkgr-finder:8892633866494130096:21:0) after 5m56s
[17:11:48.738] Handling timer "check-buildbucket-build-status" (infra/chromium-lkgr-finder:8892633866494130096:21:0)
[17:11:48.772] Build status: STARTED
[17:11:48.772] Scheduling timer "check-buildbucket-build-status" (infra/chromium-lkgr-finder:8892633866494130096:22:0) after 8m45s
[17:20:33.837] Handling timer "check-buildbucket-build-status" (infra/chromium-lkgr-finder:8892633866494130096:22:0)
[17:20:33.861] Build status: STARTED
[17:20:33.861] Scheduling timer "check-buildbucket-build-status" (infra/chromium-lkgr-finder:8892633866494130096:23:0) after 4m23s
[17:23:05.320] Received PubSub notification, asking Buildbucket for the build status
[17:23:05.403] Build:
{
"id": "8727203804499445793",
"builder": {
"project": "infra",
"bucket": "cron",
"builder": "chromium-lkgr-finder"
},
"createdBy": "project:infra",
"createTime": "2024-12-29T15:41:39.813722879Z",
"startTime": "2024-12-29T15:45:49.028564710Z",
"endTime": "2024-12-29T17:23:04.569980094Z",
"updateTime": "2024-12-29T17:23:04.569980094Z",
"status": "SUCCESS",
"input": {
}
}
[17:23:05.403] Invocation finished in 1h41m26.874369702s with status SUCCEEDED