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

Definition (rev f3e38b70a272e0c6842ebbf2b785a76d5abf67c3)

buildbucket: <
  server: "cr-buildbucket.appspot.com"
  bucket: "ci"
  builder: "linux-internal_release"
>

Incoming triggers

Incoming properties

{
  "branch": "refs/heads/3.3",
  "repository": "https://r8.googlesource.com/r8",
  "revision": "641487378bb987df38233accadf69bf2133b22a6"
}

Incoming tags

  • buildset:commit/gitiles/r8.googlesource.com/r8/+/641487378bb987df38233accadf69bf2133b22a6
  • gitiles_ref:refs/heads/3.3

Debug log (UTC)

[19:30:08.816] New invocation is queued and will start shortly
[19:30:10.087] Starting the invocation (attempt 1)
[19:30:10.126] Popped buildset tag "buildset:commit/gitiles/r8.googlesource.com/r8/+/641487378bb987df38233accadf69bf2133b22a6"
[19:30:10.126] Popped gitiles commit info from properties and tags
[19:30:10.126] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[19:30:10.126] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[19:30:10.126] Buildbucket request:
{
  "requestId": "8979864368874911936",
  "builder": {
    "project": "r8",
    "bucket": "ci",
    "builder": "linux-internal_release"
  },
  "properties": {
      "$recipe_engine/scheduler": {
            "hostname": "luci-scheduler.appspot.com",
            "invocation": "8979864368874911936",
            "job": "r8/linux-internal_release",
            "triggers": [
                  {
                        "gitiles": {
                              "ref": "refs/heads/3.3",
                              "repo": "https://r8.googlesource.com/r8",
                              "revision": "641487378bb987df38233accadf69bf2133b22a6"
                            },
                        "id": "https://r8.googlesource.com/r8/+/refs/heads/3.3@641487378bb987df38233accadf69bf2133b22a6",
                        "title": "641487378bb987df38233accadf69bf2133b22a6",
                        "url": "https://r8.googlesource.com/r8/+/641487378bb987df38233accadf69bf2133b22a6"
                      }
                ]
          }
    },
  "gitilesCommit": {
    "host": "r8.googlesource.com",
    "project": "r8",
    "id": "641487378bb987df38233accadf69bf2133b22a6",
    "ref": "refs/heads/3.3"
  },
  "tags": [
    {
      "key": "scheduler_invocation_id",
      "value": "8979864368874911936"
    },
    {
      "key": "scheduler_job_id",
      "value": "r8/linux-internal_release"
    },
    {
      "key": "user_agent",
      "value": "luci-scheduler"
    }
  ],
  "notify": {
    "pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
  }
}
[19:30:10.640] Scheduled build:
{
  "id": "8814434306762881345",
  "builder": {
    "project": "r8",
    "bucket": "ci",
    "builder": "linux-internal_release"
  },
  "number": 649,
  "createdBy": "project:r8",
  "createTime": "2022-05-11T19:30:10.198250030Z",
  "updateTime": "2022-05-11T19:30:10.198250030Z",
  "status": "SCHEDULED",
  "input": {
    "gitilesCommit": {
      "host": "r8.googlesource.com",
      "project": "r8",
      "id": "641487378bb987df38233accadf69bf2133b22a6",
      "ref": "refs/heads/3.3"
    }
  }
}
[19:30:10.640] Task URL: https://cr-buildbucket.appspot.com/build/8814434306762881345
[19:30:10.640] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8979864368874911936:2:0) after 7m39s
[19:37:49.702] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8979864368874911936:2:0)
[19:37:49.733] Build status: SCHEDULED
[19:37:49.733] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8979864368874911936:3:0) after 7m9s
[19:44:58.801] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8979864368874911936:3:0)
[19:44:58.832] Build status: SCHEDULED
[19:44:58.832] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8979864368874911936:4:0) after 3m24s
[19:48:22.921] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8979864368874911936:4:0)
[19:48:23.184] Build status: SCHEDULED
[19:48:23.184] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8979864368874911936:5:0) after 3m38s
[19:52:01.199] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8979864368874911936:5:0)
[19:52:01.246] Build status: SCHEDULED
[19:52:01.246] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8979864368874911936:6:0) after 2m17s
[19:54:18.228] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8979864368874911936:6:0)
[19:54:18.312] Build status: SCHEDULED
[19:54:18.312] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8979864368874911936:7:0) after 2m59s
[19:57:17.329] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8979864368874911936:7:0)
[19:57:17.445] Build status: SCHEDULED
[19:57:17.445] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8979864368874911936:8:0) after 9m34s
[20:06:51.514] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8979864368874911936:8:0)
[20:06:51.601] Build status: SCHEDULED
[20:06:51.601] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8979864368874911936:9:0) after 9m26s
[20:16:17.966] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8979864368874911936:9:0)
[20:16:18.066] Build status: SCHEDULED
[20:16:18.066] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8979864368874911936:10:0) after 7m47s
[20:24:05.185] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8979864368874911936:10:0)
[20:24:05.221] Build status: SCHEDULED
[20:24:05.221] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8979864368874911936:11:0) after 2m43s
[20:26:48.940] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8979864368874911936:11:0)
[20:26:49.007] Build status: SCHEDULED
[20:26:49.007] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8979864368874911936:12:0) after 9m57s
[20:36:46.028] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8979864368874911936:12:0)
[20:36:46.065] Build status: SCHEDULED
[20:36:46.065] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8979864368874911936:13:0) after 6m23s
[20:43:09.166] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8979864368874911936:13:0)
[20:43:09.199] Build status: SCHEDULED
[20:43:09.199] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8979864368874911936:14:0) after 4m5s
[20:47:14.255] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8979864368874911936:14:0)
[20:47:14.288] Build status: SCHEDULED
[20:47:14.288] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8979864368874911936:15:0) after 7m25s
[20:54:39.307] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8979864368874911936:15:0)
[20:54:39.340] Build status: SCHEDULED
[20:54:39.340] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8979864368874911936:16:0) after 3m27s
[20:58:06.486] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8979864368874911936:16:0)
[20:58:06.535] Build status: SCHEDULED
[20:58:06.535] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8979864368874911936:17:0) after 1m25s
[20:59:31.551] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8979864368874911936:17:0)
[20:59:31.600] Build status: SCHEDULED
[20:59:31.600] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8979864368874911936:18:0) after 3m45s
[21:03:16.619] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8979864368874911936:18:0)
[21:03:16.654] Build status: SCHEDULED
[21:03:16.654] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8979864368874911936:19:0) after 7m16s
[21:10:32.866] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8979864368874911936:19:0)
[21:10:32.896] Build status: SCHEDULED
[21:10:32.896] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8979864368874911936:20:0) after 1m27s
[21:11:59.913] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8979864368874911936:20:0)
[21:11:59.986] Build status: SCHEDULED
[21:11:59.986] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8979864368874911936:21:0) after 6m27s
[21:18:27.066] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8979864368874911936:21:0)
[21:18:27.102] Build status: SCHEDULED
[21:18:27.102] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8979864368874911936:22:0) after 3m26s
[21:21:53.194] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8979864368874911936:22:0)
[21:21:53.226] Build status: SCHEDULED
[21:21:53.226] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8979864368874911936:23:0) after 9m47s
[21:31:40.306] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8979864368874911936:23:0)
[21:31:40.336] Build status: SCHEDULED
[21:31:40.336] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8979864368874911936:24:0) after 4m32s
[21:36:12.372] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8979864368874911936:24:0)
[21:36:12.474] Build status: SCHEDULED
[21:36:12.474] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8979864368874911936:25:0) after 5m58s
[21:42:10.562] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8979864368874911936:25:0)
[21:42:10.610] Build status: SCHEDULED
[21:42:10.610] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8979864368874911936:26:0) after 7m32s
[21:49:42.689] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8979864368874911936:26:0)
[21:49:42.749] Build status: SCHEDULED
[21:49:42.749] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8979864368874911936:27:0) after 2m53s
[21:52:35.761] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8979864368874911936:27:0)
[21:52:35.814] Build status: SCHEDULED
[21:52:35.814] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8979864368874911936:28:0) after 3m41s
[21:56:16.832] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8979864368874911936:28:0)
[21:56:16.881] Build status: SCHEDULED
[21:56:16.881] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8979864368874911936:29:0) after 5m58s
[22:02:14.996] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8979864368874911936:29:0)
[22:02:15.057] Build status: SCHEDULED
[22:02:15.057] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8979864368874911936:30:0) after 6m1s
[22:08:16.223] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8979864368874911936:30:0)
[22:08:16.258] Build status: SCHEDULED
[22:08:16.258] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8979864368874911936:31:0) after 5m49s
[22:14:05.271] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8979864368874911936:31:0)
[22:14:05.304] Build status: SCHEDULED
[22:14:05.304] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8979864368874911936:32:0) after 8m50s
[22:22:55.352] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8979864368874911936:32:0)
[22:22:55.381] Build status: SCHEDULED
[22:22:55.381] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8979864368874911936:33:0) after 1m29s
[22:24:24.417] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8979864368874911936:33:0)
[22:24:24.479] Build status: SCHEDULED
[22:24:24.479] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8979864368874911936:34:0) after 7m34s
[22:31:58.705] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8979864368874911936:34:0)
[22:31:58.745] Build status: SCHEDULED
[22:31:58.745] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8979864368874911936:35:0) after 2m18s
[22:34:16.742] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8979864368874911936:35:0)
[22:34:16.778] Build status: SCHEDULED
[22:34:16.778] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8979864368874911936:36:0) after 1m33s
[22:35:49.797] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8979864368874911936:36:0)
[22:35:49.844] Build status: SCHEDULED
[22:35:49.844] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8979864368874911936:37:0) after 2m1s
[22:37:50.824] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8979864368874911936:37:0)
[22:37:50.994] Build status: SCHEDULED
[22:37:50.994] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8979864368874911936:38:0) after 2m22s
[22:40:13.486] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8979864368874911936:38:0)
[22:40:13.519] Build status: SCHEDULED
[22:40:13.519] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8979864368874911936:39:0) after 1m58s
[22:42:11.542] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8979864368874911936:39:0)
[22:42:11.571] Build status: SCHEDULED
[22:42:11.571] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8979864368874911936:40:0) after 4m0s
[22:46:11.558] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8979864368874911936:40:0)
[22:46:11.594] Build status: SCHEDULED
[22:46:11.594] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8979864368874911936:41:0) after 1m27s
[22:47:38.750] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8979864368874911936:41:0)
[22:47:38.781] Build status: SCHEDULED
[22:47:38.781] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8979864368874911936:42:0) after 7m13s
[22:54:51.866] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8979864368874911936:42:0)
[22:54:51.892] Build status: SCHEDULED
[22:54:51.892] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8979864368874911936:43:0) after 1m41s
[22:56:33.009] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8979864368874911936:43:0)
[22:56:33.038] Build status: SCHEDULED
[22:56:33.038] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8979864368874911936:44:0) after 8m55s
[23:05:28.259] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8979864368874911936:44:0)
[23:05:28.283] Build status: SCHEDULED
[23:05:28.283] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8979864368874911936:45:0) after 6m44s
[23:12:12.365] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8979864368874911936:45:0)
[23:12:12.393] Build status: SCHEDULED
[23:12:12.393] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8979864368874911936:46:0) after 3m32s
[23:15:44.544] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8979864368874911936:46:0)
[23:15:44.571] Build status: SCHEDULED
[23:15:44.571] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8979864368874911936:47:0) after 3m39s
[23:19:23.591] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8979864368874911936:47:0)
[23:19:23.656] Build status: SCHEDULED
[23:19:23.656] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8979864368874911936:48:0) after 3m12s
[23:22:35.869] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8979864368874911936:48:0)
[23:22:35.900] Build status: SCHEDULED
[23:22:35.900] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8979864368874911936:49:0) after 3m52s
[23:26:27.950] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8979864368874911936:49:0)
[23:26:27.977] Build status: SCHEDULED
[23:26:27.977] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8979864368874911936:50:0) after 9m33s
[23:36:01.163] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8979864368874911936:50:0)
[23:36:01.265] Build status: SCHEDULED
[23:36:01.265] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8979864368874911936:51:0) after 6m37s
[23:42:38.412] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8979864368874911936:51:0)
[23:42:38.460] Build status: SCHEDULED
[23:42:38.460] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8979864368874911936:52:0) after 8m33s
[23:51:11.525] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8979864368874911936:52:0)
[23:51:11.555] Build status: SCHEDULED
[23:51:11.555] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8979864368874911936:53:0) after 8m13s
[23:59:24.589] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8979864368874911936:53:0)
[23:59:24.619] Build status: SCHEDULED
[23:59:24.619] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8979864368874911936:54:0) after 2m41s
[00:02:05.765] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8979864368874911936:54:0)
[00:02:05.801] Build status: SCHEDULED
[00:02:05.801] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8979864368874911936:55:0) after 1m11s
[00:03:16.889] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8979864368874911936:55:0)
[00:03:16.937] Build status: SCHEDULED
[00:03:16.937] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8979864368874911936:56:0) after 1m30s
[00:04:47.353] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8979864368874911936:56:0)
[00:04:47.404] Build status: SCHEDULED
[00:04:47.404] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8979864368874911936:57:0) after 4m9s
[00:08:56.484] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8979864368874911936:57:0)
[00:08:56.506] Build status: SCHEDULED
[00:08:56.506] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8979864368874911936:58:0) after 1m50s
[00:10:46.527] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8979864368874911936:58:0)
[00:10:46.621] Build status: SCHEDULED
[00:10:46.621] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8979864368874911936:59:0) after 3m31s
[00:14:17.640] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8979864368874911936:59:0)
[00:14:17.675] Build status: SCHEDULED
[00:14:17.675] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8979864368874911936:60:0) after 7m21s
[00:16:39.645] Received PubSub notification, asking Buildbucket for the build status
[00:16:39.673] Build status: STARTED
[00:21:38.974] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8979864368874911936:60:0)
[00:21:39.004] Build status: STARTED
[00:21:39.004] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8979864368874911936:62:0) after 4m27s
[00:26:06.064] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8979864368874911936:62:0)
[00:26:06.180] Build status: STARTED
[00:26:06.180] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8979864368874911936:63:0) after 4m15s
[00:30:21.543] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8979864368874911936:63:0)
[00:30:21.581] Build status: STARTED
[00:30:21.581] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8979864368874911936:64:0) after 4m21s
[00:34:42.653] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8979864368874911936:64:0)
[00:34:42.692] Build status: STARTED
[00:34:42.692] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8979864368874911936:65:0) after 5m4s
[00:39:46.804] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8979864368874911936:65:0)
[00:39:46.828] Build status: STARTED
[00:39:46.828] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8979864368874911936:66:0) after 4m7s
[00:43:54.202] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8979864368874911936:66:0)
[00:43:54.241] Build status: STARTED
[00:43:54.241] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8979864368874911936:67:0) after 5m5s
[00:48:59.271] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8979864368874911936:67:0)
[00:48:59.303] Build status: STARTED
[00:48:59.303] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8979864368874911936:68:0) after 3m46s
[00:52:45.431] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8979864368874911936:68:0)
[00:52:45.466] Build status: STARTED
[00:52:45.466] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8979864368874911936:69:0) after 5m2s
[00:57:47.496] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8979864368874911936:69:0)
[00:57:47.529] Build status: STARTED
[00:57:47.529] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8979864368874911936:70:0) after 3m23s
[01:01:10.555] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8979864368874911936:70:0)
[01:01:10.591] Build status: STARTED
[01:01:10.591] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8979864368874911936:71:0) after 5m49s
[01:06:59.614] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8979864368874911936:71:0)
[01:06:59.644] Build status: STARTED
[01:06:59.644] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8979864368874911936:72:0) after 8m51s
[01:15:50.882] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8979864368874911936:72:0)
[01:15:50.925] Build status: STARTED
[01:15:50.925] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8979864368874911936:73:0) after 6m26s
[01:22:17.248] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8979864368874911936:73:0)
[01:22:17.285] Build status: STARTED
[01:22:17.285] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8979864368874911936:74:0) after 8m56s
[01:31:13.427] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8979864368874911936:74:0)
[01:31:13.467] Build status: STARTED
[01:31:13.467] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8979864368874911936:75:0) after 8m40s
[01:39:53.586] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8979864368874911936:75:0)
[01:39:53.614] Build status: STARTED
[01:39:53.614] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8979864368874911936:76:0) after 2m47s
[01:42:40.732] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8979864368874911936:76:0)
[01:42:40.766] Build status: STARTED
[01:42:40.766] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8979864368874911936:77:0) after 3m16s
[01:45:56.886] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8979864368874911936:77:0)
[01:45:56.916] Build status: STARTED
[01:45:56.916] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8979864368874911936:78:0) after 9m20s
[01:55:17.064] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8979864368874911936:78:0)
[01:55:17.101] Build status: STARTED
[01:55:17.101] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8979864368874911936:79:0) after 6m30s
[02:01:47.204] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8979864368874911936:79:0)
[02:01:47.237] Build status: STARTED
[02:01:47.237] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8979864368874911936:80:0) after 7m0s
[02:08:47.801] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8979864368874911936:80:0)
[02:08:47.836] Build status: STARTED
[02:08:47.836] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8979864368874911936:81:0) after 3m4s
[02:11:52.113] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8979864368874911936:81:0)
[02:11:52.145] Build status: STARTED
[02:11:52.145] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8979864368874911936:82:0) after 8m12s
[02:20:04.185] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8979864368874911936:82:0)
[02:20:04.285] Build status: STARTED
[02:20:04.285] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8979864368874911936:83:0) after 9m16s
[02:29:20.404] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8979864368874911936:83:0)
[02:29:20.441] Build status: STARTED
[02:29:20.441] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8979864368874911936:84:0) after 2m41s
[02:32:01.493] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8979864368874911936:84:0)
[02:32:01.525] Build status: STARTED
[02:32:01.525] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8979864368874911936:85:0) after 3m13s
[02:35:15.063] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8979864368874911936:85:0)
[02:35:15.103] Build status: STARTED
[02:35:15.103] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8979864368874911936:86:0) after 5m20s
[02:40:35.134] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8979864368874911936:86:0)
[02:40:35.171] Build status: STARTED
[02:40:35.171] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8979864368874911936:87:0) after 3m7s
[02:43:42.200] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8979864368874911936:87:0)
[02:43:42.236] Build status: STARTED
[02:43:42.236] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8979864368874911936:88:0) after 4m53s
[02:48:35.269] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8979864368874911936:88:0)
[02:48:35.310] Build status: STARTED
[02:48:35.310] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8979864368874911936:89:0) after 6m47s
[02:55:22.446] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8979864368874911936:89:0)
[02:55:22.485] Build status: STARTED
[02:55:22.485] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8979864368874911936:90:0) after 2m7s
[02:57:29.509] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8979864368874911936:90:0)
[02:57:29.539] Build status: STARTED
[02:57:29.539] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8979864368874911936:91:0) after 9m33s
[03:07:02.601] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8979864368874911936:91:0)
[03:07:02.634] Build status: STARTED
[03:07:02.634] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8979864368874911936:92:0) after 9m57s
[03:16:59.662] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8979864368874911936:92:0)
[03:16:59.700] Build status: STARTED
[03:16:59.700] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8979864368874911936:93:0) after 8m50s
[03:25:49.723] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8979864368874911936:93:0)
[03:25:49.810] Build status: STARTED
[03:25:49.810] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8979864368874911936:94:0) after 6m6s
[03:31:55.933] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8979864368874911936:94:0)
[03:31:55.976] Build status: STARTED
[03:31:55.976] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8979864368874911936:95:0) after 6m44s
[03:38:40.005] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8979864368874911936:95:0)
[03:38:40.061] Build status: STARTED
[03:38:40.061] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8979864368874911936:96:0) after 2m4s
[03:40:44.085] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8979864368874911936:96:0)
[03:40:44.146] Build status: STARTED
[03:40:44.146] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8979864368874911936:97:0) after 9m28s
[03:50:12.364] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8979864368874911936:97:0)
[03:50:12.401] Build status: STARTED
[03:50:12.401] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8979864368874911936:98:0) after 4m55s
[03:55:07.465] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8979864368874911936:98:0)
[03:55:07.501] Build status: STARTED
[03:55:07.501] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8979864368874911936:99:0) after 2m45s
[03:57:52.698] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8979864368874911936:99:0)
[03:57:52.749] Build status: STARTED
[03:57:52.749] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8979864368874911936:100:0) after 7m22s
[04:05:14.870] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8979864368874911936:100:0)
[04:05:14.919] Build status: STARTED
[04:05:14.919] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8979864368874911936:101:0) after 7m19s
[04:12:33.941] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8979864368874911936:101:0)
[04:12:33.980] Build status: STARTED
[04:12:33.980] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8979864368874911936:102:0) after 3m55s
[04:16:29.107] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8979864368874911936:102:0)
[04:16:29.164] Build status: STARTED
[04:16:29.164] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8979864368874911936:103:0) after 1m24s
[04:17:53.483] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8979864368874911936:103:0)
[04:17:53.515] Build status: STARTED
[04:17:53.515] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8979864368874911936:104:0) after 9m15s
[04:27:08.541] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8979864368874911936:104:0)
[04:27:08.578] Build status: STARTED
[04:27:08.578] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8979864368874911936:105:0) after 7m5s
[04:34:13.701] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8979864368874911936:105:0)
[04:34:13.732] Build status: STARTED
[04:34:13.733] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8979864368874911936:106:0) after 4m9s
[04:38:22.753] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8979864368874911936:106:0)
[04:38:22.781] Build status: STARTED
[04:38:22.781] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8979864368874911936:107:0) after 9m34s
[04:47:56.877] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8979864368874911936:107:0)
[04:47:56.916] Build status: STARTED
[04:47:56.916] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8979864368874911936:108:0) after 6m47s
[04:54:44.231] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8979864368874911936:108:0)
[04:54:44.280] Build status: STARTED
[04:54:44.280] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8979864368874911936:109:0) after 2m57s
[04:57:41.376] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8979864368874911936:109:0)
[04:57:41.418] Build status: STARTED
[04:57:41.418] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8979864368874911936:110:0) after 6m2s
[05:03:43.484] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8979864368874911936:110:0)
[05:03:43.538] Build status: STARTED
[05:03:43.538] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8979864368874911936:111:0) after 1m23s
[05:05:06.938] Handling timer "check-buildbucket-build-status" (r8/linux-internal_release:8979864368874911936:111:0)
[05:05:06.977] Build status: STARTED
[05:05:06.977] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal_release:8979864368874911936:112:0) after 8m45s
[05:07:38.270] Received PubSub notification, asking Buildbucket for the build status
[05:07:38.302] Build:
{
  "id": "8814434306762881345",
  "builder": {
    "project": "r8",
    "bucket": "ci",
    "builder": "linux-internal_release"
  },
  "number": 649,
  "createdBy": "project:r8",
  "createTime": "2022-05-11T19:30:10.198250030Z",
  "startTime": "2022-05-12T00:16:38.454971Z",
  "endTime": "2022-05-12T05:07:37.744034607Z",
  "updateTime": "2022-05-12T05:07:37.744034607Z",
  "status": "SUCCESS",
  "input": {
    "gitilesCommit": {
      "host": "r8.googlesource.com",
      "project": "r8",
      "id": "641487378bb987df38233accadf69bf2133b22a6",
      "ref": "refs/heads/3.3"
    }
  }
}
[05:07:38.302] Invocation finished in 9h37m29.501899626s with status SUCCEEDED