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

Definition (rev f340a0e7fd42f658022a052c8e96c9e3492df823)

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

Incoming triggers

Incoming properties

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

Incoming tags

  • buildset:commit/gitiles/r8.googlesource.com/r8/+/af37f19dbbf756076d1f6c817a55a859ba7dfd9a
  • gitiles_ref:refs/heads/main

Debug log (UTC)

[13:28:44.389] New invocation is queued and will start shortly
[13:28:45.450] Starting the invocation (attempt 1)
[13:28:45.486] Popped buildset tag "buildset:commit/gitiles/r8.googlesource.com/r8/+/af37f19dbbf756076d1f6c817a55a859ba7dfd9a"
[13:28:45.486] Popped gitiles commit info from properties and tags
[13:28:45.486] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[13:28:45.486] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[13:28:45.486] Buildbucket request:
{
  "requestId": "8991121130477299280",
  "builder": {
    "project": "r8",
    "bucket": "ci",
    "builder": "linux-internal"
  },
  "properties": {
      "$recipe_engine/scheduler": {
            "hostname": "luci-scheduler.appspot.com",
            "triggers": [
                  {
                        "gitiles": {
                              "ref": "refs/heads/main",
                              "repo": "https://r8.googlesource.com/r8",
                              "revision": "84cf8f5f3accc0243cd1e4bcf4293d8e62617e47"
                            },
                        "id": "https://r8.googlesource.com/r8/+/refs/heads/main@84cf8f5f3accc0243cd1e4bcf4293d8e62617e47",
                        "title": "84cf8f5f3accc0243cd1e4bcf4293d8e62617e47",
                        "url": "https://r8.googlesource.com/r8/+/84cf8f5f3accc0243cd1e4bcf4293d8e62617e47"
                      },
                  {
                        "gitiles": {
                              "ref": "refs/heads/main",
                              "repo": "https://r8.googlesource.com/r8",
                              "revision": "3e0a120cf508a856c117d8784cd6477340071181"
                            },
                        "id": "https://r8.googlesource.com/r8/+/refs/heads/main@3e0a120cf508a856c117d8784cd6477340071181",
                        "title": "3e0a120cf508a856c117d8784cd6477340071181",
                        "url": "https://r8.googlesource.com/r8/+/3e0a120cf508a856c117d8784cd6477340071181"
                      },
                  {
                        "gitiles": {
                              "ref": "refs/heads/main",
                              "repo": "https://r8.googlesource.com/r8",
                              "revision": "9da1cb3ab71053b8a77f68d10b1c74739a1a2c11"
                            },
                        "id": "https://r8.googlesource.com/r8/+/refs/heads/main@9da1cb3ab71053b8a77f68d10b1c74739a1a2c11",
                        "title": "9da1cb3ab71053b8a77f68d10b1c74739a1a2c11",
                        "url": "https://r8.googlesource.com/r8/+/9da1cb3ab71053b8a77f68d10b1c74739a1a2c11"
                      },
                  {
                        "gitiles": {
                              "ref": "refs/heads/main",
                              "repo": "https://r8.googlesource.com/r8",
                              "revision": "af37f19dbbf756076d1f6c817a55a859ba7dfd9a"
                            },
                        "id": "https://r8.googlesource.com/r8/+/refs/heads/main@af37f19dbbf756076d1f6c817a55a859ba7dfd9a",
                        "title": "af37f19dbbf756076d1f6c817a55a859ba7dfd9a",
                        "url": "https://r8.googlesource.com/r8/+/af37f19dbbf756076d1f6c817a55a859ba7dfd9a"
                      }
                ]
          }
    },
  "gitilesCommit": {
    "host": "r8.googlesource.com",
    "project": "r8",
    "id": "af37f19dbbf756076d1f6c817a55a859ba7dfd9a",
    "ref": "refs/heads/main"
  },
  "tags": [
    {
      "key": "scheduler_invocation_id",
      "value": "8991121130477299280"
    },
    {
      "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"
  }
}
[13:28:45.974] Scheduled build:
{
  "id": "8825691068551904769",
  "builder": {
    "project": "r8",
    "bucket": "ci",
    "builder": "linux-internal"
  },
  "number": 2282,
  "createdBy": "project:r8",
  "createTime": "2022-01-07T13:28:45.594836088Z",
  "updateTime": "2022-01-07T13:28:45.594836088Z",
  "status": "SCHEDULED",
  "input": {
    "gitilesCommit": {
      "host": "r8.googlesource.com",
      "project": "r8",
      "id": "af37f19dbbf756076d1f6c817a55a859ba7dfd9a",
      "ref": "refs/heads/main"
    }
  }
}
[13:28:45.974] Task URL: https://cr-buildbucket.appspot.com/build/8825691068551904769
[13:28:45.974] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8991121130477299280:2:0) after 5m37s
[13:34:23.071] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8991121130477299280:2:0)
[13:34:23.108] Build status: SCHEDULED
[13:34:23.108] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8991121130477299280:3:0) after 9m59s
[13:44:22.149] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8991121130477299280:3:0)
[13:44:22.183] Build status: SCHEDULED
[13:44:22.183] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8991121130477299280:4:0) after 6m12s
[13:50:34.207] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8991121130477299280:4:0)
[13:50:34.234] Build status: SCHEDULED
[13:50:34.234] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8991121130477299280:5:0) after 5m37s
[13:56:11.266] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8991121130477299280:5:0)
[13:56:11.385] Build status: SCHEDULED
[13:56:11.385] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8991121130477299280:6:0) after 2m25s
[13:58:36.367] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8991121130477299280:6:0)
[13:58:36.396] Build status: SCHEDULED
[13:58:36.396] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8991121130477299280:7:0) after 7m0s
[14:05:36.413] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8991121130477299280:7:0)
[14:05:36.437] Build status: SCHEDULED
[14:05:36.437] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8991121130477299280:8:0) after 3m35s
[14:09:11.550] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8991121130477299280:8:0)
[14:09:11.595] Build status: SCHEDULED
[14:09:11.595] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8991121130477299280:9:0) after 2m4s
[14:11:15.754] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8991121130477299280:9:0)
[14:11:15.868] Build status: SCHEDULED
[14:11:15.868] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8991121130477299280:10:0) after 1m56s
[14:13:11.974] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8991121130477299280:10:0)
[14:13:12.010] Build status: SCHEDULED
[14:13:12.010] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8991121130477299280:11:0) after 9m40s
[14:22:52.188] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8991121130477299280:11:0)
[14:22:52.383] Build status: SCHEDULED
[14:22:52.383] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8991121130477299280:12:0) after 6m3s
[14:28:55.507] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8991121130477299280:12:0)
[14:28:55.533] Build status: SCHEDULED
[14:28:55.533] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8991121130477299280:13:0) after 9m54s
[14:38:49.554] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8991121130477299280:13:0)
[14:38:49.581] Build status: SCHEDULED
[14:38:49.581] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8991121130477299280:14:0) after 9m39s
[14:48:28.776] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8991121130477299280:14:0)
[14:48:28.816] Build status: SCHEDULED
[14:48:28.816] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8991121130477299280:15:0) after 1m47s
[14:50:15.923] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8991121130477299280:15:0)
[14:50:15.968] Build status: SCHEDULED
[14:50:15.968] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8991121130477299280:16:0) after 2m12s
[14:52:28.089] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8991121130477299280:16:0)
[14:52:28.122] Build status: SCHEDULED
[14:52:28.122] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8991121130477299280:17:0) after 5m33s
[14:58:01.159] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8991121130477299280:17:0)
[14:58:01.187] Build status: SCHEDULED
[14:58:01.187] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8991121130477299280:18:0) after 8m8s
[15:06:09.242] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8991121130477299280:18:0)
[15:06:09.280] Build status: SCHEDULED
[15:06:09.280] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8991121130477299280:19:0) after 9m3s
[15:15:12.604] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8991121130477299280:19:0)
[15:15:12.635] Build status: SCHEDULED
[15:15:12.635] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8991121130477299280:20:0) after 5m43s
[15:20:55.632] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8991121130477299280:20:0)
[15:20:55.664] Build status: SCHEDULED
[15:20:55.664] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8991121130477299280:21:0) after 6m21s
[15:27:16.810] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8991121130477299280:21:0)
[15:27:16.858] Build status: SCHEDULED
[15:27:16.858] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8991121130477299280:22:0) after 8m42s
[15:35:58.973] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8991121130477299280:22:0)
[15:35:59.061] Build status: SCHEDULED
[15:35:59.061] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8991121130477299280:23:0) after 7m24s
[15:43:23.074] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8991121130477299280:23:0)
[15:43:23.103] Build status: SCHEDULED
[15:43:23.103] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8991121130477299280:24:0) after 8m54s
[15:52:17.123] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8991121130477299280:24:0)
[15:52:17.169] Build status: SCHEDULED
[15:52:17.169] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8991121130477299280:25:0) after 5m58s
[15:58:15.384] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8991121130477299280:25:0)
[15:58:15.414] Build status: SCHEDULED
[15:58:15.414] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8991121130477299280:26:0) after 5m43s
[16:03:58.737] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8991121130477299280:26:0)
[16:03:58.780] Build status: SCHEDULED
[16:03:58.780] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8991121130477299280:27:0) after 7m53s
[16:11:51.885] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8991121130477299280:27:0)
[16:11:51.917] Build status: SCHEDULED
[16:11:51.917] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8991121130477299280:28:0) after 1m3s
[16:12:54.930] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8991121130477299280:28:0)
[16:12:54.970] Build status: SCHEDULED
[16:12:54.970] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8991121130477299280:29:0) after 5m28s
[16:18:23.000] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8991121130477299280:29:0)
[16:18:23.039] Build status: SCHEDULED
[16:18:23.039] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8991121130477299280:30:0) after 9m43s
[16:28:06.281] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8991121130477299280:30:0)
[16:28:06.328] Build status: SCHEDULED
[16:28:06.328] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8991121130477299280:31:0) after 3m37s
[16:31:43.358] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8991121130477299280:31:0)
[16:31:43.386] Build status: SCHEDULED
[16:31:43.386] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8991121130477299280:32:0) after 4m21s
[16:36:04.488] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8991121130477299280:32:0)
[16:36:04.583] Build status: SCHEDULED
[16:36:04.583] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8991121130477299280:33:0) after 4m4s
[16:40:08.728] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8991121130477299280:33:0)
[16:40:08.844] Build status: SCHEDULED
[16:40:08.844] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8991121130477299280:34:0) after 4m44s
[16:44:53.036] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8991121130477299280:34:0)
[16:44:53.064] Build status: SCHEDULED
[16:44:53.064] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8991121130477299280:35:0) after 9m48s
[16:54:41.317] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8991121130477299280:35:0)
[16:54:41.351] Build status: SCHEDULED
[16:54:41.351] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8991121130477299280:36:0) after 9m37s
[17:04:18.570] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8991121130477299280:36:0)
[17:04:18.602] Build status: SCHEDULED
[17:04:18.602] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8991121130477299280:37:0) after 5m1s
[17:09:19.893] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8991121130477299280:37:0)
[17:09:19.923] Build status: SCHEDULED
[17:09:19.923] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8991121130477299280:38:0) after 7m46s
[17:17:05.989] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8991121130477299280:38:0)
[17:17:06.024] Build status: SCHEDULED
[17:17:06.024] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8991121130477299280:39:0) after 5m11s
[17:22:17.049] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8991121130477299280:39:0)
[17:22:17.149] Build status: SCHEDULED
[17:22:17.149] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8991121130477299280:40:0) after 1m13s
[17:23:30.169] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8991121130477299280:40:0)
[17:23:30.202] Build status: SCHEDULED
[17:23:30.202] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8991121130477299280:41:0) after 5m33s
[17:29:03.230] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8991121130477299280:41:0)
[17:29:03.277] Build status: SCHEDULED
[17:29:03.277] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8991121130477299280:42:0) after 9m36s
[17:38:39.593] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8991121130477299280:42:0)
[17:38:39.624] Build status: SCHEDULED
[17:38:39.624] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8991121130477299280:43:0) after 3m57s
[17:42:36.754] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8991121130477299280:43:0)
[17:42:36.792] Build status: SCHEDULED
[17:42:36.792] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8991121130477299280:44:0) after 3m48s
[17:46:24.851] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8991121130477299280:44:0)
[17:46:24.883] Build status: SCHEDULED
[17:46:24.884] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8991121130477299280:45:0) after 2m53s
[17:49:17.905] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8991121130477299280:45:0)
[17:49:17.961] Build status: SCHEDULED
[17:49:17.961] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8991121130477299280:46:0) after 2m55s
[17:52:13.048] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8991121130477299280:46:0)
[17:52:13.172] Build status: SCHEDULED
[17:52:13.172] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8991121130477299280:47:0) after 8m8s
[18:00:21.169] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8991121130477299280:47:0)
[18:00:21.215] Build status: SCHEDULED
[18:00:21.215] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8991121130477299280:48:0) after 2m20s
[18:02:41.257] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8991121130477299280:48:0)
[18:02:41.755] Build status: SCHEDULED
[18:02:41.755] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8991121130477299280:49:0) after 2m14s
[18:04:57.018] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8991121130477299280:49:0)
[18:04:57.272] Build status: SCHEDULED
[18:04:57.272] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8991121130477299280:50:0) after 9m57s
[18:14:54.708] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8991121130477299280:50:0)
[18:14:54.739] Build status: SCHEDULED
[18:14:54.739] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8991121130477299280:51:0) after 7m21s
[18:22:15.991] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8991121130477299280:51:0)
[18:22:16.032] Build status: SCHEDULED
[18:22:16.032] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8991121130477299280:52:0) after 9m4s
[18:31:20.057] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8991121130477299280:52:0)
[18:31:20.084] Build status: SCHEDULED
[18:31:20.084] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8991121130477299280:53:0) after 4m42s
[18:36:02.844] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8991121130477299280:53:0)
[18:36:02.875] Build status: SCHEDULED
[18:36:02.875] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8991121130477299280:54:0) after 4m38s
[18:40:40.910] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8991121130477299280:54:0)
[18:40:40.942] Build status: SCHEDULED
[18:40:40.942] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8991121130477299280:55:0) after 4m39s
[18:45:19.922] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8991121130477299280:55:0)
[18:45:19.952] Build status: SCHEDULED
[18:45:19.952] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8991121130477299280:56:0) after 1m28s
[18:46:47.965] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8991121130477299280:56:0)
[18:46:47.984] Build status: SCHEDULED
[18:46:47.984] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8991121130477299280:57:0) after 3m4s
[18:49:52.009] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8991121130477299280:57:0)
[18:49:52.188] Build status: SCHEDULED
[18:49:52.188] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8991121130477299280:58:0) after 1m1s
[18:50:17.781] Received PubSub notification, asking Buildbucket for the build status
[18:50:17.818] Build status: STARTED
[18:50:53.157] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8991121130477299280:58:0)
[18:50:53.179] Build status: STARTED
[18:50:53.179] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8991121130477299280:60:0) after 7m54s
[18:58:47.248] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8991121130477299280:60:0)
[18:58:47.274] Build status: STARTED
[18:58:47.274] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8991121130477299280:61:0) after 7m57s
[19:06:44.252] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8991121130477299280:61:0)
[19:06:44.282] Build status: STARTED
[19:06:44.282] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8991121130477299280:62:0) after 2m35s
[19:09:19.306] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8991121130477299280:62:0)
[19:09:19.325] Build status: STARTED
[19:09:19.325] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8991121130477299280:63:0) after 9m34s
[19:18:53.408] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8991121130477299280:63:0)
[19:18:53.440] Build status: STARTED
[19:18:53.440] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8991121130477299280:64:0) after 3m4s
[19:21:57.560] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8991121130477299280:64:0)
[19:21:57.591] Build status: STARTED
[19:21:57.591] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8991121130477299280:65:0) after 7m45s
[19:29:43.061] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8991121130477299280:65:0)
[19:29:43.110] Build status: STARTED
[19:29:43.110] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8991121130477299280:66:0) after 1m24s
[19:31:07.301] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8991121130477299280:66:0)
[19:31:07.334] Build status: STARTED
[19:31:07.334] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8991121130477299280:67:0) after 3m7s
[19:34:14.408] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8991121130477299280:67:0)
[19:34:14.438] Build status: STARTED
[19:34:14.439] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8991121130477299280:68:0) after 9m5s
[19:43:19.752] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8991121130477299280:68:0)
[19:43:19.784] Build status: STARTED
[19:43:19.784] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8991121130477299280:69:0) after 4m32s
[19:47:51.806] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8991121130477299280:69:0)
[19:47:51.836] Build status: STARTED
[19:47:51.836] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8991121130477299280:70:0) after 4m14s
[19:52:05.855] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8991121130477299280:70:0)
[19:52:05.929] Build status: STARTED
[19:52:05.929] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8991121130477299280:71:0) after 6m3s
[19:58:09.028] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8991121130477299280:71:0)
[19:58:09.055] Build status: STARTED
[19:58:09.055] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8991121130477299280:72:0) after 4m4s
[20:02:13.408] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8991121130477299280:72:0)
[20:02:13.439] Build status: STARTED
[20:02:13.439] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8991121130477299280:73:0) after 6m52s
[20:09:05.711] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8991121130477299280:73:0)
[20:09:05.767] Build status: STARTED
[20:09:05.767] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8991121130477299280:74:0) after 8m52s
[20:17:58.050] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8991121130477299280:74:0)
[20:17:58.079] Build status: STARTED
[20:17:58.079] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8991121130477299280:75:0) after 4m4s
[20:22:02.101] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8991121130477299280:75:0)
[20:22:02.148] Build status: STARTED
[20:22:02.148] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8991121130477299280:76:0) after 2m52s
[20:24:54.621] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8991121130477299280:76:0)
[20:24:54.665] Build status: STARTED
[20:24:54.665] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8991121130477299280:77:0) after 5m49s
[20:30:43.888] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8991121130477299280:77:0)
[20:30:43.925] Build status: STARTED
[20:30:43.925] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8991121130477299280:78:0) after 8m47s
[20:39:31.638] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8991121130477299280:78:0)
[20:39:31.723] Build status: STARTED
[20:39:31.723] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8991121130477299280:79:0) after 1m52s
[20:41:23.743] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8991121130477299280:79:0)
[20:41:23.776] Build status: STARTED
[20:41:23.776] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8991121130477299280:80:0) after 1m23s
[20:42:46.845] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8991121130477299280:80:0)
[20:42:46.875] Build status: STARTED
[20:42:46.875] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8991121130477299280:81:0) after 4m18s
[20:47:05.079] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8991121130477299280:81:0)
[20:47:05.129] Build status: STARTED
[20:47:05.129] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8991121130477299280:82:0) after 5m57s
[20:53:02.199] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8991121130477299280:82:0)
[20:53:02.230] Build status: STARTED
[20:53:02.230] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8991121130477299280:83:0) after 5m58s
[20:59:00.488] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8991121130477299280:83:0)
[20:59:00.538] Build status: STARTED
[20:59:00.538] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8991121130477299280:84:0) after 2m31s
[21:01:32.106] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8991121130477299280:84:0)
[21:01:32.141] Build status: STARTED
[21:01:32.141] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8991121130477299280:85:0) after 7m50s
[21:09:22.248] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8991121130477299280:85:0)
[21:09:22.292] Build status: STARTED
[21:09:22.292] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8991121130477299280:86:0) after 2m48s
[21:12:10.513] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8991121130477299280:86:0)
[21:12:10.541] Build status: STARTED
[21:12:10.541] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8991121130477299280:87:0) after 4m42s
[21:16:52.904] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8991121130477299280:87:0)
[21:16:52.958] Build status: STARTED
[21:16:52.958] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8991121130477299280:88:0) after 6m10s
[21:23:03.012] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8991121130477299280:88:0)
[21:23:03.049] Build status: STARTED
[21:23:03.049] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8991121130477299280:89:0) after 9m3s
[21:32:06.077] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8991121130477299280:89:0)
[21:32:06.132] Build status: STARTED
[21:32:06.132] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8991121130477299280:90:0) after 3m26s
[21:35:32.202] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8991121130477299280:90:0)
[21:35:32.232] Build status: STARTED
[21:35:32.232] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8991121130477299280:91:0) after 1m34s
[21:37:06.252] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8991121130477299280:91:0)
[21:37:06.288] Build status: STARTED
[21:37:06.288] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8991121130477299280:92:0) after 9m34s
[21:46:40.665] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8991121130477299280:92:0)
[21:46:40.688] Build status: STARTED
[21:46:40.689] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8991121130477299280:93:0) after 4m15s
[21:50:56.185] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8991121130477299280:93:0)
[21:50:56.232] Build status: STARTED
[21:50:56.232] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8991121130477299280:94:0) after 5m37s
[21:56:33.373] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8991121130477299280:94:0)
[21:56:33.407] Build status: STARTED
[21:56:33.407] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8991121130477299280:95:0) after 4m14s
[22:00:47.731] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8991121130477299280:95:0)
[22:00:47.777] Build status: STARTED
[22:00:47.777] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8991121130477299280:96:0) after 9m5s
[22:09:52.817] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8991121130477299280:96:0)
[22:09:52.858] Build status: STARTED
[22:09:52.858] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8991121130477299280:97:0) after 9m38s
[22:19:30.991] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8991121130477299280:97:0)
[22:19:31.042] Build status: STARTED
[22:19:31.042] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8991121130477299280:98:0) after 5m46s
[22:25:17.490] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8991121130477299280:98:0)
[22:25:17.523] Build status: STARTED
[22:25:17.523] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8991121130477299280:99:0) after 1m34s
[22:26:51.545] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8991121130477299280:99:0)
[22:26:51.574] Build status: STARTED
[22:26:51.574] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8991121130477299280:100:0) after 4m12s
[22:31:03.596] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8991121130477299280:100:0)
[22:31:03.625] Build status: STARTED
[22:31:03.625] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8991121130477299280:101:0) after 5m6s
[22:36:09.646] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8991121130477299280:101:0)
[22:36:09.746] Build status: STARTED
[22:36:09.746] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8991121130477299280:102:0) after 7m8s
[22:43:18.134] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8991121130477299280:102:0)
[22:43:18.168] Build status: STARTED
[22:43:18.168] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8991121130477299280:103:0) after 3m17s
[22:46:35.423] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8991121130477299280:103:0)
[22:46:35.454] Build status: STARTED
[22:46:35.454] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8991121130477299280:104:0) after 6m8s
[22:52:43.896] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8991121130477299280:104:0)
[22:52:43.938] Build status: STARTED
[22:52:43.938] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8991121130477299280:105:0) after 1m52s
[22:54:35.960] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8991121130477299280:105:0)
[22:54:35.996] Build status: STARTED
[22:54:35.996] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8991121130477299280:106:0) after 1m7s
[22:55:42.977] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8991121130477299280:106:0)
[22:55:43.017] Build status: STARTED
[22:55:43.017] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8991121130477299280:107:0) after 2m47s
[22:58:30.099] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8991121130477299280:107:0)
[22:58:30.128] Build status: STARTED
[22:58:30.128] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8991121130477299280:108:0) after 5m21s
[23:03:51.148] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8991121130477299280:108:0)
[23:03:51.178] Build status: STARTED
[23:03:51.178] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8991121130477299280:109:0) after 6m52s
[23:10:43.330] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8991121130477299280:109:0)
[23:10:43.371] Build status: STARTED
[23:10:43.371] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8991121130477299280:110:0) after 3m54s
[23:14:37.390] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8991121130477299280:110:0)
[23:14:37.508] Build status: STARTED
[23:14:37.508] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8991121130477299280:111:0) after 9m48s
[23:24:25.536] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8991121130477299280:111:0)
[23:24:25.573] Build status: STARTED
[23:24:25.573] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8991121130477299280:112:0) after 7m28s
[23:31:53.698] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8991121130477299280:112:0)
[23:31:53.727] Build status: STARTED
[23:31:53.728] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8991121130477299280:113:0) after 8m28s
[23:40:21.835] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8991121130477299280:113:0)
[23:40:21.864] Build status: STARTED
[23:40:21.864] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8991121130477299280:114:0) after 2m26s
[23:42:47.980] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8991121130477299280:114:0)
[23:42:48.274] Build status: STARTED
[23:42:48.275] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8991121130477299280:115:0) after 6m7s
[23:48:55.296] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8991121130477299280:115:0)
[23:48:55.407] Build status: STARTED
[23:48:55.407] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8991121130477299280:116:0) after 2m26s
[23:51:21.410] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8991121130477299280:116:0)
[23:51:21.446] Build status: STARTED
[23:51:21.446] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8991121130477299280:117:0) after 6m21s
[23:57:42.718] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8991121130477299280:117:0)
[23:57:42.747] Build status: STARTED
[23:57:42.747] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8991121130477299280:118:0) after 6m0s
[00:03:42.771] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8991121130477299280:118:0)
[00:03:42.791] Build status: STARTED
[00:03:42.791] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8991121130477299280:119:0) after 3m31s
[00:07:13.970] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8991121130477299280:119:0)
[00:07:13.999] Build status: STARTED
[00:07:13.999] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8991121130477299280:120:0) after 1m11s
[00:08:25.023] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8991121130477299280:120:0)
[00:08:25.061] Build status: STARTED
[00:08:25.061] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8991121130477299280:121:0) after 4m48s
[00:13:13.055] Handling timer "check-buildbucket-build-status" (r8/linux-internal:8991121130477299280:121:0)
[00:13:13.153] Build status: STARTED
[00:13:13.153] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:8991121130477299280:122:0) after 5m31s
[00:16:34.770] Received PubSub notification, asking Buildbucket for the build status
[00:16:34.806] Build:
{
  "id": "8825691068551904769",
  "builder": {
    "project": "r8",
    "bucket": "ci",
    "builder": "linux-internal"
  },
  "number": 2282,
  "createdBy": "project:r8",
  "createTime": "2022-01-07T13:28:45.594836088Z",
  "startTime": "2022-01-07T18:50:16.843495Z",
  "endTime": "2022-01-08T00:16:34.249609295Z",
  "updateTime": "2022-01-08T00:16:34.249609295Z",
  "status": "SUCCESS",
  "input": {
    "gitilesCommit": {
      "host": "r8.googlesource.com",
      "project": "r8",
      "id": "af37f19dbbf756076d1f6c817a55a859ba7dfd9a",
      "ref": "refs/heads/main"
    }
  }
}
[00:16:34.806] Invocation finished in 10h47m50.432112384s with status SUCCEEDED