Status: SUCCEEDED
Triggered by: -
Duration: 6 hours
Actions:

Definition (rev 8e315401116bbc5f80ed0063020a73aea2b1cacc)

buildbucket: <
  server: "cr-buildbucket-dev.appspot.com"
  bucket: "ci"
  builder: "build-proto-win"
>

Incoming triggers

  • cron:v1:86380 (3 years ago)

Debug log (UTC)

[09:25:20.175] New invocation is queued and will start shortly
[09:25:21.270] Starting the invocation (attempt 1)
[09:25:21.322] Ignoring gitiles_ref tag without the buildset tag
[09:25:21.322] Preparing PubSub topic for "https://cr-buildbucket-dev.appspot.com"
[09:25:21.322] PubSub topic is "projects/luci-scheduler-dev/topics/scheduler.buildbucket.cr-buildbucket-dev~appspot.gserviceaccount.com"
[09:25:21.322] Buildbucket request:
{
  "requestId": "8969936753972988480",
  "builder": {
    "project": "infra",
    "bucket": "ci",
    "builder": "build-proto-win"
  },
  "properties": {
      "$recipe_engine/scheduler": {
            "hostname": "luci-scheduler-dev.appspot.com",
            "invocation": "8969936753972988480",
            "job": "infra/build-proto-win",
            "triggers": [
                  {
                        "cron": {
                              "generation": "86380"
                            },
                        "id": "cron:v1:86380"
                      }
                ]
          }
    },
  "tags": [
    {
      "key": "scheduler_invocation_id",
      "value": "8969936753972988480"
    },
    {
      "key": "scheduler_job_id",
      "value": "infra/build-proto-win"
    },
    {
      "key": "user_agent",
      "value": "luci-scheduler-dev"
    }
  ],
  "notify": {
    "pubsubTopic": "projects/luci-scheduler-dev/topics/scheduler.buildbucket.cr-buildbucket-dev~appspot.gserviceaccount.com"
  }
}
[09:25:21.912] Scheduled build:
{
  "id": "8804506692034196833",
  "builder": {
    "project": "infra",
    "bucket": "ci",
    "builder": "build-proto-win"
  },
  "number": 12339,
  "createdBy": "project:infra",
  "createTime": "2022-08-29T09:25:21.388500435Z",
  "updateTime": "2022-08-29T09:25:21.388500435Z",
  "status": "SCHEDULED",
  "input": {

  }
}
[09:25:21.912] Task URL: https://cr-buildbucket-dev.appspot.com/build/8804506692034196833
[09:25:21.912] Scheduling timer "check-buildbucket-build-status" (infra/build-proto-win:8969936753972988480:2:0) after 5m23s
[09:30:44.932] Handling timer "check-buildbucket-build-status" (infra/build-proto-win:8969936753972988480:2:0)
[09:30:45.045] Build status: SCHEDULED
[09:30:45.045] Scheduling timer "check-buildbucket-build-status" (infra/build-proto-win:8969936753972988480:3:0) after 3m5s
[09:33:50.068] Handling timer "check-buildbucket-build-status" (infra/build-proto-win:8969936753972988480:3:0)
[09:33:50.105] Build status: SCHEDULED
[09:33:50.105] Scheduling timer "check-buildbucket-build-status" (infra/build-proto-win:8969936753972988480:4:0) after 4m48s
[09:38:38.127] Handling timer "check-buildbucket-build-status" (infra/build-proto-win:8969936753972988480:4:0)
[09:38:38.415] Build status: SCHEDULED
[09:38:38.415] Scheduling timer "check-buildbucket-build-status" (infra/build-proto-win:8969936753972988480:5:0) after 7m5s
[09:45:43.438] Handling timer "check-buildbucket-build-status" (infra/build-proto-win:8969936753972988480:5:0)
[09:45:43.474] Build status: SCHEDULED
[09:45:43.474] Scheduling timer "check-buildbucket-build-status" (infra/build-proto-win:8969936753972988480:6:0) after 6m19s
[09:52:02.510] Handling timer "check-buildbucket-build-status" (infra/build-proto-win:8969936753972988480:6:0)
[09:52:02.558] Build status: SCHEDULED
[09:52:02.558] Scheduling timer "check-buildbucket-build-status" (infra/build-proto-win:8969936753972988480:7:0) after 7m22s
[09:59:24.577] Handling timer "check-buildbucket-build-status" (infra/build-proto-win:8969936753972988480:7:0)
[09:59:24.609] Build status: SCHEDULED
[09:59:24.609] Scheduling timer "check-buildbucket-build-status" (infra/build-proto-win:8969936753972988480:8:0) after 6m41s
[10:06:05.631] Handling timer "check-buildbucket-build-status" (infra/build-proto-win:8969936753972988480:8:0)
[10:06:06.315] Build status: SCHEDULED
[10:06:06.315] Scheduling timer "check-buildbucket-build-status" (infra/build-proto-win:8969936753972988480:9:0) after 1m11s
[10:07:17.336] Handling timer "check-buildbucket-build-status" (infra/build-proto-win:8969936753972988480:9:0)
[10:07:17.370] Build status: SCHEDULED
[10:07:17.370] Scheduling timer "check-buildbucket-build-status" (infra/build-proto-win:8969936753972988480:10:0) after 7m2s
[10:14:19.400] Handling timer "check-buildbucket-build-status" (infra/build-proto-win:8969936753972988480:10:0)
[10:14:19.552] Build status: SCHEDULED
[10:14:19.552] Scheduling timer "check-buildbucket-build-status" (infra/build-proto-win:8969936753972988480:11:0) after 9m36s
[10:23:55.572] Handling timer "check-buildbucket-build-status" (infra/build-proto-win:8969936753972988480:11:0)
[10:23:55.596] Build status: SCHEDULED
[10:23:55.596] Scheduling timer "check-buildbucket-build-status" (infra/build-proto-win:8969936753972988480:12:0) after 3m0s
[10:26:55.618] Handling timer "check-buildbucket-build-status" (infra/build-proto-win:8969936753972988480:12:0)
[10:26:55.649] Build status: SCHEDULED
[10:26:55.649] Scheduling timer "check-buildbucket-build-status" (infra/build-proto-win:8969936753972988480:13:0) after 7m21s
[10:34:16.747] Handling timer "check-buildbucket-build-status" (infra/build-proto-win:8969936753972988480:13:0)
[10:34:16.814] Build status: SCHEDULED
[10:34:16.814] Scheduling timer "check-buildbucket-build-status" (infra/build-proto-win:8969936753972988480:14:0) after 1m31s
[10:35:47.839] Handling timer "check-buildbucket-build-status" (infra/build-proto-win:8969936753972988480:14:0)
[10:35:47.900] Build status: SCHEDULED
[10:35:47.900] Scheduling timer "check-buildbucket-build-status" (infra/build-proto-win:8969936753972988480:15:0) after 6m18s
[10:42:05.923] Handling timer "check-buildbucket-build-status" (infra/build-proto-win:8969936753972988480:15:0)
[10:42:05.960] Build status: SCHEDULED
[10:42:05.960] Scheduling timer "check-buildbucket-build-status" (infra/build-proto-win:8969936753972988480:16:0) after 8m10s
[10:50:15.983] Handling timer "check-buildbucket-build-status" (infra/build-proto-win:8969936753972988480:16:0)
[10:50:16.011] Build status: SCHEDULED
[10:50:16.011] Scheduling timer "check-buildbucket-build-status" (infra/build-proto-win:8969936753972988480:17:0) after 2m2s
[10:52:18.094] Handling timer "check-buildbucket-build-status" (infra/build-proto-win:8969936753972988480:17:0)
[10:52:18.118] Build status: SCHEDULED
[10:52:18.118] Scheduling timer "check-buildbucket-build-status" (infra/build-proto-win:8969936753972988480:18:0) after 3m27s
[10:55:45.140] Handling timer "check-buildbucket-build-status" (infra/build-proto-win:8969936753972988480:18:0)
[10:55:45.169] Build status: SCHEDULED
[10:55:45.169] Scheduling timer "check-buildbucket-build-status" (infra/build-proto-win:8969936753972988480:19:0) after 2m30s
[10:58:15.192] Handling timer "check-buildbucket-build-status" (infra/build-proto-win:8969936753972988480:19:0)
[10:58:15.219] Build status: SCHEDULED
[10:58:15.219] Scheduling timer "check-buildbucket-build-status" (infra/build-proto-win:8969936753972988480:20:0) after 3m5s
[11:01:20.239] Handling timer "check-buildbucket-build-status" (infra/build-proto-win:8969936753972988480:20:0)
[11:01:20.272] Build status: SCHEDULED
[11:01:20.272] Scheduling timer "check-buildbucket-build-status" (infra/build-proto-win:8969936753972988480:21:0) after 5m53s
[11:07:13.320] Handling timer "check-buildbucket-build-status" (infra/build-proto-win:8969936753972988480:21:0)
[11:07:13.363] Build status: SCHEDULED
[11:07:13.363] Scheduling timer "check-buildbucket-build-status" (infra/build-proto-win:8969936753972988480:22:0) after 3m46s
[11:10:59.400] Handling timer "check-buildbucket-build-status" (infra/build-proto-win:8969936753972988480:22:0)
[11:10:59.444] Build status: SCHEDULED
[11:10:59.444] Scheduling timer "check-buildbucket-build-status" (infra/build-proto-win:8969936753972988480:23:0) after 5m23s
[11:16:22.465] Handling timer "check-buildbucket-build-status" (infra/build-proto-win:8969936753972988480:23:0)
[11:16:22.498] Build status: SCHEDULED
[11:16:22.498] Scheduling timer "check-buildbucket-build-status" (infra/build-proto-win:8969936753972988480:24:0) after 8m51s
[11:25:13.520] Handling timer "check-buildbucket-build-status" (infra/build-proto-win:8969936753972988480:24:0)
[11:25:13.543] Build status: SCHEDULED
[11:25:13.543] Scheduling timer "check-buildbucket-build-status" (infra/build-proto-win:8969936753972988480:25:0) after 1m3s
[11:26:16.564] Handling timer "check-buildbucket-build-status" (infra/build-proto-win:8969936753972988480:25:0)
[11:26:16.594] Build status: SCHEDULED
[11:26:16.595] Scheduling timer "check-buildbucket-build-status" (infra/build-proto-win:8969936753972988480:26:0) after 5m24s
[11:31:40.615] Handling timer "check-buildbucket-build-status" (infra/build-proto-win:8969936753972988480:26:0)
[11:31:40.640] Build status: SCHEDULED
[11:31:40.640] Scheduling timer "check-buildbucket-build-status" (infra/build-proto-win:8969936753972988480:27:0) after 5m36s
[11:37:16.677] Handling timer "check-buildbucket-build-status" (infra/build-proto-win:8969936753972988480:27:0)
[11:37:16.706] Build status: SCHEDULED
[11:37:16.706] Scheduling timer "check-buildbucket-build-status" (infra/build-proto-win:8969936753972988480:28:0) after 1m29s
[11:38:45.730] Handling timer "check-buildbucket-build-status" (infra/build-proto-win:8969936753972988480:28:0)
[11:38:45.768] Build status: SCHEDULED
[11:38:45.768] Scheduling timer "check-buildbucket-build-status" (infra/build-proto-win:8969936753972988480:29:0) after 4m11s
[11:42:56.789] Handling timer "check-buildbucket-build-status" (infra/build-proto-win:8969936753972988480:29:0)
[11:42:56.812] Build status: SCHEDULED
[11:42:56.812] Scheduling timer "check-buildbucket-build-status" (infra/build-proto-win:8969936753972988480:30:0) after 6m23s
[11:49:19.839] Handling timer "check-buildbucket-build-status" (infra/build-proto-win:8969936753972988480:30:0)
[11:49:19.869] Build status: SCHEDULED
[11:49:19.869] Scheduling timer "check-buildbucket-build-status" (infra/build-proto-win:8969936753972988480:31:0) after 2m6s
[11:51:26.265] Handling timer "check-buildbucket-build-status" (infra/build-proto-win:8969936753972988480:31:0)
[11:51:26.295] Build status: SCHEDULED
[11:51:26.295] Scheduling timer "check-buildbucket-build-status" (infra/build-proto-win:8969936753972988480:32:0) after 7m19s
[11:58:45.332] Handling timer "check-buildbucket-build-status" (infra/build-proto-win:8969936753972988480:32:0)
[11:58:45.386] Build status: SCHEDULED
[11:58:45.386] Scheduling timer "check-buildbucket-build-status" (infra/build-proto-win:8969936753972988480:33:0) after 7m18s
[12:06:03.410] Handling timer "check-buildbucket-build-status" (infra/build-proto-win:8969936753972988480:33:0)
[12:06:03.451] Build status: SCHEDULED
[12:06:03.451] Scheduling timer "check-buildbucket-build-status" (infra/build-proto-win:8969936753972988480:34:0) after 2m20s
[12:08:23.473] Handling timer "check-buildbucket-build-status" (infra/build-proto-win:8969936753972988480:34:0)
[12:08:23.534] Build status: SCHEDULED
[12:08:23.534] Scheduling timer "check-buildbucket-build-status" (infra/build-proto-win:8969936753972988480:35:0) after 8m39s
[12:17:02.565] Handling timer "check-buildbucket-build-status" (infra/build-proto-win:8969936753972988480:35:0)
[12:17:02.603] Build status: SCHEDULED
[12:17:02.603] Scheduling timer "check-buildbucket-build-status" (infra/build-proto-win:8969936753972988480:36:0) after 9m20s
[12:26:22.629] Handling timer "check-buildbucket-build-status" (infra/build-proto-win:8969936753972988480:36:0)
[12:26:22.682] Build status: SCHEDULED
[12:26:22.682] Scheduling timer "check-buildbucket-build-status" (infra/build-proto-win:8969936753972988480:37:0) after 2m3s
[12:28:25.708] Handling timer "check-buildbucket-build-status" (infra/build-proto-win:8969936753972988480:37:0)
[12:28:25.743] Build status: SCHEDULED
[12:28:25.743] Scheduling timer "check-buildbucket-build-status" (infra/build-proto-win:8969936753972988480:38:0) after 4m59s
[12:33:24.766] Handling timer "check-buildbucket-build-status" (infra/build-proto-win:8969936753972988480:38:0)
[12:33:24.788] Build status: SCHEDULED
[12:33:24.788] Scheduling timer "check-buildbucket-build-status" (infra/build-proto-win:8969936753972988480:39:0) after 5m57s
[12:39:21.810] Handling timer "check-buildbucket-build-status" (infra/build-proto-win:8969936753972988480:39:0)
[12:39:21.856] Build status: SCHEDULED
[12:39:21.856] Scheduling timer "check-buildbucket-build-status" (infra/build-proto-win:8969936753972988480:40:0) after 4m31s
[12:43:52.878] Handling timer "check-buildbucket-build-status" (infra/build-proto-win:8969936753972988480:40:0)
[12:43:52.904] Build status: SCHEDULED
[12:43:52.904] Scheduling timer "check-buildbucket-build-status" (infra/build-proto-win:8969936753972988480:41:0) after 6m29s
[12:50:21.928] Handling timer "check-buildbucket-build-status" (infra/build-proto-win:8969936753972988480:41:0)
[12:50:21.963] Build status: SCHEDULED
[12:50:21.963] Scheduling timer "check-buildbucket-build-status" (infra/build-proto-win:8969936753972988480:42:0) after 4m26s
[12:54:47.984] Handling timer "check-buildbucket-build-status" (infra/build-proto-win:8969936753972988480:42:0)
[12:54:48.065] Build status: SCHEDULED
[12:54:48.065] Scheduling timer "check-buildbucket-build-status" (infra/build-proto-win:8969936753972988480:43:0) after 6m59s
[13:01:47.103] Handling timer "check-buildbucket-build-status" (infra/build-proto-win:8969936753972988480:43:0)
[13:01:47.709] Build status: SCHEDULED
[13:01:47.709] Scheduling timer "check-buildbucket-build-status" (infra/build-proto-win:8969936753972988480:44:0) after 7m19s
[13:09:06.730] Handling timer "check-buildbucket-build-status" (infra/build-proto-win:8969936753972988480:44:0)
[13:09:06.784] Build status: SCHEDULED
[13:09:06.784] Scheduling timer "check-buildbucket-build-status" (infra/build-proto-win:8969936753972988480:45:0) after 7m31s
[13:16:37.806] Handling timer "check-buildbucket-build-status" (infra/build-proto-win:8969936753972988480:45:0)
[13:16:37.867] Build status: SCHEDULED
[13:16:37.867] Scheduling timer "check-buildbucket-build-status" (infra/build-proto-win:8969936753972988480:46:0) after 1m55s
[13:18:32.892] Handling timer "check-buildbucket-build-status" (infra/build-proto-win:8969936753972988480:46:0)
[13:18:32.954] Build status: SCHEDULED
[13:18:32.954] Scheduling timer "check-buildbucket-build-status" (infra/build-proto-win:8969936753972988480:47:0) after 4m38s
[13:23:10.979] Handling timer "check-buildbucket-build-status" (infra/build-proto-win:8969936753972988480:47:0)
[13:23:11.005] Build status: SCHEDULED
[13:23:11.005] Scheduling timer "check-buildbucket-build-status" (infra/build-proto-win:8969936753972988480:48:0) after 8m15s
[13:31:26.027] Handling timer "check-buildbucket-build-status" (infra/build-proto-win:8969936753972988480:48:0)
[13:31:26.076] Build status: SCHEDULED
[13:31:26.076] Scheduling timer "check-buildbucket-build-status" (infra/build-proto-win:8969936753972988480:49:0) after 2m8s
[13:33:34.100] Handling timer "check-buildbucket-build-status" (infra/build-proto-win:8969936753972988480:49:0)
[13:33:34.124] Build status: SCHEDULED
[13:33:34.124] Scheduling timer "check-buildbucket-build-status" (infra/build-proto-win:8969936753972988480:50:0) after 2m54s
[13:36:28.164] Handling timer "check-buildbucket-build-status" (infra/build-proto-win:8969936753972988480:50:0)
[13:36:28.188] Build status: SCHEDULED
[13:36:28.188] Scheduling timer "check-buildbucket-build-status" (infra/build-proto-win:8969936753972988480:51:0) after 7m49s
[13:44:17.650] Handling timer "check-buildbucket-build-status" (infra/build-proto-win:8969936753972988480:51:0)
[13:44:17.675] Build status: SCHEDULED
[13:44:17.675] Scheduling timer "check-buildbucket-build-status" (infra/build-proto-win:8969936753972988480:52:0) after 9m8s
[13:53:25.698] Handling timer "check-buildbucket-build-status" (infra/build-proto-win:8969936753972988480:52:0)
[13:53:25.736] Build status: SCHEDULED
[13:53:25.736] Scheduling timer "check-buildbucket-build-status" (infra/build-proto-win:8969936753972988480:53:0) after 3m52s
[13:57:17.871] Handling timer "check-buildbucket-build-status" (infra/build-proto-win:8969936753972988480:53:0)
[13:57:17.901] Build status: SCHEDULED
[13:57:17.901] Scheduling timer "check-buildbucket-build-status" (infra/build-proto-win:8969936753972988480:54:0) after 1m50s
[13:59:07.931] Handling timer "check-buildbucket-build-status" (infra/build-proto-win:8969936753972988480:54:0)
[13:59:07.974] Build status: SCHEDULED
[13:59:07.974] Scheduling timer "check-buildbucket-build-status" (infra/build-proto-win:8969936753972988480:55:0) after 3m11s
[14:02:19.000] Handling timer "check-buildbucket-build-status" (infra/build-proto-win:8969936753972988480:55:0)
[14:02:19.685] Build status: SCHEDULED
[14:02:19.685] Scheduling timer "check-buildbucket-build-status" (infra/build-proto-win:8969936753972988480:56:0) after 5m20s
[14:07:39.711] Handling timer "check-buildbucket-build-status" (infra/build-proto-win:8969936753972988480:56:0)
[14:07:39.747] Build status: SCHEDULED
[14:07:39.747] Scheduling timer "check-buildbucket-build-status" (infra/build-proto-win:8969936753972988480:57:0) after 9m13s
[14:16:52.769] Handling timer "check-buildbucket-build-status" (infra/build-proto-win:8969936753972988480:57:0)
[14:16:52.840] Build status: SCHEDULED
[14:16:52.840] Scheduling timer "check-buildbucket-build-status" (infra/build-proto-win:8969936753972988480:58:0) after 4m39s
[14:21:31.937] Handling timer "check-buildbucket-build-status" (infra/build-proto-win:8969936753972988480:58:0)
[14:21:31.960] Build status: SCHEDULED
[14:21:31.960] Scheduling timer "check-buildbucket-build-status" (infra/build-proto-win:8969936753972988480:59:0) after 3m44s
[14:25:15.987] Handling timer "check-buildbucket-build-status" (infra/build-proto-win:8969936753972988480:59:0)
[14:25:16.055] Build status: SCHEDULED
[14:25:16.055] Scheduling timer "check-buildbucket-build-status" (infra/build-proto-win:8969936753972988480:60:0) after 6m10s
[14:31:26.077] Handling timer "check-buildbucket-build-status" (infra/build-proto-win:8969936753972988480:60:0)
[14:31:26.126] Build status: SCHEDULED
[14:31:26.126] Scheduling timer "check-buildbucket-build-status" (infra/build-proto-win:8969936753972988480:61:0) after 6m13s
[14:37:39.149] Handling timer "check-buildbucket-build-status" (infra/build-proto-win:8969936753972988480:61:0)
[14:37:39.190] Build status: SCHEDULED
[14:37:39.190] Scheduling timer "check-buildbucket-build-status" (infra/build-proto-win:8969936753972988480:62:0) after 4m31s
[14:42:10.211] Handling timer "check-buildbucket-build-status" (infra/build-proto-win:8969936753972988480:62:0)
[14:42:10.262] Build status: SCHEDULED
[14:42:10.262] Scheduling timer "check-buildbucket-build-status" (infra/build-proto-win:8969936753972988480:63:0) after 7m25s
[14:49:35.289] Handling timer "check-buildbucket-build-status" (infra/build-proto-win:8969936753972988480:63:0)
[14:49:35.315] Build status: SCHEDULED
[14:49:35.315] Scheduling timer "check-buildbucket-build-status" (infra/build-proto-win:8969936753972988480:64:0) after 2m37s
[14:52:12.347] Handling timer "check-buildbucket-build-status" (infra/build-proto-win:8969936753972988480:64:0)
[14:52:12.388] Build status: SCHEDULED
[14:52:12.388] Scheduling timer "check-buildbucket-build-status" (infra/build-proto-win:8969936753972988480:65:0) after 9m5s
[15:01:17.418] Handling timer "check-buildbucket-build-status" (infra/build-proto-win:8969936753972988480:65:0)
[15:01:17.488] Build status: SCHEDULED
[15:01:17.489] Scheduling timer "check-buildbucket-build-status" (infra/build-proto-win:8969936753972988480:66:0) after 2m54s
[15:04:11.511] Handling timer "check-buildbucket-build-status" (infra/build-proto-win:8969936753972988480:66:0)
[15:04:11.554] Build status: SCHEDULED
[15:04:11.554] Scheduling timer "check-buildbucket-build-status" (infra/build-proto-win:8969936753972988480:67:0) after 1m8s
[15:05:19.576] Handling timer "check-buildbucket-build-status" (infra/build-proto-win:8969936753972988480:67:0)
[15:05:19.616] Build status: SCHEDULED
[15:05:19.616] Scheduling timer "check-buildbucket-build-status" (infra/build-proto-win:8969936753972988480:68:0) after 2m45s
[15:08:04.639] Handling timer "check-buildbucket-build-status" (infra/build-proto-win:8969936753972988480:68:0)
[15:08:04.681] Build status: SCHEDULED
[15:08:04.681] Scheduling timer "check-buildbucket-build-status" (infra/build-proto-win:8969936753972988480:69:0) after 2m25s
[15:10:29.770] Handling timer "check-buildbucket-build-status" (infra/build-proto-win:8969936753972988480:69:0)
[15:10:29.800] Build status: SCHEDULED
[15:10:29.800] Scheduling timer "check-buildbucket-build-status" (infra/build-proto-win:8969936753972988480:70:0) after 4m13s
[15:14:42.825] Handling timer "check-buildbucket-build-status" (infra/build-proto-win:8969936753972988480:70:0)
[15:14:42.851] Build status: SCHEDULED
[15:14:42.852] Scheduling timer "check-buildbucket-build-status" (infra/build-proto-win:8969936753972988480:71:0) after 1m15s
[15:15:57.874] Handling timer "check-buildbucket-build-status" (infra/build-proto-win:8969936753972988480:71:0)
[15:15:57.990] Build status: SCHEDULED
[15:15:57.990] Scheduling timer "check-buildbucket-build-status" (infra/build-proto-win:8969936753972988480:72:0) after 9m31s
[15:25:29.018] Handling timer "check-buildbucket-build-status" (infra/build-proto-win:8969936753972988480:72:0)
[15:25:29.054] Build status: SCHEDULED
[15:25:29.054] Scheduling timer "check-buildbucket-build-status" (infra/build-proto-win:8969936753972988480:73:0) after 1m21s
[15:26:50.123] Handling timer "check-buildbucket-build-status" (infra/build-proto-win:8969936753972988480:73:0)
[15:26:50.160] Build status: SCHEDULED
[15:26:50.160] Scheduling timer "check-buildbucket-build-status" (infra/build-proto-win:8969936753972988480:74:0) after 9m32s
[15:32:45.044] Received PubSub notification, asking Buildbucket for the build status
[15:32:45.091] Build status: STARTED
[15:34:25.154] Received PubSub notification, asking Buildbucket for the build status
[15:34:25.188] Build:
{
  "id": "8804506692034196833",
  "builder": {
    "project": "infra",
    "bucket": "ci",
    "builder": "build-proto-win"
  },
  "number": 12339,
  "createdBy": "project:infra",
  "createTime": "2022-08-29T09:25:21.388500435Z",
  "startTime": "2022-08-29T15:32:44.051651Z",
  "endTime": "2022-08-29T15:34:19.560691726Z",
  "updateTime": "2022-08-29T15:34:19.560691726Z",
  "status": "SUCCESS",
  "input": {

  }
}
[15:34:25.188] Invocation finished in 6h9m5.033304106s with status SUCCEEDED