[13:21:08.125] New invocation is queued and will start shortly
[13:21:09.323] Starting the invocation (attempt 1)
[13:21:09.350] Ignoring gitiles_ref tag without the buildset tag
[13:21:09.350] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[13:21:09.350] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[13:21:09.350] Buildbucket request:
{
"requestId": "8934407907929274992",
"builder": {
"project": "pigweed",
"bucket": "infra.ci",
"builder": "auto-submit"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8934407907929274992",
"job": "pigweed/infra.ci-auto-submit",
"triggers": [
{
"cron": {
"generation": "4797"
},
"id": "cron:v1:4797"
}
]
}
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8934407907929274992"
},
{
"key": "scheduler_job_id",
"value": "pigweed/infra.ci-auto-submit"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[13:21:09.816] Scheduled build:
{
"id": "8768977845920805649",
"builder": {
"project": "pigweed",
"bucket": "infra.ci",
"builder": "auto-submit"
},
"createdBy": "project:pigweed",
"createTime": "2023-09-25T13:21:09.417724052Z",
"updateTime": "2023-09-25T13:21:09.417724052Z",
"status": "SCHEDULED",
"input": {
}
}
[13:21:09.816] Task URL: https://cr-buildbucket.appspot.com/build/8768977845920805649
[13:21:09.816] Scheduling timer "check-buildbucket-build-status" (pigweed/infra.ci-auto-submit:8934407907929274992:2:0) after 4m26s
[13:21:10.839] Received PubSub notification, asking Buildbucket for the build status
[13:21:10.914] Build status: SCHEDULED
[13:21:12.511] Received PubSub notification, asking Buildbucket for the build status
[13:21:12.549] Build status: STARTED
[13:25:35.840] Handling timer "check-buildbucket-build-status" (pigweed/infra.ci-auto-submit:8934407907929274992:2:0)
[13:25:35.860] Build status: STARTED
[13:25:35.860] Scheduling timer "check-buildbucket-build-status" (pigweed/infra.ci-auto-submit:8934407907929274992:5:0) after 6m12s
[13:31:47.995] Handling timer "check-buildbucket-build-status" (pigweed/infra.ci-auto-submit:8934407907929274992:5:0)
[13:31:48.049] Build status: STARTED
[13:31:48.049] Scheduling timer "check-buildbucket-build-status" (pigweed/infra.ci-auto-submit:8934407907929274992:6:0) after 9m49s
[13:41:37.169] Handling timer "check-buildbucket-build-status" (pigweed/infra.ci-auto-submit:8934407907929274992:6:0)
[13:41:37.198] Build status: STARTED
[13:41:37.198] Scheduling timer "check-buildbucket-build-status" (pigweed/infra.ci-auto-submit:8934407907929274992:7:0) after 5m21s
[13:46:58.267] Handling timer "check-buildbucket-build-status" (pigweed/infra.ci-auto-submit:8934407907929274992:7:0)
[13:46:58.299] Build status: STARTED
[13:46:58.299] Scheduling timer "check-buildbucket-build-status" (pigweed/infra.ci-auto-submit:8934407907929274992:8:0) after 1m7s
[13:48:05.442] Handling timer "check-buildbucket-build-status" (pigweed/infra.ci-auto-submit:8934407907929274992:8:0)
[13:48:05.495] Build status: STARTED
[13:48:05.495] Scheduling timer "check-buildbucket-build-status" (pigweed/infra.ci-auto-submit:8934407907929274992:9:0) after 6m56s
[13:55:01.686] Handling timer "check-buildbucket-build-status" (pigweed/infra.ci-auto-submit:8934407907929274992:9:0)
[13:55:01.724] Build status: STARTED
[13:55:01.724] Scheduling timer "check-buildbucket-build-status" (pigweed/infra.ci-auto-submit:8934407907929274992:10:0) after 2m27s
[13:57:28.738] Handling timer "check-buildbucket-build-status" (pigweed/infra.ci-auto-submit:8934407907929274992:10:0)
[13:57:28.756] Build status: STARTED
[13:57:28.756] Scheduling timer "check-buildbucket-build-status" (pigweed/infra.ci-auto-submit:8934407907929274992:11:0) after 2m20s
[13:59:49.027] Handling timer "check-buildbucket-build-status" (pigweed/infra.ci-auto-submit:8934407907929274992:11:0)
[13:59:49.049] Build status: STARTED
[13:59:49.049] Scheduling timer "check-buildbucket-build-status" (pigweed/infra.ci-auto-submit:8934407907929274992:12:0) after 9m53s
[14:09:42.085] Handling timer "check-buildbucket-build-status" (pigweed/infra.ci-auto-submit:8934407907929274992:12:0)
[14:09:42.189] Build status: STARTED
[14:09:42.189] Scheduling timer "check-buildbucket-build-status" (pigweed/infra.ci-auto-submit:8934407907929274992:13:0) after 4m16s
[14:13:58.338] Handling timer "check-buildbucket-build-status" (pigweed/infra.ci-auto-submit:8934407907929274992:13:0)
[14:13:58.367] Build status: STARTED
[14:13:58.367] Scheduling timer "check-buildbucket-build-status" (pigweed/infra.ci-auto-submit:8934407907929274992:14:0) after 2m33s
[14:16:31.812] Handling timer "check-buildbucket-build-status" (pigweed/infra.ci-auto-submit:8934407907929274992:14:0)
[14:16:31.879] Build status: STARTED
[14:16:31.879] Scheduling timer "check-buildbucket-build-status" (pigweed/infra.ci-auto-submit:8934407907929274992:15:0) after 1m2s
[14:17:33.939] Handling timer "check-buildbucket-build-status" (pigweed/infra.ci-auto-submit:8934407907929274992:15:0)
[14:17:33.959] Build status: STARTED
[14:17:33.959] Scheduling timer "check-buildbucket-build-status" (pigweed/infra.ci-auto-submit:8934407907929274992:16:0) after 2m36s
[14:20:09.978] Handling timer "check-buildbucket-build-status" (pigweed/infra.ci-auto-submit:8934407907929274992:16:0)
[14:20:10.023] Build status: STARTED
[14:20:10.023] Scheduling timer "check-buildbucket-build-status" (pigweed/infra.ci-auto-submit:8934407907929274992:17:0) after 9m9s
[14:21:34.544] Received PubSub notification, asking Buildbucket for the build status
[14:21:34.658] Build:
{
"id": "8768977845920805649",
"builder": {
"project": "pigweed",
"bucket": "infra.ci",
"builder": "auto-submit"
},
"createdBy": "project:pigweed",
"createTime": "2023-09-25T13:21:09.417724052Z",
"startTime": "2023-09-25T13:21:11.553129Z",
"endTime": "2023-09-25T14:21:34.175473681Z",
"updateTime": "2023-09-25T14:21:34.175473681Z",
"status": "SUCCESS",
"input": {
}
}
[14:21:34.658] Invocation finished in 1h0m26.539930372s with status SUCCEEDED