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

• 417e89893751ee0fea04c86edf386f1eff0e2c96 (2 years ago)

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

• buildset:commit/gitiles/chromium.googlesource.com/native_client/src/native_client/+/417e89893751ee0fea04c86edf386f1eff0e2c96
• gitiles_ref:refs/heads/main

[18:25:47.739] New invocation is queued and will start shortly
[18:25:49.158] Starting the invocation (attempt 1)
[18:25:49.185] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/native_client/src/native_client/+/417e89893751ee0fea04c86edf386f1eff0e2c96"
[18:25:49.185] Popped gitiles commit info from properties and tags
[18:25:49.185] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[18:25:49.185] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[18:25:49.186] Buildbucket request:
{
  "requestId": "8949427836795224480",
  "builder": {
    "project": "nacl",
    "bucket": "ci",
    "builder": "linux-64-validator-opt"
  },
  "properties": {
      "$recipe_engine/scheduler": {
            "hostname": "luci-scheduler.appspot.com",
            "invocation": "8949427836795224480",
            "job": "nacl/linux-64-validator-opt",
            "triggers": [
                  {
                        "gitiles": {
                              "ref": "refs/heads/main",
                              "repo": "https://chromium.googlesource.com/native_client/src/native_client",
                              "revision": "417e89893751ee0fea04c86edf386f1eff0e2c96"
                            },
                        "id": "https://chromium.googlesource.com/native_client/src/native_client/+/refs/heads/main@417e89893751ee0fea04c86edf386f1eff0e2c96",
                        "title": "417e89893751ee0fea04c86edf386f1eff0e2c96",
                        "url": "https://chromium.googlesource.com/native_client/src/native_client/+/417e89893751ee0fea04c86edf386f1eff0e2c96"
                      }
                ]
          }
    },
  "gitilesCommit": {
    "host": "chromium.googlesource.com",
    "project": "native_client/src/native_client",
    "id": "417e89893751ee0fea04c86edf386f1eff0e2c96",
    "ref": "refs/heads/main"
  },
  "tags": [
    {
      "key": "scheduler_invocation_id",
      "value": "8949427836795224480"
    },
    {
      "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"
  }
}
[18:25:49.550] Scheduled build:
{
  "id": "8783997774556184529",
  "builder": {
    "project": "nacl",
    "bucket": "ci",
    "builder": "linux-64-validator-opt"
  },
  "number": 347,
  "createdBy": "project:nacl",
  "createTime": "2023-04-12T18:25:49.244717756Z",
  "updateTime": "2023-04-12T18:25:49.244717756Z",
  "status": "SCHEDULED",
  "input": {
    "gitilesCommit": {
      "host": "chromium.googlesource.com",
      "project": "native_client/src/native_client",
      "id": "417e89893751ee0fea04c86edf386f1eff0e2c96",
      "ref": "refs/heads/main"
    }
  }
}
[18:25:49.550] Task URL: https://cr-buildbucket.appspot.com/build/8783997774556184529
[18:25:49.550] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:8949427836795224480:2:0) after 4m17s
[18:26:10.585] Received PubSub notification, asking Buildbucket for the build status
[18:26:10.617] Build status: STARTED
[18:30:06.624] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:8949427836795224480:2:0)
[18:30:06.660] Build status: STARTED
[18:30:06.660] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:8949427836795224480:4:0) after 3m47s
[18:33:53.678] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:8949427836795224480:4:0)
[18:33:53.698] Build status: STARTED
[18:33:53.698] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:8949427836795224480:5:0) after 1m29s
[18:35:22.718] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:8949427836795224480:5:0)
[18:35:22.759] Build status: STARTED
[18:35:22.759] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:8949427836795224480:6:0) after 4m48s
[18:40:10.775] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:8949427836795224480:6:0)
[18:40:10.795] Build status: STARTED
[18:40:10.795] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:8949427836795224480:7:0) after 4m47s
[18:44:57.812] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:8949427836795224480:7:0)
[18:44:57.836] Build status: STARTED
[18:44:57.836] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:8949427836795224480:8:0) after 3m20s
[18:48:17.861] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:8949427836795224480:8:0)
[18:48:17.940] Build status: STARTED
[18:48:17.940] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:8949427836795224480:9:0) after 9m54s
[18:58:11.950] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:8949427836795224480:9:0)
[18:58:11.994] Build status: STARTED
[18:58:11.994] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:8949427836795224480:10:0) after 3m0s
[19:01:12.016] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:8949427836795224480:10:0)
[19:01:12.062] Build status: STARTED
[19:01:12.062] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:8949427836795224480:11:0) after 5m36s
[19:06:48.083] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:8949427836795224480:11:0)
[19:06:48.131] Build status: STARTED
[19:06:48.131] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:8949427836795224480:12:0) after 9m22s
[19:16:10.148] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:8949427836795224480:12:0)
[19:16:10.348] Build status: STARTED
[19:16:10.348] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:8949427836795224480:13:0) after 2m2s
[19:18:12.495] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:8949427836795224480:13:0)
[19:18:12.516] Build status: STARTED
[19:18:12.516] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:8949427836795224480:14:0) after 5m33s
[19:23:45.544] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:8949427836795224480:14:0)
[19:23:45.713] Build status: STARTED
[19:23:45.713] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:8949427836795224480:15:0) after 6m2s
[19:29:47.699] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:8949427836795224480:15:0)
[19:29:47.760] Build status: STARTED
[19:29:47.760] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:8949427836795224480:16:0) after 2m26s
[19:32:13.811] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:8949427836795224480:16:0)
[19:32:13.849] Build status: STARTED
[19:32:13.849] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:8949427836795224480:17:0) after 2m14s
[19:34:27.933] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:8949427836795224480:17:0)
[19:34:27.972] Build status: STARTED
[19:34:27.972] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:8949427836795224480:18:0) after 9m18s
[19:43:45.990] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:8949427836795224480:18:0)
[19:43:46.012] Build status: STARTED
[19:43:46.012] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:8949427836795224480:19:0) after 8m49s
[19:52:35.039] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:8949427836795224480:19:0)
[19:52:35.098] Build status: STARTED
[19:52:35.098] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:8949427836795224480:20:0) after 9m59s
[20:02:34.481] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:8949427836795224480:20:0)
[20:02:34.551] Build status: STARTED
[20:02:34.551] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:8949427836795224480:21:0) after 5m31s
[20:08:05.665] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:8949427836795224480:21:0)
[20:08:05.790] Build status: STARTED
[20:08:05.790] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:8949427836795224480:22:0) after 6m33s
[20:14:38.809] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:8949427836795224480:22:0)
[20:14:38.839] Build status: STARTED
[20:14:38.839] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:8949427836795224480:23:0) after 2m24s
[20:17:02.964] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:8949427836795224480:23:0)
[20:17:03.008] Build status: STARTED
[20:17:03.008] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:8949427836795224480:24:0) after 9m13s
[20:26:16.025] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:8949427836795224480:24:0)
[20:26:16.194] Build status: STARTED
[20:26:16.194] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:8949427836795224480:25:0) after 9m17s
[20:35:33.211] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:8949427836795224480:25:0)
[20:35:33.360] Build status: STARTED
[20:35:33.360] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:8949427836795224480:26:0) after 4m37s
[20:40:10.381] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:8949427836795224480:26:0)
[20:40:10.435] Build status: STARTED
[20:40:10.435] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:8949427836795224480:27:0) after 4m34s
[20:44:44.450] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:8949427836795224480:27:0)
[20:44:44.575] Build status: STARTED
[20:44:44.575] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:8949427836795224480:28:0) after 5m54s
[20:50:38.649] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:8949427836795224480:28:0)
[20:50:38.718] Build status: STARTED
[20:50:38.718] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:8949427836795224480:29:0) after 7m24s
[20:58:02.734] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:8949427836795224480:29:0)
[20:58:02.771] Build status: STARTED
[20:58:02.771] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:8949427836795224480:30:0) after 2m7s
[21:00:09.787] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:8949427836795224480:30:0)
[21:00:09.834] Build status: STARTED
[21:00:09.835] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:8949427836795224480:31:0) after 3m41s
[21:03:50.851] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:8949427836795224480:31:0)
[21:03:50.874] Build status: STARTED
[21:03:50.874] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:8949427836795224480:32:0) after 4m0s
[21:07:50.960] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:8949427836795224480:32:0)
[21:07:51.004] Build status: STARTED
[21:07:51.004] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:8949427836795224480:33:0) after 3m23s
[21:11:14.032] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:8949427836795224480:33:0)
[21:11:14.065] Build status: STARTED
[21:11:14.065] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:8949427836795224480:34:0) after 6m40s
[21:17:54.091] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:8949427836795224480:34:0)
[21:17:54.123] Build status: STARTED
[21:17:54.123] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:8949427836795224480:35:0) after 7m28s
[21:25:22.153] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:8949427836795224480:35:0)
[21:25:22.195] Build status: STARTED
[21:25:22.195] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:8949427836795224480:36:0) after 4m27s
[21:29:49.263] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:8949427836795224480:36:0)
[21:29:49.285] Build status: STARTED
[21:29:49.285] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:8949427836795224480:37:0) after 2m39s
[21:32:28.289] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:8949427836795224480:37:0)
[21:32:28.357] Build status: STARTED
[21:32:28.357] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:8949427836795224480:38:0) after 6m8s
[21:38:36.426] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:8949427836795224480:38:0)
[21:38:36.458] Build status: STARTED
[21:38:36.459] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:8949427836795224480:39:0) after 6m47s
[21:45:23.510] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:8949427836795224480:39:0)
[21:45:23.553] Build status: STARTED
[21:45:23.553] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:8949427836795224480:40:0) after 8m1s
[21:53:24.622] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:8949427836795224480:40:0)
[21:53:24.678] Build status: STARTED
[21:53:24.678] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:8949427836795224480:41:0) after 5m8s
[21:58:32.806] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:8949427836795224480:41:0)
[21:58:32.840] Build status: STARTED
[21:58:32.840] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:8949427836795224480:42:0) after 1m6s
[21:59:39.257] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:8949427836795224480:42:0)
[21:59:39.289] Build status: STARTED
[21:59:39.289] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:8949427836795224480:43:0) after 3m47s
[22:03:26.650] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:8949427836795224480:43:0)
[22:03:26.966] Build status: STARTED
[22:03:26.966] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:8949427836795224480:44:0) after 6m37s
[22:10:03.987] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:8949427836795224480:44:0)
[22:10:04.078] Build status: STARTED
[22:10:04.078] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:8949427836795224480:45:0) after 7m24s
[22:17:28.459] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:8949427836795224480:45:0)
[22:17:28.480] Build status: STARTED
[22:17:28.480] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:8949427836795224480:46:0) after 1m44s
[22:19:12.666] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:8949427836795224480:46:0)
[22:19:12.706] Build status: STARTED
[22:19:12.707] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:8949427836795224480:47:0) after 6m56s
[22:26:08.756] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:8949427836795224480:47:0)
[22:26:08.797] Build status: STARTED
[22:26:08.797] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:8949427836795224480:48:0) after 2m8s
[22:28:17.283] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:8949427836795224480:48:0)
[22:28:17.448] Build status: STARTED
[22:28:17.448] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:8949427836795224480:49:0) after 5m41s
[22:33:58.794] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:8949427836795224480:49:0)
[22:33:58.949] Build status: STARTED
[22:33:58.949] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:8949427836795224480:50:0) after 1m34s
[22:35:33.421] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:8949427836795224480:50:0)
[22:35:33.452] Build status: STARTED
[22:35:33.452] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:8949427836795224480:51:0) after 1m25s
[22:36:58.481] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:8949427836795224480:51:0)
[22:36:58.516] Build status: STARTED
[22:36:58.516] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:8949427836795224480:52:0) after 2m5s
[22:39:05.154] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:8949427836795224480:52:0)
[22:39:05.181] Build status: STARTED
[22:39:05.181] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:8949427836795224480:53:0) after 4m42s
[22:43:48.013] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:8949427836795224480:53:0)
[22:43:48.049] Build status: STARTED
[22:43:48.049] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:8949427836795224480:54:0) after 6m29s
[22:50:17.072] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:8949427836795224480:54:0)
[22:50:17.157] Build status: STARTED
[22:50:17.157] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:8949427836795224480:55:0) after 5m13s
[22:55:30.194] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:8949427836795224480:55:0)
[22:55:30.412] Build status: STARTED
[22:55:30.412] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:8949427836795224480:56:0) after 2m6s
[22:57:36.433] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:8949427836795224480:56:0)
[22:57:36.464] Build status: STARTED
[22:57:36.464] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:8949427836795224480:57:0) after 8m31s
[23:06:07.588] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:8949427836795224480:57:0)
[23:06:07.611] Build status: STARTED
[23:06:07.611] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:8949427836795224480:58:0) after 6m11s
[23:12:18.633] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:8949427836795224480:58:0)
[23:12:18.676] Build status: STARTED
[23:12:18.676] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:8949427836795224480:59:0) after 6m1s
[23:18:19.661] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:8949427836795224480:59:0)
[23:18:19.696] Build status: STARTED
[23:18:19.696] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:8949427836795224480:60:0) after 9m17s
[23:27:36.947] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:8949427836795224480:60:0)
[23:27:36.980] Build status: STARTED
[23:27:36.980] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:8949427836795224480:61:0) after 5m43s
[23:33:20.058] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:8949427836795224480:61:0)
[23:33:20.110] Build status: STARTED
[23:33:20.110] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:8949427836795224480:62:0) after 8m51s
[23:42:11.132] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:8949427836795224480:62:0)
[23:42:11.166] Build status: STARTED
[23:42:11.166] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:8949427836795224480:63:0) after 6m25s
[23:48:36.192] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:8949427836795224480:63:0)
[23:48:36.227] Build status: STARTED
[23:48:36.227] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:8949427836795224480:64:0) after 7m48s
[23:56:24.284] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:8949427836795224480:64:0)
[23:56:24.303] Build status: STARTED
[23:56:24.303] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:8949427836795224480:65:0) after 9m42s
[00:06:06.527] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:8949427836795224480:65:0)
[00:06:06.547] Build status: STARTED
[00:06:06.547] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:8949427836795224480:66:0) after 7m30s
[00:13:36.596] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:8949427836795224480:66:0)
[00:13:36.624] Build status: STARTED
[00:13:36.624] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:8949427836795224480:67:0) after 7m28s
[00:21:04.643] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:8949427836795224480:67:0)
[00:21:04.664] Build status: STARTED
[00:21:04.664] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:8949427836795224480:68:0) after 5m14s
[00:26:18.711] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:8949427836795224480:68:0)
[00:26:18.744] Build status: STARTED
[00:26:18.745] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:8949427836795224480:69:0) after 7m44s
[00:34:02.919] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:8949427836795224480:69:0)
[00:34:02.958] Build status: STARTED
[00:34:02.958] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:8949427836795224480:70:0) after 4m56s
[00:38:58.982] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:8949427836795224480:70:0)
[00:38:59.012] Build status: STARTED
[00:38:59.012] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:8949427836795224480:71:0) after 2m7s
[00:41:06.029] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:8949427836795224480:71:0)
[00:41:06.068] Build status: STARTED
[00:41:06.069] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:8949427836795224480:72:0) after 8m10s
[00:49:17.794] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:8949427836795224480:72:0)
[00:49:17.814] Build status: STARTED
[00:49:17.814] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:8949427836795224480:73:0) after 7m15s
[00:56:33.124] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:8949427836795224480:73:0)
[00:56:33.155] Build status: STARTED
[00:56:33.155] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:8949427836795224480:74:0) after 6m23s
[01:02:56.687] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:8949427836795224480:74:0)
[01:02:56.750] Build status: STARTED
[01:02:56.750] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:8949427836795224480:75:0) after 8m17s
[01:11:13.777] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:8949427836795224480:75:0)
[01:11:13.807] Build status: STARTED
[01:11:13.807] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:8949427836795224480:76:0) after 7m43s
[01:18:56.824] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:8949427836795224480:76:0)
[01:18:56.856] Build status: STARTED
[01:18:56.856] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:8949427836795224480:77:0) after 9m37s
[01:20:20.904] Received PubSub notification, asking Buildbucket for the build status
[01:20:20.935] Build:
{
  "id": "8783997774556184529",
  "builder": {
    "project": "nacl",
    "bucket": "ci",
    "builder": "linux-64-validator-opt"
  },
  "number": 347,
  "createdBy": "project:nacl",
  "createTime": "2023-04-12T18:25:49.244717756Z",
  "startTime": "2023-04-12T18:26:09.108655Z",
  "endTime": "2023-04-13T01:20:20.248486014Z",
  "updateTime": "2023-04-13T01:20:20.248486014Z",
  "status": "SUCCESS",
  "input": {
    "gitilesCommit": {
      "host": "chromium.googlesource.com",
      "project": "native_client/src/native_client",
      "id": "417e89893751ee0fea04c86edf386f1eff0e2c96",
      "ref": "refs/heads/main"
    }
  }
}
[01:20:20.935] Invocation finished in 6h54m33.209274584s with status SUCCEEDED