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

Definition (rev 5ef313b610068c2546b37fe9e5221e7f42819a45)

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": "744d742137a82656b8ee27513f975e0528aecd78"
}

Incoming tags

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

Debug log (UTC)

[22:17:31.217] New invocation is queued and will start shortly
[22:17:32.335] Starting the invocation (attempt 1)
[22:17:32.384] Popped buildset tag "buildset:commit/gitiles/r8.googlesource.com/r8/+/744d742137a82656b8ee27513f975e0528aecd78"
[22:17:32.384] Popped gitiles commit info from properties and tags
[22:17:32.384] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[22:17:32.385] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[22:17:32.385] Buildbucket request:
{
  "requestId": "9013646507123502384",
  "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": "3e6cd93a181b50323ae9e2509d37e4e9854ae8a3"
                            },
                        "id": "https://r8.googlesource.com/r8/+/refs/heads/main@3e6cd93a181b50323ae9e2509d37e4e9854ae8a3",
                        "title": "3e6cd93a181b50323ae9e2509d37e4e9854ae8a3",
                        "url": "https://r8.googlesource.com/r8/+/3e6cd93a181b50323ae9e2509d37e4e9854ae8a3"
                      },
                  {
                        "gitiles": {
                              "ref": "refs/heads/main",
                              "repo": "https://r8.googlesource.com/r8",
                              "revision": "81a779bbeb64001a8813a6047b69dacca608f5f5"
                            },
                        "id": "https://r8.googlesource.com/r8/+/refs/heads/main@81a779bbeb64001a8813a6047b69dacca608f5f5",
                        "title": "81a779bbeb64001a8813a6047b69dacca608f5f5",
                        "url": "https://r8.googlesource.com/r8/+/81a779bbeb64001a8813a6047b69dacca608f5f5"
                      },
                  {
                        "gitiles": {
                              "ref": "refs/heads/main",
                              "repo": "https://r8.googlesource.com/r8",
                              "revision": "942c53dfb6064bcd7acdba1bd7cf6fd5522370dc"
                            },
                        "id": "https://r8.googlesource.com/r8/+/refs/heads/main@942c53dfb6064bcd7acdba1bd7cf6fd5522370dc",
                        "title": "942c53dfb6064bcd7acdba1bd7cf6fd5522370dc",
                        "url": "https://r8.googlesource.com/r8/+/942c53dfb6064bcd7acdba1bd7cf6fd5522370dc"
                      },
                  {
                        "gitiles": {
                              "ref": "refs/heads/main",
                              "repo": "https://r8.googlesource.com/r8",
                              "revision": "58fb3499f1cf0bfb89d0465ed860c92ff6853c57"
                            },
                        "id": "https://r8.googlesource.com/r8/+/refs/heads/main@58fb3499f1cf0bfb89d0465ed860c92ff6853c57",
                        "title": "58fb3499f1cf0bfb89d0465ed860c92ff6853c57",
                        "url": "https://r8.googlesource.com/r8/+/58fb3499f1cf0bfb89d0465ed860c92ff6853c57"
                      },
                  {
                        "gitiles": {
                              "ref": "refs/heads/main",
                              "repo": "https://r8.googlesource.com/r8",
                              "revision": "744d742137a82656b8ee27513f975e0528aecd78"
                            },
                        "id": "https://r8.googlesource.com/r8/+/refs/heads/main@744d742137a82656b8ee27513f975e0528aecd78",
                        "title": "744d742137a82656b8ee27513f975e0528aecd78",
                        "url": "https://r8.googlesource.com/r8/+/744d742137a82656b8ee27513f975e0528aecd78"
                      }
                ]
          }
    },
  "gitilesCommit": {
    "host": "r8.googlesource.com",
    "project": "r8",
    "id": "744d742137a82656b8ee27513f975e0528aecd78",
    "ref": "refs/heads/main"
  },
  "tags": [
    {
      "key": "scheduler_invocation_id",
      "value": "9013646507123502384"
    },
    {
      "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"
  }
}
[22:17:33.079] Scheduled build:
{
  "id": "8848216445124598000",
  "builder": {
    "project": "r8",
    "bucket": "ci",
    "builder": "linux-internal"
  },
  "number": 1775,
  "createdBy": "project:r8",
  "createTime": "2021-05-03T22:17:32.489443Z",
  "updateTime": "2021-05-03T22:17:32.941076Z",
  "status": "SCHEDULED",
  "input": {
    "gitilesCommit": {
      "host": "r8.googlesource.com",
      "project": "r8",
      "id": "744d742137a82656b8ee27513f975e0528aecd78",
      "ref": "refs/heads/main"
    }
  }
}
[22:17:33.079] Task URL: https://cr-buildbucket.appspot.com/build/8848216445124598000
[22:17:33.079] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9013646507123502384:2:0) after 6m31s
[22:24:04.097] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9013646507123502384:2:0)
[22:24:04.125] Build status: SCHEDULED
[22:24:04.125] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9013646507123502384:3:0) after 8m59s
[22:33:03.148] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9013646507123502384:3:0)
[22:33:03.181] Build status: SCHEDULED
[22:33:03.181] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9013646507123502384:4:0) after 3m59s
[22:37:02.694] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9013646507123502384:4:0)
[22:37:02.719] Build status: SCHEDULED
[22:37:02.719] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9013646507123502384:5:0) after 5m41s
[22:42:43.835] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9013646507123502384:5:0)
[22:42:43.868] Build status: SCHEDULED
[22:42:43.868] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9013646507123502384:6:0) after 7m31s
[22:50:14.973] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9013646507123502384:6:0)
[22:50:15.026] Build status: SCHEDULED
[22:50:15.026] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9013646507123502384:7:0) after 4m56s
[22:55:11.099] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9013646507123502384:7:0)
[22:55:11.147] Build status: SCHEDULED
[22:55:11.147] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9013646507123502384:8:0) after 6m1s
[23:01:12.332] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9013646507123502384:8:0)
[23:01:12.358] Build status: SCHEDULED
[23:01:12.358] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9013646507123502384:9:0) after 9m1s
[23:10:13.503] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9013646507123502384:9:0)
[23:10:13.529] Build status: SCHEDULED
[23:10:13.529] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9013646507123502384:10:0) after 7m51s
[23:18:04.568] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9013646507123502384:10:0)
[23:18:04.595] Build status: SCHEDULED
[23:18:04.595] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9013646507123502384:11:0) after 4m53s
[23:22:57.743] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9013646507123502384:11:0)
[23:22:57.770] Build status: SCHEDULED
[23:22:57.770] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9013646507123502384:12:0) after 8m46s
[23:31:43.861] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9013646507123502384:12:0)
[23:31:43.891] Build status: SCHEDULED
[23:31:43.892] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9013646507123502384:13:0) after 9m8s
[23:40:51.914] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9013646507123502384:13:0)
[23:40:51.942] Build status: SCHEDULED
[23:40:51.942] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9013646507123502384:14:0) after 1m38s
[23:42:30.008] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9013646507123502384:14:0)
[23:42:30.037] Build status: SCHEDULED
[23:42:30.037] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9013646507123502384:15:0) after 6m4s
[23:48:34.073] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9013646507123502384:15:0)
[23:48:34.107] Build status: SCHEDULED
[23:48:34.107] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9013646507123502384:16:0) after 9m14s
[23:57:48.129] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9013646507123502384:16:0)
[23:57:48.160] Build status: SCHEDULED
[23:57:48.160] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9013646507123502384:17:0) after 7m36s
[00:05:24.279] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9013646507123502384:17:0)
[00:05:24.310] Build status: SCHEDULED
[00:05:24.310] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9013646507123502384:18:0) after 7m0s
[00:12:24.423] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9013646507123502384:18:0)
[00:12:24.448] Build status: SCHEDULED
[00:12:24.448] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9013646507123502384:19:0) after 9m58s
[00:22:22.539] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9013646507123502384:19:0)
[00:22:22.575] Build status: SCHEDULED
[00:22:22.575] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9013646507123502384:20:0) after 7m7s
[00:29:29.892] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9013646507123502384:20:0)
[00:29:29.923] Build status: SCHEDULED
[00:29:29.923] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9013646507123502384:21:0) after 5m31s
[00:35:00.953] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9013646507123502384:21:0)
[00:35:00.992] Build status: SCHEDULED
[00:35:00.992] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9013646507123502384:22:0) after 5m24s
[00:40:25.071] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9013646507123502384:22:0)
[00:40:25.099] Build status: SCHEDULED
[00:40:25.099] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9013646507123502384:23:0) after 9m42s
[00:50:07.146] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9013646507123502384:23:0)
[00:50:07.181] Build status: SCHEDULED
[00:50:07.181] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9013646507123502384:24:0) after 4m4s
[00:54:11.214] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9013646507123502384:24:0)
[00:54:11.247] Build status: SCHEDULED
[00:54:11.247] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9013646507123502384:25:0) after 2m49s
[00:57:00.333] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9013646507123502384:25:0)
[00:57:00.360] Build status: SCHEDULED
[00:57:00.360] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9013646507123502384:26:0) after 3m7s
[01:00:07.491] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9013646507123502384:26:0)
[01:00:07.537] Build status: SCHEDULED
[01:00:07.537] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9013646507123502384:27:0) after 5m29s
[01:05:36.770] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9013646507123502384:27:0)
[01:05:36.818] Build status: SCHEDULED
[01:05:36.818] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9013646507123502384:28:0) after 4m39s
[01:10:15.973] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9013646507123502384:28:0)
[01:10:16.001] Build status: SCHEDULED
[01:10:16.001] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9013646507123502384:29:0) after 8m47s
[01:19:03.073] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9013646507123502384:29:0)
[01:19:03.100] Build status: SCHEDULED
[01:19:03.100] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9013646507123502384:30:0) after 6m3s
[01:25:06.122] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9013646507123502384:30:0)
[01:25:06.150] Build status: SCHEDULED
[01:25:06.150] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9013646507123502384:31:0) after 7m1s
[01:32:07.176] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9013646507123502384:31:0)
[01:32:07.204] Build status: SCHEDULED
[01:32:07.204] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9013646507123502384:32:0) after 4m47s
[01:36:54.229] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9013646507123502384:32:0)
[01:36:54.262] Build status: SCHEDULED
[01:36:54.262] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9013646507123502384:33:0) after 2m41s
[01:39:35.284] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9013646507123502384:33:0)
[01:39:35.313] Build status: SCHEDULED
[01:39:35.313] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9013646507123502384:34:0) after 7m42s
[01:47:17.336] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9013646507123502384:34:0)
[01:47:17.369] Build status: SCHEDULED
[01:47:17.369] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9013646507123502384:35:0) after 4m39s
[01:51:56.669] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9013646507123502384:35:0)
[01:51:56.745] Build status: SCHEDULED
[01:51:56.745] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9013646507123502384:36:0) after 5m30s
[01:57:26.762] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9013646507123502384:36:0)
[01:57:26.789] Build status: SCHEDULED
[01:57:26.789] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9013646507123502384:37:0) after 4m37s
[02:02:03.870] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9013646507123502384:37:0)
[02:02:03.899] Build status: SCHEDULED
[02:02:03.899] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9013646507123502384:38:0) after 5m2s
[02:07:05.919] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9013646507123502384:38:0)
[02:07:05.946] Build status: SCHEDULED
[02:07:05.946] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9013646507123502384:39:0) after 7m14s
[02:14:19.965] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9013646507123502384:39:0)
[02:14:19.995] Build status: SCHEDULED
[02:14:19.995] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9013646507123502384:40:0) after 2m18s
[02:16:38.014] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9013646507123502384:40:0)
[02:16:38.048] Build status: SCHEDULED
[02:16:38.048] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9013646507123502384:41:0) after 6m22s
[02:23:00.097] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9013646507123502384:41:0)
[02:23:00.142] Build status: SCHEDULED
[02:23:00.142] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9013646507123502384:42:0) after 9m40s
[02:32:40.302] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9013646507123502384:42:0)
[02:32:40.332] Build status: SCHEDULED
[02:32:40.332] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9013646507123502384:43:0) after 2m52s
[02:35:32.355] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9013646507123502384:43:0)
[02:35:32.387] Build status: SCHEDULED
[02:35:32.387] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9013646507123502384:44:0) after 2m4s
[02:37:36.421] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9013646507123502384:44:0)
[02:37:36.454] Build status: SCHEDULED
[02:37:36.454] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9013646507123502384:45:0) after 1m30s
[02:39:06.473] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9013646507123502384:45:0)
[02:39:06.499] Build status: SCHEDULED
[02:39:06.499] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9013646507123502384:46:0) after 2m16s
[02:41:22.521] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9013646507123502384:46:0)
[02:41:22.570] Build status: SCHEDULED
[02:41:22.570] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9013646507123502384:47:0) after 2m44s
[02:44:06.632] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9013646507123502384:47:0)
[02:44:06.662] Build status: SCHEDULED
[02:44:06.662] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9013646507123502384:48:0) after 6m25s
[02:50:31.697] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9013646507123502384:48:0)
[02:50:31.728] Build status: SCHEDULED
[02:50:31.728] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9013646507123502384:49:0) after 7m8s
[02:57:39.970] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9013646507123502384:49:0)
[02:57:40.002] Build status: SCHEDULED
[02:57:40.002] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9013646507123502384:50:0) after 1m41s
[02:59:21.001] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9013646507123502384:50:0)
[02:59:21.034] Build status: SCHEDULED
[02:59:21.034] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9013646507123502384:51:0) after 9m23s
[03:05:10.958] Received PubSub notification, asking Buildbucket for the build status
[03:05:11.034] Build status: STARTED
[03:08:44.212] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9013646507123502384:51:0)
[03:08:44.239] Build status: STARTED
[03:08:44.239] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9013646507123502384:53:0) after 2m13s
[03:10:57.267] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9013646507123502384:53:0)
[03:10:57.302] Build status: STARTED
[03:10:57.302] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9013646507123502384:54:0) after 5m23s
[03:16:20.607] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9013646507123502384:54:0)
[03:16:20.634] Build status: STARTED
[03:16:20.634] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9013646507123502384:55:0) after 1m27s
[03:17:47.656] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9013646507123502384:55:0)
[03:17:47.687] Build status: STARTED
[03:17:47.687] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9013646507123502384:56:0) after 3m39s
[03:21:26.721] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9013646507123502384:56:0)
[03:21:26.760] Build status: STARTED
[03:21:26.760] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9013646507123502384:57:0) after 3m39s
[03:25:05.892] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9013646507123502384:57:0)
[03:25:05.929] Build status: STARTED
[03:25:05.929] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9013646507123502384:58:0) after 9m33s
[03:34:38.993] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9013646507123502384:58:0)
[03:34:39.031] Build status: STARTED
[03:34:39.031] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9013646507123502384:59:0) after 3m58s
[03:38:37.218] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9013646507123502384:59:0)
[03:38:37.251] Build status: STARTED
[03:38:37.251] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9013646507123502384:60:0) after 4m50s
[03:43:27.269] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9013646507123502384:60:0)
[03:43:27.303] Build status: STARTED
[03:43:27.303] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9013646507123502384:61:0) after 9m55s
[03:53:22.427] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9013646507123502384:61:0)
[03:53:22.457] Build status: STARTED
[03:53:22.457] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9013646507123502384:62:0) after 5m12s
[03:58:34.637] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9013646507123502384:62:0)
[03:58:34.665] Build status: STARTED
[03:58:34.665] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9013646507123502384:63:0) after 4m50s
[04:03:24.652] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9013646507123502384:63:0)
[04:03:24.680] Build status: STARTED
[04:03:24.680] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9013646507123502384:64:0) after 4m28s
[04:07:52.727] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9013646507123502384:64:0)
[04:07:52.754] Build status: STARTED
[04:07:52.755] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9013646507123502384:65:0) after 9m3s
[04:16:55.931] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9013646507123502384:65:0)
[04:16:55.959] Build status: STARTED
[04:16:55.959] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9013646507123502384:66:0) after 9m44s
[04:26:39.983] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9013646507123502384:66:0)
[04:26:40.009] Build status: STARTED
[04:26:40.009] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9013646507123502384:67:0) after 4m20s
[04:31:00.242] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9013646507123502384:67:0)
[04:31:00.270] Build status: STARTED
[04:31:00.270] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9013646507123502384:68:0) after 4m30s
[04:35:30.289] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9013646507123502384:68:0)
[04:35:30.316] Build status: STARTED
[04:35:30.316] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9013646507123502384:69:0) after 2m52s
[04:38:22.335] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9013646507123502384:69:0)
[04:38:22.406] Build status: STARTED
[04:38:22.406] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9013646507123502384:70:0) after 7m6s
[04:45:28.522] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9013646507123502384:70:0)
[04:45:28.551] Build status: STARTED
[04:45:28.551] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9013646507123502384:71:0) after 6m40s
[04:52:08.624] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9013646507123502384:71:0)
[04:52:08.652] Build status: STARTED
[04:52:08.652] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9013646507123502384:72:0) after 6m16s
[04:58:24.838] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9013646507123502384:72:0)
[04:58:24.866] Build status: STARTED
[04:58:24.866] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9013646507123502384:73:0) after 6m59s
[05:05:23.889] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9013646507123502384:73:0)
[05:05:23.918] Build status: STARTED
[05:05:23.918] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9013646507123502384:74:0) after 7m51s
[05:13:14.941] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9013646507123502384:74:0)
[05:13:14.975] Build status: STARTED
[05:13:14.975] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9013646507123502384:75:0) after 7m46s
[05:21:01.248] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9013646507123502384:75:0)
[05:21:01.278] Build status: STARTED
[05:21:01.278] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9013646507123502384:76:0) after 8m6s
[05:29:07.319] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9013646507123502384:76:0)
[05:29:07.348] Build status: STARTED
[05:29:07.348] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9013646507123502384:77:0) after 7m36s
[05:36:43.415] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9013646507123502384:77:0)
[05:36:43.437] Build status: STARTED
[05:36:43.437] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9013646507123502384:78:0) after 6m21s
[05:43:04.438] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9013646507123502384:78:0)
[05:43:04.466] Build status: STARTED
[05:43:04.466] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9013646507123502384:79:0) after 4m44s
[05:47:48.729] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9013646507123502384:79:0)
[05:47:48.759] Build status: STARTED
[05:47:48.759] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9013646507123502384:80:0) after 2m33s
[05:50:21.866] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9013646507123502384:80:0)
[05:50:21.897] Build status: STARTED
[05:50:21.897] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9013646507123502384:81:0) after 6m48s
[05:57:09.919] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9013646507123502384:81:0)
[05:57:09.946] Build status: STARTED
[05:57:09.946] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9013646507123502384:82:0) after 8m15s
[06:05:25.072] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9013646507123502384:82:0)
[06:05:25.110] Build status: STARTED
[06:05:25.110] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9013646507123502384:83:0) after 2m55s
[06:08:20.231] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9013646507123502384:83:0)
[06:08:20.256] Build status: STARTED
[06:08:20.256] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9013646507123502384:84:0) after 5m40s
[06:14:00.453] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9013646507123502384:84:0)
[06:14:00.481] Build status: STARTED
[06:14:00.481] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9013646507123502384:85:0) after 3m30s
[06:17:30.575] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9013646507123502384:85:0)
[06:17:30.601] Build status: STARTED
[06:17:30.601] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9013646507123502384:86:0) after 6m15s
[06:23:45.633] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9013646507123502384:86:0)
[06:23:45.661] Build status: STARTED
[06:23:45.661] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9013646507123502384:87:0) after 9m6s
[06:32:51.784] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9013646507123502384:87:0)
[06:32:51.808] Build status: STARTED
[06:32:51.808] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9013646507123502384:88:0) after 8m41s
[06:41:32.859] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9013646507123502384:88:0)
[06:41:32.884] Build status: STARTED
[06:41:32.884] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9013646507123502384:89:0) after 1m11s
[06:42:43.907] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9013646507123502384:89:0)
[06:42:43.936] Build status: STARTED
[06:42:43.936] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9013646507123502384:90:0) after 4m1s
[06:46:45.011] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9013646507123502384:90:0)
[06:46:45.037] Build status: STARTED
[06:46:45.037] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9013646507123502384:91:0) after 8m31s
[06:55:16.276] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9013646507123502384:91:0)
[06:55:16.302] Build status: STARTED
[06:55:16.302] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9013646507123502384:92:0) after 8m46s
[07:04:02.436] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9013646507123502384:92:0)
[07:04:02.468] Build status: STARTED
[07:04:02.468] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9013646507123502384:93:0) after 6m26s
[07:10:28.489] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9013646507123502384:93:0)
[07:10:28.525] Build status: STARTED
[07:10:28.525] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9013646507123502384:94:0) after 6m20s
[07:16:48.727] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9013646507123502384:94:0)
[07:16:48.752] Build status: STARTED
[07:16:48.752] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9013646507123502384:95:0) after 3m57s
[07:20:45.791] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9013646507123502384:95:0)
[07:20:45.817] Build status: STARTED
[07:20:45.817] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9013646507123502384:96:0) after 5m37s
[07:26:22.938] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9013646507123502384:96:0)
[07:26:22.975] Build status: STARTED
[07:26:22.975] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9013646507123502384:97:0) after 6m13s
[07:32:36.140] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9013646507123502384:97:0)
[07:32:36.167] Build status: STARTED
[07:32:36.167] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9013646507123502384:98:0) after 9m19s
[07:41:55.195] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9013646507123502384:98:0)
[07:41:55.225] Build status: STARTED
[07:41:55.225] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9013646507123502384:99:0) after 5m20s
[07:47:15.246] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9013646507123502384:99:0)
[07:47:15.274] Build status: STARTED
[07:47:15.274] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9013646507123502384:100:0) after 2m51s
[07:50:06.665] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9013646507123502384:100:0)
[07:50:06.692] Build status: STARTED
[07:50:06.692] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9013646507123502384:101:0) after 8m42s
[07:58:48.710] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9013646507123502384:101:0)
[07:58:48.808] Build status: STARTED
[07:58:48.808] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9013646507123502384:102:0) after 6m37s
[08:05:25.830] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9013646507123502384:102:0)
[08:05:25.858] Build status: STARTED
[08:05:25.858] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9013646507123502384:103:0) after 2m54s
[08:08:19.884] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9013646507123502384:103:0)
[08:08:19.910] Build status: STARTED
[08:08:19.910] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9013646507123502384:104:0) after 8m3s
[08:16:22.969] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9013646507123502384:104:0)
[08:16:22.995] Build status: STARTED
[08:16:22.995] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9013646507123502384:105:0) after 3m46s
[08:20:09.030] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9013646507123502384:105:0)
[08:20:09.062] Build status: STARTED
[08:20:09.062] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9013646507123502384:106:0) after 3m41s
[08:23:50.399] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9013646507123502384:106:0)
[08:23:50.434] Build status: STARTED
[08:23:50.434] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9013646507123502384:107:0) after 3m44s
[08:27:34.455] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9013646507123502384:107:0)
[08:27:34.502] Build status: STARTED
[08:27:34.502] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9013646507123502384:108:0) after 5m49s
[08:33:23.599] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9013646507123502384:108:0)
[08:33:23.628] Build status: STARTED
[08:33:23.628] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9013646507123502384:109:0) after 5m12s
[08:38:35.661] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9013646507123502384:109:0)
[08:38:35.686] Build status: STARTED
[08:38:35.686] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9013646507123502384:110:0) after 9m39s
[08:39:03.428] Received PubSub notification, asking Buildbucket for the build status
[08:39:03.454] Build:
{
  "id": "8848216445124598000",
  "builder": {
    "project": "r8",
    "bucket": "ci",
    "builder": "linux-internal"
  },
  "number": 1775,
  "createdBy": "project:r8",
  "createTime": "2021-05-03T22:17:32.489443Z",
  "startTime": "2021-05-04T03:05:08.059080Z",
  "endTime": "2021-05-04T08:38:54.036983Z",
  "updateTime": "2021-05-04T08:38:54.317992Z",
  "status": "SUCCESS",
  "input": {
    "gitilesCommit": {
      "host": "r8.googlesource.com",
      "project": "r8",
      "id": "744d742137a82656b8ee27513f975e0528aecd78",
      "ref": "refs/heads/main"
    }
  }
}
[08:39:03.454] Invocation finished in 10h21m32.255232246s with status SUCCEEDED