LUCI Scheduler :: r8 :: linux-internal

Status: SUCCEEDED

Triggered by: -

Duration: 16 hours

Actions:

Definition (rev 11ee884dc0e65548e1df5af19abf13230aecda6e)

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

Incoming triggers

41d495cbbd9756e236912fd4924bf1f79fa9b244 (3 years ago)
91be310704afde858629ce53cc8b9fa9b946a69f (3 years ago)
f6298e673454f97a3903dcd135898f6a61ff89b1 (3 years ago)
6806d8dbd5c8bb589f866a2f6971711035666fda (3 years ago)
dd520b6bf4f08cabb711e4f4ef73f4097492eb2c (3 years ago)
8830c532de5e4b94c8f0b1dd2abc30495170b9d9 (3 years ago)
40879634ddf28768bb73babf6e0c539da652ae09 (3 years ago)

Incoming properties

{
  "branch": "refs/heads/main",
  "repository": "https://r8.googlesource.com/r8",
  "revision": "40879634ddf28768bb73babf6e0c539da652ae09"
}

Incoming tags

buildset:commit/gitiles/r8.googlesource.com/r8/+/40879634ddf28768bb73babf6e0c539da652ae09
gitiles_ref:refs/heads/main

Debug log (UTC)

[08:55:46.857] New invocation is queued and will start shortly
[08:55:48.983] Starting the invocation (attempt 1)
[08:55:49.036] Popped buildset tag "buildset:commit/gitiles/r8.googlesource.com/r8/+/40879634ddf28768bb73babf6e0c539da652ae09"
[08:55:49.036] Popped gitiles commit info from properties and tags
[08:55:49.036] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[08:55:49.036] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[08:55:49.036] Buildbucket request:
{
  "requestId": "8979270100964467600",
  "builder": {
    "project": "r8",
    "bucket": "ci",
    "builder": "linux-internal"
  },
  "properties": {
      "$recipe_engine/scheduler": {
            "hostname": "luci-scheduler.appspot.com",
            "invocation": "8979270100964467600",
            "job": "r8/linux-internal",
            "triggers": [
                  {
                        "gitiles": {
                              "ref": "refs/heads/main",
                              "repo": "https://r8.googlesource.com/r8",
                              "revision": "41d495cbbd9756e236912fd4924bf1f79fa9b244"
                            },
                        "id": "https://r8.googlesource.com/r8/+/refs/heads/main@41d495cbbd9756e236912fd4924bf1f79fa9b244",
                        "title": "41d495cbbd9756e236912fd4924bf1f79fa9b244",
                        "url": "https://r8.googlesource.com/r8/+/41d495cbbd9756e236912fd4924bf1f79fa9b244"
                      },
                  {
                        "gitiles": {
                              "ref": "refs/heads/main",
                              "repo": "https://r8.googlesource.com/r8",
                              "revision": "91be310704afde858629ce53cc8b9fa9b946a69f"
                            },
                        "id": "https://r8.googlesource.com/r8/+/refs/heads/main@91be310704afde858629ce53cc8b9fa9b946a69f",
                        "title": "91be310704afde858629ce53cc8b9fa9b946a69f",
                        "url": "https://r8.googlesource.com/r8/+/91be310704afde858629ce53cc8b9fa9b946a69f"
                      },
                  {
                        "gitiles": {
                              "ref": "refs/heads/main",
                              "repo": "https://r8.googlesource.com/r8",
                              "revision": "f6298e673454f97a3903dcd135898f6a61ff89b1"
                            },
                        "id": "https://r8.googlesource.com/r8/+/refs/heads/main@f6298e673454f97a3903dcd135898f6a61ff89b1",
                        "title": "f6298e673454f97a3903dcd135898f6a61ff89b1",
                        "url": "https://r8.googlesource.com/r8/+/f6298e673454f97a3903dcd135898f6a61ff89b1"
                      },
                  {
                        "gitiles": {
                              "ref": "refs/heads/main",
                              "repo": "https://r8.googlesource.com/r8",
                              "revision": "6806d8dbd5c8bb589f866a2f6971711035666fda"
                            },
                        "id": "https://r8.googlesource.com/r8/+/refs/heads/main@6806d8dbd5c8bb589f866a2f6971711035666fda",
                        "title": "6806d8dbd5c8bb589f866a2f6971711035666fda",
                        "url": "https://r8.googlesource.com/r8/+/6806d8dbd5c8bb589f866a2f6971711035666fda"
                      },
                  {
                        "gitiles": {
                              "ref": "refs/heads/main",
                              "repo": "https://r8.googlesource.com/r8",
                              "revision": "dd520b6bf4f08cabb711e4f4ef73f4097492eb2c"
                            },
                        "id": "https://r8.googlesource.com/r8/+/refs/heads/main@dd520b6bf4f08cabb711e4f4ef73f4097492eb2c",
                        "title": "dd520b6bf4f08cabb711e4f4ef73f4097492eb2c",
                        "url": "https://r8.googlesource.com/r8/+/dd520b6bf4f08cabb711e4f4ef73f4097492eb2c"
                      },
                  {
                        "gitiles": {
                              "ref": "refs/heads/main",
                              "repo": "https://r8.googlesource.com/r8",
                              "revision": "8830c532de5e4b94c8f0b1dd2abc30495170b9d9"
                            },
                        "id": "https://r8.googlesource.com/r8/+/refs/heads/main@8830c532de5e4b94c8f0b1dd2abc30495170b9d9",
                        "title": "8830c532de5e4b94c8f0b1dd2abc30495170b9d9",
                        "url": "https://r8.googlesource.com/r8/+/8830c532de5e4b94c8f0b1dd2abc30495170b9d9"
                      },
                  {
                        "gitiles": {
                              "ref": "refs/heads/main",
                              "repo": "https://r8.googlesource.com/r8",
                              "revision": "40879634ddf28768bb73babf6e0c539da652ae09"
                            },
                        "id": "https://r8.googlesource.com/r8/+/refs/heads/main@40879634ddf28768bb73babf6e0c539da652ae09",
                        "title": "40879634ddf28768bb73babf6e0c539da652ae09",
                        "url": "https://r8.googlesource.com/r8/+/40879634ddf28768bb73babf6e0c539da652ae09"
                      }
                ]
          }
    },
  "gitilesCommit": {
    "host": "r8.googlesource.com",
    "project": "r8",
    "id": "40879634ddf28768bb73babf6e0c539da652ae09",
    "ref": "refs/heads/main"
  },
  "tags": [
    {
      "key": "scheduler_invocation_id",
      "value": "8979270100964467600"
    },
    {
      "key": "scheduler_job_id",
      "value": "r8/linux-internal"
    },
    {
      "key": "user_agent",
      "value": "luci-scheduler"
    }
  ],
  "notify": {
    "pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
  }
}
[08:55:49.598] Scheduled build:
{
  "id": "8813840037899888593",
  "builder": {
    "project": "r8",
    "bucket": "ci",
    "builder": "linux-internal"
  },
  "number": 2554,
  "createdBy": "project:r8",
  "createTime": "2022-05-18T08:55:49.149776630Z",
  "updateTime": "2022-05-18T08:55:49.149776630Z",
  "status": "SCHEDULED",
  "input": {
    "gitilesCommit": {
      "host": "r8.googlesource.com",
      "project": "r8",
      "id": "40879634ddf28768bb73babf6e0c539da652ae09",
      "ref": "refs/heads/main"
    }
  }
}
[08:55:49.598] Task URL: https://cr-buildbucket.appspot.com/build/8813840037899888593
[08:55:49.598] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8979270100964467600:2:0) after 4m50s
[09:00:39.615] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8979270100964467600:2:0)
[09:00:39.648] Build status: SCHEDULED
[09:00:39.648] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8979270100964467600:3:0) after 7m5s
[09:07:44.700] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8979270100964467600:3:0)
[09:07:44.737] Build status: SCHEDULED
[09:07:44.737] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8979270100964467600:4:0) after 9m54s
[09:17:38.882] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8979270100964467600:4:0)
[09:17:38.911] Build status: SCHEDULED
[09:17:38.911] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8979270100964467600:5:0) after 1m8s
[09:18:46.961] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8979270100964467600:5:0)
[09:18:46.991] Build status: SCHEDULED
[09:18:46.992] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8979270100964467600:6:0) after 8m5s
[09:26:52.021] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8979270100964467600:6:0)
[09:26:52.051] Build status: SCHEDULED
[09:26:52.051] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8979270100964467600:7:0) after 5m31s
[09:32:23.070] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8979270100964467600:7:0)
[09:32:23.117] Build status: SCHEDULED
[09:32:23.117] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8979270100964467600:8:0) after 4m35s
[09:36:58.234] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8979270100964467600:8:0)
[09:36:58.271] Build status: SCHEDULED
[09:36:58.271] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8979270100964467600:9:0) after 9m46s
[09:46:45.418] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8979270100964467600:9:0)
[09:46:45.449] Build status: SCHEDULED
[09:46:45.449] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8979270100964467600:10:0) after 9m13s
[09:55:58.485] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8979270100964467600:10:0)
[09:55:58.513] Build status: SCHEDULED
[09:55:58.513] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8979270100964467600:11:0) after 9m8s
[10:05:06.531] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8979270100964467600:11:0)
[10:05:06.564] Build status: SCHEDULED
[10:05:06.564] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8979270100964467600:12:0) after 5m36s
[10:10:42.582] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8979270100964467600:12:0)
[10:10:42.602] Build status: SCHEDULED
[10:10:42.602] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8979270100964467600:13:0) after 5m36s
[10:16:18.688] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8979270100964467600:13:0)
[10:16:18.720] Build status: SCHEDULED
[10:16:18.720] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8979270100964467600:14:0) after 8m2s
[10:24:20.758] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8979270100964467600:14:0)
[10:24:20.791] Build status: SCHEDULED
[10:24:20.791] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8979270100964467600:15:0) after 6m0s
[10:30:20.993] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8979270100964467600:15:0)
[10:30:21.028] Build status: SCHEDULED
[10:30:21.028] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8979270100964467600:16:0) after 8m36s
[10:38:57.195] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8979270100964467600:16:0)
[10:38:57.228] Build status: SCHEDULED
[10:38:57.228] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8979270100964467600:17:0) after 4m16s
[10:43:13.375] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8979270100964467600:17:0)
[10:43:13.444] Build status: SCHEDULED
[10:43:13.444] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8979270100964467600:18:0) after 1m2s
[10:44:15.516] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8979270100964467600:18:0)
[10:44:15.663] Build status: SCHEDULED
[10:44:15.663] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8979270100964467600:19:0) after 1m7s
[10:45:22.714] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8979270100964467600:19:0)
[10:45:22.815] Build status: SCHEDULED
[10:45:22.815] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8979270100964467600:20:0) after 4m54s
[10:50:16.991] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8979270100964467600:20:0)
[10:50:17.015] Build status: SCHEDULED
[10:50:17.015] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8979270100964467600:21:0) after 9m4s
[10:59:21.068] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8979270100964467600:21:0)
[10:59:21.098] Build status: SCHEDULED
[10:59:21.098] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8979270100964467600:22:0) after 5m43s
[11:05:04.223] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8979270100964467600:22:0)
[11:05:04.263] Build status: SCHEDULED
[11:05:04.263] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8979270100964467600:23:0) after 8m8s
[11:13:12.352] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8979270100964467600:23:0)
[11:13:12.384] Build status: SCHEDULED
[11:13:12.384] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8979270100964467600:24:0) after 1m17s
[11:14:29.413] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8979270100964467600:24:0)
[11:14:29.432] Build status: SCHEDULED
[11:14:29.432] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8979270100964467600:25:0) after 2m55s
[11:17:24.474] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8979270100964467600:25:0)
[11:17:24.494] Build status: SCHEDULED
[11:17:24.494] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8979270100964467600:26:0) after 4m10s
[11:21:34.517] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8979270100964467600:26:0)
[11:21:34.545] Build status: SCHEDULED
[11:21:34.545] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8979270100964467600:27:0) after 7m51s
[11:29:25.666] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8979270100964467600:27:0)
[11:29:25.703] Build status: SCHEDULED
[11:29:25.703] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8979270100964467600:28:0) after 5m31s
[11:34:56.720] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8979270100964467600:28:0)
[11:34:56.751] Build status: SCHEDULED
[11:34:56.751] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8979270100964467600:29:0) after 3m45s
[11:38:41.770] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8979270100964467600:29:0)
[11:38:41.803] Build status: SCHEDULED
[11:38:41.803] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8979270100964467600:30:0) after 9m42s
[11:48:23.823] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8979270100964467600:30:0)
[11:48:23.855] Build status: SCHEDULED
[11:48:23.855] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8979270100964467600:31:0) after 5m43s
[11:54:06.886] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8979270100964467600:31:0)
[11:54:06.986] Build status: SCHEDULED
[11:54:06.986] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8979270100964467600:32:0) after 5m5s
[11:59:12.074] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8979270100964467600:32:0)
[11:59:12.104] Build status: SCHEDULED
[11:59:12.104] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8979270100964467600:33:0) after 1m57s
[12:01:09.469] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8979270100964467600:33:0)
[12:01:09.498] Build status: SCHEDULED
[12:01:09.498] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8979270100964467600:34:0) after 2m5s
[12:03:14.598] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8979270100964467600:34:0)
[12:03:14.631] Build status: SCHEDULED
[12:03:14.631] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8979270100964467600:35:0) after 6m16s
[12:09:30.652] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8979270100964467600:35:0)
[12:09:30.683] Build status: SCHEDULED
[12:09:30.683] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8979270100964467600:36:0) after 8m16s
[12:17:46.705] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8979270100964467600:36:0)
[12:17:46.734] Build status: SCHEDULED
[12:17:46.734] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8979270100964467600:37:0) after 1m22s
[12:19:09.128] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8979270100964467600:37:0)
[12:19:09.163] Build status: SCHEDULED
[12:19:09.163] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8979270100964467600:38:0) after 6m36s
[12:25:45.212] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8979270100964467600:38:0)
[12:25:45.231] Build status: SCHEDULED
[12:25:45.231] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8979270100964467600:39:0) after 7m59s
[12:33:44.476] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8979270100964467600:39:0)
[12:33:44.508] Build status: SCHEDULED
[12:33:44.508] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8979270100964467600:40:0) after 5m4s
[12:38:48.696] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8979270100964467600:40:0)
[12:38:48.745] Build status: SCHEDULED
[12:38:48.745] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8979270100964467600:41:0) after 6m24s
[12:45:12.943] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8979270100964467600:41:0)
[12:45:12.980] Build status: SCHEDULED
[12:45:12.980] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8979270100964467600:42:0) after 6m51s
[12:52:03.999] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8979270100964467600:42:0)
[12:52:04.045] Build status: SCHEDULED
[12:52:04.045] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8979270100964467600:43:0) after 4m55s
[12:56:59.278] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8979270100964467600:43:0)
[12:56:59.316] Build status: SCHEDULED
[12:56:59.316] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8979270100964467600:44:0) after 4m20s
[13:01:19.411] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8979270100964467600:44:0)
[13:01:19.452] Build status: SCHEDULED
[13:01:19.452] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8979270100964467600:45:0) after 1m10s
[13:02:29.471] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8979270100964467600:45:0)
[13:02:29.499] Build status: SCHEDULED
[13:02:29.499] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8979270100964467600:46:0) after 1m59s
[13:04:28.591] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8979270100964467600:46:0)
[13:04:28.637] Build status: SCHEDULED
[13:04:28.637] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8979270100964467600:47:0) after 4m41s
[13:09:09.776] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8979270100964467600:47:0)
[13:09:09.810] Build status: SCHEDULED
[13:09:09.810] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8979270100964467600:48:0) after 4m7s
[13:13:17.196] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8979270100964467600:48:0)
[13:13:17.232] Build status: SCHEDULED
[13:13:17.232] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8979270100964467600:49:0) after 9m7s
[13:22:24.454] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8979270100964467600:49:0)
[13:22:24.488] Build status: SCHEDULED
[13:22:24.488] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8979270100964467600:50:0) after 6m42s
[13:29:06.741] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8979270100964467600:50:0)
[13:29:06.770] Build status: SCHEDULED
[13:29:06.770] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8979270100964467600:51:0) after 7m21s
[13:36:27.888] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8979270100964467600:51:0)
[13:36:27.922] Build status: SCHEDULED
[13:36:27.922] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8979270100964467600:52:0) after 8m24s
[13:44:51.968] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8979270100964467600:52:0)
[13:44:51.998] Build status: SCHEDULED
[13:44:51.998] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8979270100964467600:53:0) after 4m34s
[13:49:26.331] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8979270100964467600:53:0)
[13:49:26.361] Build status: SCHEDULED
[13:49:26.361] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8979270100964467600:54:0) after 4m1s
[13:53:27.527] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8979270100964467600:54:0)
[13:53:27.565] Build status: SCHEDULED
[13:53:27.565] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8979270100964467600:55:0) after 9m40s
[14:03:07.649] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8979270100964467600:55:0)
[14:03:07.689] Build status: SCHEDULED
[14:03:07.690] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8979270100964467600:56:0) after 5m5s
[14:08:12.773] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8979270100964467600:56:0)
[14:08:12.806] Build status: SCHEDULED
[14:08:12.806] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8979270100964467600:57:0) after 9m48s
[14:18:00.965] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8979270100964467600:57:0)
[14:18:01.032] Build status: SCHEDULED
[14:18:01.032] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8979270100964467600:58:0) after 4m47s
[14:22:48.193] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8979270100964467600:58:0)
[14:22:48.224] Build status: SCHEDULED
[14:22:48.224] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8979270100964467600:59:0) after 4m27s
[14:27:15.245] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8979270100964467600:59:0)
[14:27:15.276] Build status: SCHEDULED
[14:27:15.276] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8979270100964467600:60:0) after 1m1s
[14:28:16.297] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8979270100964467600:60:0)
[14:28:16.327] Build status: SCHEDULED
[14:28:16.327] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8979270100964467600:61:0) after 6m42s
[14:34:58.497] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8979270100964467600:61:0)
[14:34:58.530] Build status: SCHEDULED
[14:34:58.531] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8979270100964467600:62:0) after 9m20s
[14:44:18.556] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8979270100964467600:62:0)
[14:44:18.591] Build status: SCHEDULED
[14:44:18.591] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8979270100964467600:63:0) after 2m33s
[14:46:51.616] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8979270100964467600:63:0)
[14:46:51.647] Build status: SCHEDULED
[14:46:51.647] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8979270100964467600:64:0) after 7m19s
[14:54:10.830] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8979270100964467600:64:0)
[14:54:10.867] Build status: SCHEDULED
[14:54:10.867] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8979270100964467600:65:0) after 2m53s
[14:57:03.886] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8979270100964467600:65:0)
[14:57:03.937] Build status: SCHEDULED
[14:57:03.937] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8979270100964467600:66:0) after 9m13s
[15:06:16.957] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8979270100964467600:66:0)
[15:06:16.987] Build status: SCHEDULED
[15:06:16.987] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8979270100964467600:67:0) after 4m44s
[15:11:01.035] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8979270100964467600:67:0)
[15:11:01.065] Build status: SCHEDULED
[15:11:01.065] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8979270100964467600:68:0) after 5m59s
[15:17:00.216] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8979270100964467600:68:0)
[15:17:00.248] Build status: SCHEDULED
[15:17:00.248] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8979270100964467600:69:0) after 1m44s
[15:18:44.286] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8979270100964467600:69:0)
[15:18:44.305] Build status: SCHEDULED
[15:18:44.305] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8979270100964467600:70:0) after 6m44s
[15:25:28.331] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8979270100964467600:70:0)
[15:25:28.385] Build status: SCHEDULED
[15:25:28.385] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8979270100964467600:71:0) after 7m53s
[15:33:21.405] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8979270100964467600:71:0)
[15:33:21.480] Build status: SCHEDULED
[15:33:21.480] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8979270100964467600:72:0) after 9m10s
[15:42:31.602] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8979270100964467600:72:0)
[15:42:31.634] Build status: SCHEDULED
[15:42:31.634] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8979270100964467600:73:0) after 6m18s
[15:48:49.684] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8979270100964467600:73:0)
[15:48:49.718] Build status: SCHEDULED
[15:48:49.718] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8979270100964467600:74:0) after 7m3s
[15:55:52.898] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8979270100964467600:74:0)
[15:55:52.923] Build status: SCHEDULED
[15:55:52.923] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8979270100964467600:75:0) after 8m18s
[16:04:11.308] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8979270100964467600:75:0)
[16:04:11.343] Build status: SCHEDULED
[16:04:11.343] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8979270100964467600:76:0) after 6m43s
[16:10:54.361] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8979270100964467600:76:0)
[16:10:54.494] Build status: SCHEDULED
[16:10:54.494] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8979270100964467600:77:0) after 2m12s
[16:13:06.699] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8979270100964467600:77:0)
[16:13:06.726] Build status: SCHEDULED
[16:13:06.726] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8979270100964467600:78:0) after 7m21s
[16:20:27.868] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8979270100964467600:78:0)
[16:20:27.929] Build status: SCHEDULED
[16:20:27.929] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8979270100964467600:79:0) after 9m40s
[16:30:08.130] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8979270100964467600:79:0)
[16:30:08.168] Build status: SCHEDULED
[16:30:08.168] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8979270100964467600:80:0) after 8m33s
[16:38:41.503] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8979270100964467600:80:0)
[16:38:41.535] Build status: SCHEDULED
[16:38:41.535] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8979270100964467600:81:0) after 5m49s
[16:44:30.925] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8979270100964467600:81:0)
[16:44:30.958] Build status: SCHEDULED
[16:44:30.958] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8979270100964467600:82:0) after 5m24s
[16:49:55.133] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8979270100964467600:82:0)
[16:49:55.169] Build status: SCHEDULED
[16:49:55.169] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8979270100964467600:83:0) after 7m37s
[16:57:32.209] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8979270100964467600:83:0)
[16:57:32.273] Build status: SCHEDULED
[16:57:32.273] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8979270100964467600:84:0) after 4m7s
[17:01:39.293] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8979270100964467600:84:0)
[17:01:39.329] Build status: SCHEDULED
[17:01:39.329] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8979270100964467600:85:0) after 1m18s
[17:02:57.856] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8979270100964467600:85:0)
[17:02:57.901] Build status: SCHEDULED
[17:02:57.901] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8979270100964467600:86:0) after 5m10s
[17:08:08.254] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8979270100964467600:86:0)
[17:08:08.284] Build status: SCHEDULED
[17:08:08.284] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8979270100964467600:87:0) after 7m27s
[17:15:35.539] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8979270100964467600:87:0)
[17:15:35.584] Build status: SCHEDULED
[17:15:35.584] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8979270100964467600:88:0) after 5m16s
[17:20:51.789] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8979270100964467600:88:0)
[17:20:51.856] Build status: SCHEDULED
[17:20:51.856] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8979270100964467600:89:0) after 9m3s
[17:29:55.106] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8979270100964467600:89:0)
[17:29:55.140] Build status: SCHEDULED
[17:29:55.140] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8979270100964467600:90:0) after 7m45s
[17:37:40.254] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8979270100964467600:90:0)
[17:37:40.289] Build status: SCHEDULED
[17:37:40.289] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8979270100964467600:91:0) after 4m47s
[17:42:27.474] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8979270100964467600:91:0)
[17:42:27.516] Build status: SCHEDULED
[17:42:27.516] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8979270100964467600:92:0) after 9m24s
[17:51:51.538] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8979270100964467600:92:0)
[17:51:51.566] Build status: SCHEDULED
[17:51:51.566] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8979270100964467600:93:0) after 3m6s
[17:54:58.102] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8979270100964467600:93:0)
[17:54:58.135] Build status: SCHEDULED
[17:54:58.135] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8979270100964467600:94:0) after 3m8s
[17:58:06.216] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8979270100964467600:94:0)
[17:58:06.243] Build status: SCHEDULED
[17:58:06.243] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8979270100964467600:95:0) after 4m38s
[18:02:44.274] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8979270100964467600:95:0)
[18:02:44.318] Build status: SCHEDULED
[18:02:44.318] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8979270100964467600:96:0) after 1m15s
[18:04:00.016] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8979270100964467600:96:0)
[18:04:00.099] Build status: SCHEDULED
[18:04:00.099] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8979270100964467600:97:0) after 1m29s
[18:05:29.211] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8979270100964467600:97:0)
[18:05:29.345] Build status: SCHEDULED
[18:05:29.345] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8979270100964467600:98:0) after 3m44s
[18:09:13.526] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8979270100964467600:98:0)
[18:09:13.568] Build status: SCHEDULED
[18:09:13.568] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8979270100964467600:99:0) after 7m31s
[18:16:44.598] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8979270100964467600:99:0)
[18:16:44.628] Build status: SCHEDULED
[18:16:44.628] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8979270100964467600:100:0) after 5m56s
[18:22:40.906] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8979270100964467600:100:0)
[18:22:40.990] Build status: SCHEDULED
[18:22:40.991] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8979270100964467600:101:0) after 4m53s
[18:27:33.983] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8979270100964467600:101:0)
[18:27:34.017] Build status: SCHEDULED
[18:27:34.017] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8979270100964467600:102:0) after 3m3s
[18:30:37.255] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8979270100964467600:102:0)
[18:30:37.282] Build status: SCHEDULED
[18:30:37.282] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8979270100964467600:103:0) after 5m51s
[18:36:28.374] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8979270100964467600:103:0)
[18:36:28.407] Build status: SCHEDULED
[18:36:28.407] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8979270100964467600:104:0) after 4m18s
[18:40:46.616] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8979270100964467600:104:0)
[18:40:46.647] Build status: SCHEDULED
[18:40:46.647] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8979270100964467600:105:0) after 1m25s
[18:42:11.681] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8979270100964467600:105:0)
[18:42:11.715] Build status: SCHEDULED
[18:42:11.715] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8979270100964467600:106:0) after 5m16s
[18:47:27.724] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8979270100964467600:106:0)
[18:47:27.762] Build status: SCHEDULED
[18:47:27.762] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8979270100964467600:107:0) after 2m59s
[18:50:26.783] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8979270100964467600:107:0)
[18:50:26.869] Build status: SCHEDULED
[18:50:26.869] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8979270100964467600:108:0) after 6m52s
[18:57:18.890] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8979270100964467600:108:0)
[18:57:18.920] Build status: SCHEDULED
[18:57:18.920] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8979270100964467600:109:0) after 7m49s
[19:05:07.942] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8979270100964467600:109:0)
[19:05:07.981] Build status: SCHEDULED
[19:05:07.981] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8979270100964467600:110:0) after 7m30s
[19:12:38.007] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8979270100964467600:110:0)
[19:12:38.053] Build status: SCHEDULED
[19:12:38.053] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8979270100964467600:111:0) after 3m37s
[19:16:15.124] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8979270100964467600:111:0)
[19:16:15.155] Build status: SCHEDULED
[19:16:15.155] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8979270100964467600:112:0) after 6m29s
[19:22:44.184] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8979270100964467600:112:0)
[19:22:44.254] Build status: SCHEDULED
[19:22:44.254] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8979270100964467600:113:0) after 3m21s
[19:26:05.312] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8979270100964467600:113:0)
[19:26:05.357] Build status: SCHEDULED
[19:26:05.357] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8979270100964467600:114:0) after 3m28s
[19:29:33.377] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8979270100964467600:114:0)
[19:29:33.451] Build status: SCHEDULED
[19:29:33.451] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8979270100964467600:115:0) after 3m21s
[19:32:54.520] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8979270100964467600:115:0)
[19:32:54.549] Build status: SCHEDULED
[19:32:54.549] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8979270100964467600:116:0) after 5m10s
[19:38:04.567] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8979270100964467600:116:0)
[19:38:04.600] Build status: SCHEDULED
[19:38:04.600] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8979270100964467600:117:0) after 7m1s
[19:45:05.621] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8979270100964467600:117:0)
[19:45:05.654] Build status: SCHEDULED
[19:45:05.655] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8979270100964467600:118:0) after 8m16s
[19:53:21.680] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8979270100964467600:118:0)
[19:53:21.736] Build status: SCHEDULED
[19:53:21.736] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8979270100964467600:119:0) after 7m58s
[20:01:20.002] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8979270100964467600:119:0)
[20:01:20.041] Build status: SCHEDULED
[20:01:20.041] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8979270100964467600:120:0) after 5m8s
[20:06:28.064] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8979270100964467600:120:0)
[20:06:28.105] Build status: SCHEDULED
[20:06:28.105] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8979270100964467600:121:0) after 6m51s
[20:13:19.267] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8979270100964467600:121:0)
[20:13:19.304] Build status: SCHEDULED
[20:13:19.304] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8979270100964467600:122:0) after 4m19s
[20:17:38.771] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8979270100964467600:122:0)
[20:17:38.807] Build status: SCHEDULED
[20:17:38.807] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8979270100964467600:123:0) after 3m37s
[20:21:15.827] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8979270100964467600:123:0)
[20:21:15.857] Build status: SCHEDULED
[20:21:15.857] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8979270100964467600:124:0) after 9m22s
[20:30:37.987] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8979270100964467600:124:0)
[20:30:38.020] Build status: SCHEDULED
[20:30:38.020] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8979270100964467600:125:0) after 3m57s
[20:34:35.040] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8979270100964467600:125:0)
[20:34:35.069] Build status: SCHEDULED
[20:34:35.069] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8979270100964467600:126:0) after 2m43s
[20:37:18.089] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8979270100964467600:126:0)
[20:37:18.124] Build status: SCHEDULED
[20:37:18.124] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8979270100964467600:127:0) after 9m1s
[20:46:19.120] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8979270100964467600:127:0)
[20:46:19.157] Build status: SCHEDULED
[20:46:19.157] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8979270100964467600:128:0) after 2m27s
[20:48:46.174] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8979270100964467600:128:0)
[20:48:46.209] Build status: SCHEDULED
[20:48:46.209] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8979270100964467600:129:0) after 4m22s
[20:53:08.501] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8979270100964467600:129:0)
[20:53:08.527] Build status: SCHEDULED
[20:53:08.527] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8979270100964467600:130:0) after 3m12s
[20:56:20.548] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8979270100964467600:130:0)
[20:56:20.593] Build status: SCHEDULED
[20:56:20.593] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8979270100964467600:131:0) after 5m1s
[20:57:18.955] Received PubSub notification, asking Buildbucket for the build status
[20:57:18.989] Build status: STARTED
[21:01:21.621] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8979270100964467600:131:0)
[21:01:21.652] Build status: STARTED
[21:01:21.652] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8979270100964467600:133:0) after 2m38s
[21:03:59.646] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8979270100964467600:133:0)
[21:03:59.690] Build status: STARTED
[21:03:59.690] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8979270100964467600:134:0) after 3m9s
[21:07:08.769] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8979270100964467600:134:0)
[21:07:08.801] Build status: STARTED
[21:07:08.801] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8979270100964467600:135:0) after 6m6s
[21:13:14.879] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8979270100964467600:135:0)
[21:13:14.941] Build status: STARTED
[21:13:14.941] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8979270100964467600:136:0) after 9m52s
[21:23:06.968] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8979270100964467600:136:0)
[21:23:07.006] Build status: STARTED
[21:23:07.006] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8979270100964467600:137:0) after 7m35s
[21:30:42.615] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8979270100964467600:137:0)
[21:30:47.975] Build status: STARTED
[21:30:47.975] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8979270100964467600:138:0) after 2m22s
[21:33:09.990] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8979270100964467600:138:0)
[21:33:10.026] Build status: STARTED
[21:33:10.026] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8979270100964467600:139:0) after 8m26s
[21:41:36.051] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8979270100964467600:139:0)
[21:41:36.087] Build status: STARTED
[21:41:36.087] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8979270100964467600:140:0) after 3m10s
[21:44:46.116] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8979270100964467600:140:0)
[21:44:46.165] Build status: STARTED
[21:44:46.165] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8979270100964467600:141:0) after 7m39s
[21:52:25.189] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8979270100964467600:141:0)
[21:52:25.227] Build status: STARTED
[21:52:25.227] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8979270100964467600:142:0) after 5m7s
[21:57:32.250] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8979270100964467600:142:0)
[21:57:32.297] Build status: STARTED
[21:57:32.297] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8979270100964467600:143:0) after 6m13s
[22:03:45.320] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8979270100964467600:143:0)
[22:03:45.358] Build status: STARTED
[22:03:45.358] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8979270100964467600:144:0) after 1m31s
[22:05:16.379] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8979270100964467600:144:0)
[22:05:16.475] Build status: STARTED
[22:05:16.475] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8979270100964467600:145:0) after 9m20s
[22:14:36.546] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8979270100964467600:145:0)
[22:14:36.580] Build status: STARTED
[22:14:36.580] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8979270100964467600:146:0) after 2m30s
[22:17:06.601] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8979270100964467600:146:0)
[22:17:06.640] Build status: STARTED
[22:17:06.640] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8979270100964467600:147:0) after 8m20s
[22:25:26.662] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8979270100964467600:147:0)
[22:25:26.695] Build status: STARTED
[22:25:26.695] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8979270100964467600:148:0) after 5m9s
[22:30:35.706] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8979270100964467600:148:0)
[22:30:35.742] Build status: STARTED
[22:30:35.742] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8979270100964467600:149:0) after 1m23s
[22:31:59.023] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8979270100964467600:149:0)
[22:31:59.054] Build status: STARTED
[22:31:59.054] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8979270100964467600:150:0) after 6m59s
[22:38:58.147] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8979270100964467600:150:0)
[22:38:58.179] Build status: STARTED
[22:38:58.179] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8979270100964467600:151:0) after 6m19s
[22:45:17.512] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8979270100964467600:151:0)
[22:45:17.542] Build status: STARTED
[22:45:17.542] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8979270100964467600:152:0) after 1m3s
[22:46:20.676] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8979270100964467600:152:0)
[22:46:20.722] Build status: STARTED
[22:46:20.722] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8979270100964467600:153:0) after 3m46s
[22:50:06.856] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8979270100964467600:153:0)
[22:50:06.912] Build status: STARTED
[22:50:06.912] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8979270100964467600:154:0) after 6m4s
[22:56:10.896] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8979270100964467600:154:0)
[22:56:10.933] Build status: STARTED
[22:56:10.933] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8979270100964467600:155:0) after 3m43s
[22:59:54.017] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8979270100964467600:155:0)
[22:59:54.052] Build status: STARTED
[22:59:54.052] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8979270100964467600:156:0) after 5m24s
[23:05:18.089] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8979270100964467600:156:0)
[23:05:18.126] Build status: STARTED
[23:05:18.126] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8979270100964467600:157:0) after 5m44s
[23:11:02.153] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8979270100964467600:157:0)
[23:11:02.186] Build status: STARTED
[23:11:02.186] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8979270100964467600:158:0) after 5m48s
[23:16:50.544] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8979270100964467600:158:0)
[23:16:50.575] Build status: STARTED
[23:16:50.575] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8979270100964467600:159:0) after 4m45s
[23:21:35.707] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8979270100964467600:159:0)
[23:21:35.742] Build status: STARTED
[23:21:35.742] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8979270100964467600:160:0) after 1m13s
[23:22:48.792] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8979270100964467600:160:0)
[23:22:48.821] Build status: STARTED
[23:22:48.821] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8979270100964467600:161:0) after 1m52s
[23:24:40.877] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8979270100964467600:161:0)
[23:24:40.965] Build status: STARTED
[23:24:40.965] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8979270100964467600:162:0) after 5m50s
[23:30:30.988] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8979270100964467600:162:0)
[23:30:31.035] Build status: STARTED
[23:30:31.035] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8979270100964467600:163:0) after 4m37s
[23:35:08.292] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8979270100964467600:163:0)
[23:35:08.323] Build status: STARTED
[23:35:08.323] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8979270100964467600:164:0) after 3m38s
[23:38:46.443] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8979270100964467600:164:0)
[23:38:46.479] Build status: STARTED
[23:38:46.479] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8979270100964467600:165:0) after 4m19s
[23:43:05.597] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8979270100964467600:165:0)
[23:43:05.628] Build status: STARTED
[23:43:05.628] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8979270100964467600:166:0) after 1m56s
[23:45:01.771] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8979270100964467600:166:0)
[23:45:01.810] Build status: STARTED
[23:45:01.810] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8979270100964467600:167:0) after 5m29s
[23:50:30.906] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8979270100964467600:167:0)
[23:50:30.927] Build status: STARTED
[23:50:30.927] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8979270100964467600:168:0) after 3m54s
[23:54:24.993] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8979270100964467600:168:0)
[23:54:25.049] Build status: STARTED
[23:54:25.049] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8979270100964467600:169:0) after 2m11s
[23:56:36.180] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8979270100964467600:169:0)
[23:56:36.215] Build status: STARTED
[23:56:36.215] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8979270100964467600:170:0) after 8m30s
[00:05:06.479] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8979270100964467600:170:0)
[00:05:06.564] Build status: STARTED
[00:05:06.564] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8979270100964467600:171:0) after 1m9s
[00:06:15.760] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8979270100964467600:171:0)
[00:06:15.792] Build status: STARTED
[00:06:15.792] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8979270100964467600:172:0) after 3m45s
[00:10:01.170] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8979270100964467600:172:0)
[00:10:01.207] Build status: STARTED
[00:10:01.207] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8979270100964467600:173:0) after 4m4s
[00:14:05.230] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8979270100964467600:173:0)
[00:14:05.267] Build status: STARTED
[00:14:05.267] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8979270100964467600:174:0) after 5m42s
[00:19:47.316] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8979270100964467600:174:0)
[00:19:47.349] Build status: STARTED
[00:19:47.349] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8979270100964467600:175:0) after 5m32s
[00:25:19.377] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8979270100964467600:175:0)
[00:25:19.419] Build status: STARTED
[00:25:19.419] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8979270100964467600:176:0) after 5m17s
[00:30:36.612] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8979270100964467600:176:0)
[00:30:36.664] Build status: STARTED
[00:30:36.664] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8979270100964467600:177:0) after 4m33s
[00:35:10.104] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8979270100964467600:177:0)
[00:35:10.142] Build status: STARTED
[00:35:10.142] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8979270100964467600:178:0) after 2m1s
[00:37:11.156] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8979270100964467600:178:0)
[00:37:11.200] Build status: STARTED
[00:37:11.201] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8979270100964467600:179:0) after 6m22s
[00:43:33.225] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8979270100964467600:179:0)
[00:43:33.261] Build status: STARTED
[00:43:33.261] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8979270100964467600:180:0) after 5m58s
[00:49:31.317] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8979270100964467600:180:0)
[00:49:31.350] Build status: STARTED
[00:49:31.350] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8979270100964467600:181:0) after 9m41s
[00:59:12.401] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8979270100964467600:181:0)
[00:59:12.434] Build status: STARTED
[00:59:12.434] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8979270100964467600:182:0) after 1m21s
[01:00:33.459] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8979270100964467600:182:0)
[01:00:33.498] Build status: STARTED
[01:00:33.498] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8979270100964467600:183:0) after 9m35s
[01:10:08.568] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8979270100964467600:183:0)
[01:10:08.626] Build status: STARTED
[01:10:08.626] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8979270100964467600:184:0) after 3m53s
[01:14:01.740] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8979270100964467600:184:0)
[01:14:01.776] Build status: STARTED
[01:14:01.776] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8979270100964467600:185:0) after 3m9s
[01:17:10.798] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8979270100964467600:185:0)
[01:17:10.829] Build status: STARTED
[01:17:10.829] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8979270100964467600:186:0) after 1m14s
[01:18:24.851] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8979270100964467600:186:0)
[01:18:24.885] Build status: STARTED
[01:18:24.885] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8979270100964467600:187:0) after 2m36s
[01:21:01.009] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8979270100964467600:187:0)
[01:21:01.045] Build status: STARTED
[01:21:01.045] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8979270100964467600:188:0) after 5m0s
[01:26:01.165] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8979270100964467600:188:0)
[01:26:01.242] Build status: STARTED
[01:26:01.242] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8979270100964467600:189:0) after 5m3s
[01:31:04.266] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8979270100964467600:189:0)
[01:31:04.368] Build status: STARTED
[01:31:04.368] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8979270100964467600:190:0) after 1m17s
[01:32:21.438] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8979270100964467600:190:0)
[01:32:21.477] Build status: STARTED
[01:32:21.477] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8979270100964467600:191:0) after 2m5s
[01:34:26.620] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8979270100964467600:191:0)
[01:34:26.664] Build status: STARTED
[01:34:26.664] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8979270100964467600:192:0) after 7m14s
[01:35:28.295] Received PubSub notification, asking Buildbucket for the build status
[01:35:28.329] Build:
{
  "id": "8813840037899888593",
  "builder": {
    "project": "r8",
    "bucket": "ci",
    "builder": "linux-internal"
  },
  "number": 2554,
  "createdBy": "project:r8",
  "createTime": "2022-05-18T08:55:49.149776630Z",
  "startTime": "2022-05-18T20:57:15.828550Z",
  "endTime": "2022-05-19T01:35:26.797079813Z",
  "updateTime": "2022-05-19T01:35:26.797079813Z",
  "status": "SUCCESS",
  "input": {
    "gitilesCommit": {
      "host": "r8.googlesource.com",
      "project": "r8",
      "id": "40879634ddf28768bb73babf6e0c539da652ae09",
      "ref": "refs/heads/main"
    }
  }
}
[01:35:28.329] Invocation finished in 16h39m41.48658658s with status SUCCEEDED