LUCI Scheduler :: nacl :: linux-64-validator-opt

Status: SUCCEEDED

Triggered by: -

Duration: 7 hours

Actions:

Definition (rev bfb605913f5344b857c7354e555e9cccd458dc07)

buildbucket: <
  server: "cr-buildbucket.appspot.com"
  bucket: "ci"
  builder: "linux-64-validator-opt"
>

Incoming triggers

984091cc2de8571b10a388a8158faa47752e677b (2 years ago)

Incoming properties

{
  "branch": "refs/heads/main",
  "repository": "https://chromium.googlesource.com/native_client/src/native_client",
  "revision": "984091cc2de8571b10a388a8158faa47752e677b"
}

Incoming tags

buildset:commit/gitiles/chromium.googlesource.com/native_client/src/native_client/+/984091cc2de8571b10a388a8158faa47752e677b
gitiles_ref:refs/heads/main

Debug log (UTC)

[17:04:52.209] New invocation is queued and will start shortly
[17:04:53.279] Starting the invocation (attempt 1)
[17:04:53.338] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/native_client/src/native_client/+/984091cc2de8571b10a388a8158faa47752e677b"
[17:04:53.338] Popped gitiles commit info from properties and tags
[17:04:53.338] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[17:04:53.338] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[17:04:53.339] Buildbucket request:
{
  "requestId": "8986034102612793312",
  "builder": {
    "project": "nacl",
    "bucket": "ci",
    "builder": "linux-64-validator-opt"
  },
  "properties": {
      "$recipe_engine/scheduler": {
            "hostname": "luci-scheduler.appspot.com",
            "triggers": [
                  {
                        "gitiles": {
                              "ref": "refs/heads/main",
                              "repo": "https://chromium.googlesource.com/native_client/src/native_client",
                              "revision": "984091cc2de8571b10a388a8158faa47752e677b"
                            },
                        "id": "https://chromium.googlesource.com/native_client/src/native_client/+/refs/heads/main@984091cc2de8571b10a388a8158faa47752e677b",
                        "title": "984091cc2de8571b10a388a8158faa47752e677b",
                        "url": "https://chromium.googlesource.com/native_client/src/native_client/+/984091cc2de8571b10a388a8158faa47752e677b"
                      }
                ]
          }
    },
  "gitilesCommit": {
    "host": "chromium.googlesource.com",
    "project": "native_client/src/native_client",
    "id": "984091cc2de8571b10a388a8158faa47752e677b",
    "ref": "refs/heads/main"
  },
  "tags": [
    {
      "key": "scheduler_invocation_id",
      "value": "8986034102612793312"
    },
    {
      "key": "scheduler_job_id",
      "value": "nacl/linux-64-validator-opt"
    },
    {
      "key": "user_agent",
      "value": "luci-scheduler"
    }
  ],
  "notify": {
    "pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
  }
}
[17:04:53.824] Scheduled build:
{
  "id": "8820604040694065073",
  "builder": {
    "project": "nacl",
    "bucket": "ci",
    "builder": "linux-64-validator-opt"
  },
  "number": 277,
  "createdBy": "project:nacl",
  "createTime": "2022-03-04T17:04:53.408455437Z",
  "updateTime": "2022-03-04T17:04:53.408455437Z",
  "status": "SCHEDULED",
  "input": {
    "gitilesCommit": {
      "host": "chromium.googlesource.com",
      "project": "native_client/src/native_client",
      "id": "984091cc2de8571b10a388a8158faa47752e677b",
      "ref": "refs/heads/main"
    }
  }
}
[17:04:53.824] Task URL: https://cr-buildbucket.appspot.com/build/8820604040694065073
[17:04:53.824] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:8986034102612793312:2:0) after 1m6s
[17:05:59.876] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:8986034102612793312:2:0)
[17:05:59.911] Build status: SCHEDULED
[17:05:59.911] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:8986034102612793312:3:0) after 7m3s
[17:13:03.032] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:8986034102612793312:3:0)
[17:13:03.065] Build status: SCHEDULED
[17:13:03.065] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:8986034102612793312:4:0) after 5m10s
[17:13:16.887] Received PubSub notification, asking Buildbucket for the build status
[17:13:16.923] Build status: STARTED
[17:18:13.084] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:8986034102612793312:4:0)
[17:18:13.121] Build status: STARTED
[17:18:13.121] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:8986034102612793312:6:0) after 6m3s
[17:24:16.318] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:8986034102612793312:6:0)
[17:24:16.357] Build status: STARTED
[17:24:16.357] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:8986034102612793312:7:0) after 1m31s
[17:25:47.376] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:8986034102612793312:7:0)
[17:25:47.408] Build status: STARTED
[17:25:47.408] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:8986034102612793312:8:0) after 6m32s
[17:32:19.426] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:8986034102612793312:8:0)
[17:32:19.482] Build status: STARTED
[17:32:19.482] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:8986034102612793312:9:0) after 3m28s
[17:35:47.516] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:8986034102612793312:9:0)
[17:35:47.547] Build status: STARTED
[17:35:47.547] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:8986034102612793312:10:0) after 6m22s
[17:42:09.703] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:8986034102612793312:10:0)
[17:42:09.733] Build status: STARTED
[17:42:09.733] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:8986034102612793312:11:0) after 1m55s
[17:44:04.979] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:8986034102612793312:11:0)
[17:44:05.009] Build status: STARTED
[17:44:05.009] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:8986034102612793312:12:0) after 8m53s
[17:52:58.027] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:8986034102612793312:12:0)
[17:52:58.076] Build status: STARTED
[17:52:58.076] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:8986034102612793312:13:0) after 5m41s
[17:58:39.106] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:8986034102612793312:13:0)
[17:58:39.147] Build status: STARTED
[17:58:39.147] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:8986034102612793312:14:0) after 8m54s
[18:07:33.354] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:8986034102612793312:14:0)
[18:07:33.385] Build status: STARTED
[18:07:33.385] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:8986034102612793312:15:0) after 8m4s
[18:15:37.390] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:8986034102612793312:15:0)
[18:15:37.421] Build status: STARTED
[18:15:37.421] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:8986034102612793312:16:0) after 7m20s
[18:22:57.914] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:8986034102612793312:16:0)
[18:22:57.948] Build status: STARTED
[18:22:57.948] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:8986034102612793312:17:0) after 1m37s
[18:24:34.964] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:8986034102612793312:17:0)
[18:24:34.994] Build status: STARTED
[18:24:34.994] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:8986034102612793312:18:0) after 7m49s
[18:32:24.035] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:8986034102612793312:18:0)
[18:32:24.068] Build status: STARTED
[18:32:24.070] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:8986034102612793312:19:0) after 3m27s
[18:35:51.374] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:8986034102612793312:19:0)
[18:35:51.421] Build status: STARTED
[18:35:51.421] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:8986034102612793312:20:0) after 6m9s
[18:42:00.490] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:8986034102612793312:20:0)
[18:42:00.528] Build status: STARTED
[18:42:00.528] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:8986034102612793312:21:0) after 8m4s
[18:50:04.591] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:8986034102612793312:21:0)
[18:50:04.627] Build status: STARTED
[18:50:04.627] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:8986034102612793312:22:0) after 3m44s
[18:53:48.659] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:8986034102612793312:22:0)
[18:53:48.740] Build status: STARTED
[18:53:48.741] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:8986034102612793312:23:0) after 6m30s
[19:00:18.849] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:8986034102612793312:23:0)
[19:00:18.887] Build status: STARTED
[19:00:18.887] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:8986034102612793312:24:0) after 5m56s
[19:06:14.905] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:8986034102612793312:24:0)
[19:06:14.941] Build status: STARTED
[19:06:14.941] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:8986034102612793312:25:0) after 8m19s
[19:14:34.141] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:8986034102612793312:25:0)
[19:14:34.172] Build status: STARTED
[19:14:34.172] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:8986034102612793312:26:0) after 7m23s
[19:21:57.372] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:8986034102612793312:26:0)
[19:21:57.404] Build status: STARTED
[19:21:57.404] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:8986034102612793312:27:0) after 2m47s
[19:24:44.426] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:8986034102612793312:27:0)
[19:24:44.468] Build status: STARTED
[19:24:44.468] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:8986034102612793312:28:0) after 9m25s
[19:34:09.459] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:8986034102612793312:28:0)
[19:34:09.512] Build status: STARTED
[19:34:09.512] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:8986034102612793312:29:0) after 9m54s
[19:44:03.603] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:8986034102612793312:29:0)
[19:44:03.651] Build status: STARTED
[19:44:03.651] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:8986034102612793312:30:0) after 6m43s
[19:50:46.811] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:8986034102612793312:30:0)
[19:50:46.843] Build status: STARTED
[19:50:46.843] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:8986034102612793312:31:0) after 4m30s
[19:55:16.863] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:8986034102612793312:31:0)
[19:55:16.905] Build status: STARTED
[19:55:16.905] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:8986034102612793312:32:0) after 6m55s
[20:02:12.069] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:8986034102612793312:32:0)
[20:02:12.128] Build status: STARTED
[20:02:12.128] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:8986034102612793312:33:0) after 4m11s
[20:06:23.386] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:8986034102612793312:33:0)
[20:06:23.487] Build status: STARTED
[20:06:23.487] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:8986034102612793312:34:0) after 3m11s
[20:09:34.553] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:8986034102612793312:34:0)
[20:09:34.608] Build status: STARTED
[20:09:34.608] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:8986034102612793312:35:0) after 9m7s
[20:18:42.013] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:8986034102612793312:35:0)
[20:18:42.052] Build status: STARTED
[20:18:42.052] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:8986034102612793312:36:0) after 1m45s
[20:20:27.173] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:8986034102612793312:36:0)
[20:20:27.208] Build status: STARTED
[20:20:27.208] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:8986034102612793312:37:0) after 2m18s
[20:22:45.329] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:8986034102612793312:37:0)
[20:22:45.360] Build status: STARTED
[20:22:45.360] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:8986034102612793312:38:0) after 3m23s
[20:26:08.589] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:8986034102612793312:38:0)
[20:26:08.630] Build status: STARTED
[20:26:08.630] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:8986034102612793312:39:0) after 9m11s
[20:35:19.664] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:8986034102612793312:39:0)
[20:35:19.702] Build status: STARTED
[20:35:19.702] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:8986034102612793312:40:0) after 8m1s
[20:43:20.943] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:8986034102612793312:40:0)
[20:43:20.978] Build status: STARTED
[20:43:20.978] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:8986034102612793312:41:0) after 8m32s
[20:51:53.382] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:8986034102612793312:41:0)
[20:51:53.460] Build status: STARTED
[20:51:53.460] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:8986034102612793312:42:0) after 3m28s
[20:55:21.601] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:8986034102612793312:42:0)
[20:55:21.644] Build status: STARTED
[20:55:21.644] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:8986034102612793312:43:0) after 9m58s
[21:05:19.769] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:8986034102612793312:43:0)
[21:05:19.849] Build status: STARTED
[21:05:19.849] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:8986034102612793312:44:0) after 3m32s
[21:08:51.900] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:8986034102612793312:44:0)
[21:08:51.944] Build status: STARTED
[21:08:51.944] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:8986034102612793312:45:0) after 3m18s
[21:12:10.020] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:8986034102612793312:45:0)
[21:12:10.048] Build status: STARTED
[21:12:10.048] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:8986034102612793312:46:0) after 7m12s
[21:19:22.376] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:8986034102612793312:46:0)
[21:19:22.407] Build status: STARTED
[21:19:22.407] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:8986034102612793312:47:0) after 6m21s
[21:25:43.790] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:8986034102612793312:47:0)
[21:25:43.827] Build status: STARTED
[21:25:43.827] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:8986034102612793312:48:0) after 4m46s
[21:30:30.048] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:8986034102612793312:48:0)
[21:30:30.103] Build status: STARTED
[21:30:30.103] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:8986034102612793312:49:0) after 2m24s
[21:32:54.648] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:8986034102612793312:49:0)
[21:32:54.682] Build status: STARTED
[21:32:54.682] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:8986034102612793312:50:0) after 4m39s
[21:37:33.691] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:8986034102612793312:50:0)
[21:37:33.721] Build status: STARTED
[21:37:33.721] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:8986034102612793312:51:0) after 1m28s
[21:39:01.878] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:8986034102612793312:51:0)
[21:39:01.923] Build status: STARTED
[21:39:01.923] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:8986034102612793312:52:0) after 5m47s
[21:44:48.984] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:8986034102612793312:52:0)
[21:44:49.029] Build status: STARTED
[21:44:49.029] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:8986034102612793312:53:0) after 1m58s
[21:46:47.055] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:8986034102612793312:53:0)
[21:46:47.095] Build status: STARTED
[21:46:47.095] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:8986034102612793312:54:0) after 1m6s
[21:47:53.334] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:8986034102612793312:54:0)
[21:47:53.408] Build status: STARTED
[21:47:53.408] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:8986034102612793312:55:0) after 9m9s
[21:57:02.459] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:8986034102612793312:55:0)
[21:57:02.491] Build status: STARTED
[21:57:02.491] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:8986034102612793312:56:0) after 7m57s
[22:04:59.581] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:8986034102612793312:56:0)
[22:04:59.611] Build status: STARTED
[22:04:59.611] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:8986034102612793312:57:0) after 6m41s
[22:11:40.675] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:8986034102612793312:57:0)
[22:11:40.741] Build status: STARTED
[22:11:40.741] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:8986034102612793312:58:0) after 6m55s
[22:18:35.765] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:8986034102612793312:58:0)
[22:18:35.796] Build status: STARTED
[22:18:35.796] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:8986034102612793312:59:0) after 3m55s
[22:22:30.819] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:8986034102612793312:59:0)
[22:22:30.859] Build status: STARTED
[22:22:30.859] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:8986034102612793312:60:0) after 7m44s
[22:30:14.890] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:8986034102612793312:60:0)
[22:30:14.927] Build status: STARTED
[22:30:14.927] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:8986034102612793312:61:0) after 8m11s
[22:38:26.082] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:8986034102612793312:61:0)
[22:38:26.120] Build status: STARTED
[22:38:26.120] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:8986034102612793312:62:0) after 1m48s
[22:40:14.402] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:8986034102612793312:62:0)
[22:40:14.438] Build status: STARTED
[22:40:14.438] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:8986034102612793312:63:0) after 3m14s
[22:43:28.573] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:8986034102612793312:63:0)
[22:43:28.622] Build status: STARTED
[22:43:28.622] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:8986034102612793312:64:0) after 1m45s
[22:45:14.272] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:8986034102612793312:64:0)
[22:45:14.307] Build status: STARTED
[22:45:14.307] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:8986034102612793312:65:0) after 9m26s
[22:54:40.330] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:8986034102612793312:65:0)
[22:54:40.382] Build status: STARTED
[22:54:40.382] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:8986034102612793312:66:0) after 5m5s
[22:59:45.680] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:8986034102612793312:66:0)
[22:59:45.714] Build status: STARTED
[22:59:45.714] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:8986034102612793312:67:0) after 4m59s
[23:04:44.806] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:8986034102612793312:67:0)
[23:04:44.835] Build status: STARTED
[23:04:44.835] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:8986034102612793312:68:0) after 4m30s
[23:09:14.930] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:8986034102612793312:68:0)
[23:09:15.021] Build status: STARTED
[23:09:15.021] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:8986034102612793312:69:0) after 1m10s
[23:10:25.025] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:8986034102612793312:69:0)
[23:10:25.057] Build status: STARTED
[23:10:25.057] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:8986034102612793312:70:0) after 2m41s
[23:13:06.159] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:8986034102612793312:70:0)
[23:13:06.196] Build status: STARTED
[23:13:06.196] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:8986034102612793312:71:0) after 1m22s
[23:14:28.199] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:8986034102612793312:71:0)
[23:14:28.235] Build status: STARTED
[23:14:28.235] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:8986034102612793312:72:0) after 5m3s
[23:19:31.255] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:8986034102612793312:72:0)
[23:19:31.287] Build status: STARTED
[23:19:31.287] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:8986034102612793312:73:0) after 8m19s
[23:27:50.479] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:8986034102612793312:73:0)
[23:27:50.512] Build status: STARTED
[23:27:50.512] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:8986034102612793312:74:0) after 2m0s
[23:30:22.351] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:8986034102612793312:74:0)
[23:30:22.385] Build status: STARTED
[23:30:22.385] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:8986034102612793312:75:0) after 6m48s
[23:37:10.976] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:8986034102612793312:75:0)
[23:37:11.009] Build status: STARTED
[23:37:11.009] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:8986034102612793312:76:0) after 1m19s
[23:38:30.202] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:8986034102612793312:76:0)
[23:38:30.236] Build status: STARTED
[23:38:30.236] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:8986034102612793312:77:0) after 4m1s
[23:42:31.259] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:8986034102612793312:77:0)
[23:42:31.300] Build status: STARTED
[23:42:31.300] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:8986034102612793312:78:0) after 3m12s
[23:45:43.611] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:8986034102612793312:78:0)
[23:45:43.644] Build status: STARTED
[23:45:43.644] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:8986034102612793312:79:0) after 9m7s
[23:54:50.638] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:8986034102612793312:79:0)
[23:54:50.667] Build status: STARTED
[23:54:50.667] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:8986034102612793312:80:0) after 8m22s
[00:03:12.697] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:8986034102612793312:80:0)
[00:03:12.748] Build status: STARTED
[00:03:12.748] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:8986034102612793312:81:0) after 7m36s
[00:09:34.108] Received PubSub notification, asking Buildbucket for the build status
[00:09:34.139] Build:
{
  "id": "8820604040694065073",
  "builder": {
    "project": "nacl",
    "bucket": "ci",
    "builder": "linux-64-validator-opt"
  },
  "number": 277,
  "createdBy": "project:nacl",
  "createTime": "2022-03-04T17:04:53.408455437Z",
  "startTime": "2022-03-04T17:13:12.372586Z",
  "endTime": "2022-03-05T00:09:33.726373443Z",
  "updateTime": "2022-03-05T00:09:33.726373443Z",
  "status": "SUCCESS",
  "input": {
    "gitilesCommit": {
      "host": "chromium.googlesource.com",
      "project": "native_client/src/native_client",
      "id": "984091cc2de8571b10a388a8158faa47752e677b",
      "ref": "refs/heads/main"
    }
  }
}
[00:09:34.139] Invocation finished in 7h4m41.944568728s with status SUCCEEDED