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

Status: SUCCEEDED

Triggered by: -

Duration: 9 hours

Actions:

Definition (rev 4a2f121d23f9adfa08cce385d9356b05a0d1b7b6)

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

Incoming triggers

55656f56c1e0dfdc73ff624f002257c346be8587 (3 years ago)

Incoming properties

{
  "branch": "refs/heads/master",
  "repository": "https://chromium.googlesource.com/native_client/src/native_client",
  "revision": "55656f56c1e0dfdc73ff624f002257c346be8587"
}

Incoming tags

buildset:commit/gitiles/chromium.googlesource.com/native_client/src/native_client/+/55656f56c1e0dfdc73ff624f002257c346be8587
gitiles_ref:refs/heads/master

Debug log (UTC)

[22:28:42.825] New invocation is queued and will start shortly
[22:28:44.041] Starting the invocation (attempt 1)
[22:28:44.075] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/native_client/src/native_client/+/55656f56c1e0dfdc73ff624f002257c346be8587"
[22:28:44.075] Popped gitiles commit info from properties and tags
[22:28:44.075] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[22:28:44.075] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[22:28:44.076] Buildbucket request:
{
  "requestId": "9005310881979859200",
  "builder": {
    "project": "nacl",
    "bucket": "ci",
    "builder": "linux-64-validator-opt"
  },
  "properties": {
      "$recipe_engine/scheduler": {
            "hostname": "luci-scheduler.appspot.com",
            "triggers": [
                  {
                        "gitiles": {
                              "ref": "refs/heads/master",
                              "repo": "https://chromium.googlesource.com/native_client/src/native_client",
                              "revision": "55656f56c1e0dfdc73ff624f002257c346be8587"
                            },
                        "id": "https://chromium.googlesource.com/native_client/src/native_client/+/refs/heads/master@55656f56c1e0dfdc73ff624f002257c346be8587",
                        "title": "55656f56c1e0dfdc73ff624f002257c346be8587",
                        "url": "https://chromium.googlesource.com/native_client/src/native_client/+/55656f56c1e0dfdc73ff624f002257c346be8587"
                      }
                ]
          }
    },
  "gitilesCommit": {
    "host": "chromium.googlesource.com",
    "project": "native_client/src/native_client",
    "id": "55656f56c1e0dfdc73ff624f002257c346be8587",
    "ref": "refs/heads/master"
  },
  "tags": [
    {
      "key": "scheduler_invocation_id",
      "value": "9005310881979859200"
    },
    {
      "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"
  }
}
[22:28:44.536] Scheduled build:
{
  "id": "8839880819915867040",
  "builder": {
    "project": "nacl",
    "bucket": "ci",
    "builder": "linux-64-validator-opt"
  },
  "number": 222,
  "createdBy": "project:nacl",
  "createTime": "2021-08-03T22:28:44.162148Z",
  "updateTime": "2021-08-03T22:28:44.469526Z",
  "status": "SCHEDULED",
  "input": {
    "gitilesCommit": {
      "host": "chromium.googlesource.com",
      "project": "native_client/src/native_client",
      "id": "55656f56c1e0dfdc73ff624f002257c346be8587",
      "ref": "refs/heads/master"
    }
  }
}
[22:28:44.536] Task URL: https://cr-buildbucket.appspot.com/build/8839880819915867040
[22:28:44.536] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9005310881979859200:2:0) after 7m43s
[22:28:59.120] Received PubSub notification, asking Buildbucket for the build status
[22:28:59.157] Build status: STARTED
[22:36:27.559] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9005310881979859200:2:0)
[22:36:27.597] Build status: STARTED
[22:36:27.597] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9005310881979859200:4:0) after 6m30s
[22:42:57.615] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9005310881979859200:4:0)
[22:42:57.655] Build status: STARTED
[22:42:57.655] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9005310881979859200:5:0) after 7m36s
[22:50:33.674] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9005310881979859200:5:0)
[22:50:33.705] Build status: STARTED
[22:50:33.705] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9005310881979859200:6:0) after 4m47s
[22:55:21.147] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9005310881979859200:6:0)
[22:55:21.183] Build status: STARTED
[22:55:21.183] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9005310881979859200:7:0) after 6m47s
[23:02:08.186] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9005310881979859200:7:0)
[23:02:08.222] Build status: STARTED
[23:02:08.222] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9005310881979859200:8:0) after 3m47s
[23:05:55.425] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9005310881979859200:8:0)
[23:05:55.474] Build status: STARTED
[23:05:55.474] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9005310881979859200:9:0) after 7m11s
[23:13:06.756] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9005310881979859200:9:0)
[23:13:06.789] Build status: STARTED
[23:13:06.789] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9005310881979859200:10:0) after 5m0s
[23:18:07.365] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9005310881979859200:10:0)
[23:18:07.400] Build status: STARTED
[23:18:07.400] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9005310881979859200:11:0) after 7m6s
[23:25:13.426] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9005310881979859200:11:0)
[23:25:13.453] Build status: STARTED
[23:25:13.453] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9005310881979859200:12:0) after 8m43s
[23:33:56.473] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9005310881979859200:12:0)
[23:33:56.596] Build status: STARTED
[23:33:56.596] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9005310881979859200:13:0) after 5m25s
[23:39:21.991] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9005310881979859200:13:0)
[23:39:22.097] Build status: STARTED
[23:39:22.097] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9005310881979859200:14:0) after 8m20s
[23:47:42.571] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9005310881979859200:14:0)
[23:47:42.602] Build status: STARTED
[23:47:42.602] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9005310881979859200:15:0) after 6m15s
[23:53:58.223] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9005310881979859200:15:0)
[23:53:58.253] Build status: STARTED
[23:53:58.253] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9005310881979859200:16:0) after 1m41s
[23:55:39.280] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9005310881979859200:16:0)
[23:55:39.307] Build status: STARTED
[23:55:39.307] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9005310881979859200:17:0) after 9m35s
[00:05:14.331] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9005310881979859200:17:0)
[00:05:14.355] Build status: STARTED
[00:05:14.355] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9005310881979859200:18:0) after 6m17s
[00:11:31.494] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9005310881979859200:18:0)
[00:11:31.577] Build status: STARTED
[00:11:31.577] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9005310881979859200:19:0) after 1m19s
[00:12:50.594] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9005310881979859200:19:0)
[00:12:50.623] Build status: STARTED
[00:12:50.623] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9005310881979859200:20:0) after 8m13s
[00:21:03.645] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9005310881979859200:20:0)
[00:21:03.679] Build status: STARTED
[00:21:03.679] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9005310881979859200:21:0) after 4m55s
[00:25:58.700] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9005310881979859200:21:0)
[00:25:58.732] Build status: STARTED
[00:25:58.732] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9005310881979859200:22:0) after 7m19s
[00:33:17.765] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9005310881979859200:22:0)
[00:33:17.798] Build status: STARTED
[00:33:17.799] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9005310881979859200:23:0) after 6m12s
[00:39:29.860] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9005310881979859200:23:0)
[00:39:29.895] Build status: STARTED
[00:39:29.895] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9005310881979859200:24:0) after 5m55s
[00:45:25.208] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9005310881979859200:24:0)
[00:45:25.238] Build status: STARTED
[00:45:25.238] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9005310881979859200:25:0) after 6m8s
[00:51:33.429] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9005310881979859200:25:0)
[00:51:33.458] Build status: STARTED
[00:51:33.458] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9005310881979859200:26:0) after 4m56s
[00:56:29.653] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9005310881979859200:26:0)
[00:56:29.682] Build status: STARTED
[00:56:29.682] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9005310881979859200:27:0) after 7m41s
[01:04:11.603] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9005310881979859200:27:0)
[01:04:11.635] Build status: STARTED
[01:04:11.635] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9005310881979859200:28:0) after 9m39s
[01:13:50.987] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9005310881979859200:28:0)
[01:13:51.018] Build status: STARTED
[01:13:51.018] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9005310881979859200:29:0) after 1m13s
[01:15:04.301] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9005310881979859200:29:0)
[01:15:04.530] Build status: STARTED
[01:15:04.530] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9005310881979859200:30:0) after 1m41s
[01:16:45.906] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9005310881979859200:30:0)
[01:16:45.945] Build status: STARTED
[01:16:45.945] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9005310881979859200:31:0) after 8m54s
[01:25:40.215] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9005310881979859200:31:0)
[01:25:40.297] Build status: STARTED
[01:25:40.297] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9005310881979859200:32:0) after 7m58s
[01:33:38.374] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9005310881979859200:32:0)
[01:33:38.415] Build status: STARTED
[01:33:38.415] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9005310881979859200:33:0) after 1m20s
[01:34:58.479] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9005310881979859200:33:0)
[01:34:58.510] Build status: STARTED
[01:34:58.510] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9005310881979859200:34:0) after 1m53s
[01:36:51.534] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9005310881979859200:34:0)
[01:36:51.563] Build status: STARTED
[01:36:51.563] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9005310881979859200:35:0) after 8m56s
[01:45:47.713] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9005310881979859200:35:0)
[01:45:47.749] Build status: STARTED
[01:45:47.749] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9005310881979859200:36:0) after 3m3s
[01:48:50.859] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9005310881979859200:36:0)
[01:48:50.889] Build status: STARTED
[01:48:50.889] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9005310881979859200:37:0) after 1m1s
[01:49:52.010] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9005310881979859200:37:0)
[01:49:52.056] Build status: STARTED
[01:49:52.056] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9005310881979859200:38:0) after 7m33s
[01:57:25.398] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9005310881979859200:38:0)
[01:57:25.426] Build status: STARTED
[01:57:25.426] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9005310881979859200:39:0) after 2m9s
[01:59:34.544] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9005310881979859200:39:0)
[01:59:34.572] Build status: STARTED
[01:59:34.572] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9005310881979859200:40:0) after 1m28s
[02:01:03.296] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9005310881979859200:40:0)
[02:01:03.331] Build status: STARTED
[02:01:03.331] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9005310881979859200:41:0) after 3m45s
[02:04:48.452] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9005310881979859200:41:0)
[02:04:48.491] Build status: STARTED
[02:04:48.491] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9005310881979859200:42:0) after 5m14s
[02:10:02.815] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9005310881979859200:42:0)
[02:10:02.848] Build status: STARTED
[02:10:02.848] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9005310881979859200:43:0) after 2m44s
[02:12:47.563] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9005310881979859200:43:0)
[02:12:47.594] Build status: STARTED
[02:12:47.594] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9005310881979859200:44:0) after 6m57s
[02:19:44.681] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9005310881979859200:44:0)
[02:19:44.756] Build status: STARTED
[02:19:44.756] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9005310881979859200:45:0) after 1m4s
[02:20:48.823] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9005310881979859200:45:0)
[02:20:48.896] Build status: STARTED
[02:20:48.896] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9005310881979859200:46:0) after 9m46s
[02:30:34.922] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9005310881979859200:46:0)
[02:30:34.956] Build status: STARTED
[02:30:34.956] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9005310881979859200:47:0) after 8m18s
[02:38:52.983] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9005310881979859200:47:0)
[02:38:53.012] Build status: STARTED
[02:38:53.012] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9005310881979859200:48:0) after 7m29s
[02:46:22.250] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9005310881979859200:48:0)
[02:46:22.282] Build status: STARTED
[02:46:22.282] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9005310881979859200:49:0) after 4m31s
[02:50:53.502] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9005310881979859200:49:0)
[02:50:53.532] Build status: STARTED
[02:50:53.532] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9005310881979859200:50:0) after 5m22s
[02:56:15.709] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9005310881979859200:50:0)
[02:56:15.741] Build status: STARTED
[02:56:15.741] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9005310881979859200:51:0) after 4m27s
[03:00:42.839] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9005310881979859200:51:0)
[03:00:42.872] Build status: STARTED
[03:00:42.872] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9005310881979859200:52:0) after 5m30s
[03:06:12.947] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9005310881979859200:52:0)
[03:06:12.988] Build status: STARTED
[03:06:12.988] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9005310881979859200:53:0) after 1m23s
[03:07:35.990] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9005310881979859200:53:0)
[03:07:36.030] Build status: STARTED
[03:07:36.030] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9005310881979859200:54:0) after 7m55s
[03:15:31.047] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9005310881979859200:54:0)
[03:15:31.082] Build status: STARTED
[03:15:31.082] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9005310881979859200:55:0) after 5m5s
[03:20:36.280] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9005310881979859200:55:0)
[03:20:36.308] Build status: STARTED
[03:20:36.308] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9005310881979859200:56:0) after 9m45s
[03:30:21.541] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9005310881979859200:56:0)
[03:30:21.569] Build status: STARTED
[03:30:21.569] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9005310881979859200:57:0) after 4m33s
[03:34:54.690] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9005310881979859200:57:0)
[03:34:54.716] Build status: STARTED
[03:34:54.716] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9005310881979859200:58:0) after 7m47s
[03:42:41.834] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9005310881979859200:58:0)
[03:42:41.872] Build status: STARTED
[03:42:41.872] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9005310881979859200:59:0) after 2m38s
[03:45:19.901] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9005310881979859200:59:0)
[03:45:19.935] Build status: STARTED
[03:45:19.935] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9005310881979859200:60:0) after 9m32s
[03:54:52.012] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9005310881979859200:60:0)
[03:54:52.043] Build status: STARTED
[03:54:52.043] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9005310881979859200:61:0) after 8m59s
[04:03:51.223] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9005310881979859200:61:0)
[04:03:51.269] Build status: STARTED
[04:03:51.269] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9005310881979859200:62:0) after 3m3s
[04:06:54.547] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9005310881979859200:62:0)
[04:06:54.576] Build status: STARTED
[04:06:54.576] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9005310881979859200:63:0) after 2m49s
[04:09:43.597] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9005310881979859200:63:0)
[04:09:43.628] Build status: STARTED
[04:09:43.628] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9005310881979859200:64:0) after 1m1s
[04:10:44.789] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9005310881979859200:64:0)
[04:10:44.819] Build status: STARTED
[04:10:44.819] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9005310881979859200:65:0) after 7m3s
[04:17:47.843] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9005310881979859200:65:0)
[04:17:47.873] Build status: STARTED
[04:17:47.873] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9005310881979859200:66:0) after 2m13s
[04:20:01.144] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9005310881979859200:66:0)
[04:20:01.173] Build status: STARTED
[04:20:01.173] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9005310881979859200:67:0) after 3m31s
[04:23:32.194] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9005310881979859200:67:0)
[04:23:32.264] Build status: STARTED
[04:23:32.264] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9005310881979859200:68:0) after 1m38s
[04:25:10.420] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9005310881979859200:68:0)
[04:25:10.450] Build status: STARTED
[04:25:10.450] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9005310881979859200:69:0) after 7m8s
[04:32:18.426] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9005310881979859200:69:0)
[04:32:18.460] Build status: STARTED
[04:32:18.460] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9005310881979859200:70:0) after 2m59s
[04:35:17.555] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9005310881979859200:70:0)
[04:35:17.628] Build status: STARTED
[04:35:17.628] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9005310881979859200:71:0) after 9m24s
[04:44:41.762] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9005310881979859200:71:0)
[04:44:41.794] Build status: STARTED
[04:44:41.794] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9005310881979859200:72:0) after 4m16s
[04:48:57.924] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9005310881979859200:72:0)
[04:48:57.956] Build status: STARTED
[04:48:57.957] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9005310881979859200:73:0) after 4m40s
[04:53:38.039] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9005310881979859200:73:0)
[04:53:38.066] Build status: STARTED
[04:53:38.066] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9005310881979859200:74:0) after 5m28s
[04:59:06.188] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9005310881979859200:74:0)
[04:59:06.218] Build status: STARTED
[04:59:06.218] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9005310881979859200:75:0) after 9m50s
[05:08:56.281] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9005310881979859200:75:0)
[05:08:56.308] Build status: STARTED
[05:08:56.308] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9005310881979859200:76:0) after 6m15s
[05:15:11.469] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9005310881979859200:76:0)
[05:15:11.498] Build status: STARTED
[05:15:11.498] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9005310881979859200:77:0) after 3m26s
[05:18:37.630] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9005310881979859200:77:0)
[05:18:37.659] Build status: STARTED
[05:18:37.659] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9005310881979859200:78:0) after 2m7s
[05:20:44.701] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9005310881979859200:78:0)
[05:20:44.733] Build status: STARTED
[05:20:44.733] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9005310881979859200:79:0) after 8m0s
[05:28:44.858] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9005310881979859200:79:0)
[05:28:44.887] Build status: STARTED
[05:28:44.887] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9005310881979859200:80:0) after 3m31s
[05:32:15.985] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9005310881979859200:80:0)
[05:32:16.021] Build status: STARTED
[05:32:16.021] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9005310881979859200:81:0) after 4m48s
[05:37:04.060] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9005310881979859200:81:0)
[05:37:04.093] Build status: STARTED
[05:37:04.093] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9005310881979859200:82:0) after 2m38s
[05:39:42.135] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9005310881979859200:82:0)
[05:39:42.167] Build status: STARTED
[05:39:42.167] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9005310881979859200:83:0) after 1m49s
[05:41:31.276] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9005310881979859200:83:0)
[05:41:31.306] Build status: STARTED
[05:41:31.306] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9005310881979859200:84:0) after 5m11s
[05:46:42.335] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9005310881979859200:84:0)
[05:46:42.371] Build status: STARTED
[05:46:42.371] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9005310881979859200:85:0) after 9m51s
[05:56:33.391] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9005310881979859200:85:0)
[05:56:33.420] Build status: STARTED
[05:56:33.420] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9005310881979859200:86:0) after 5m32s
[06:02:05.469] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9005310881979859200:86:0)
[06:02:05.501] Build status: STARTED
[06:02:05.501] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9005310881979859200:87:0) after 3m40s
[06:05:45.772] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9005310881979859200:87:0)
[06:05:45.803] Build status: STARTED
[06:05:45.803] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9005310881979859200:88:0) after 4m57s
[06:10:42.789] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9005310881979859200:88:0)
[06:10:42.816] Build status: STARTED
[06:10:42.816] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9005310881979859200:89:0) after 2m26s
[06:13:08.831] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9005310881979859200:89:0)
[06:13:08.864] Build status: STARTED
[06:13:08.864] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9005310881979859200:90:0) after 4m36s
[06:17:44.894] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9005310881979859200:90:0)
[06:17:44.924] Build status: STARTED
[06:17:44.924] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9005310881979859200:91:0) after 9m2s
[06:26:47.057] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9005310881979859200:91:0)
[06:26:47.097] Build status: STARTED
[06:26:47.097] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9005310881979859200:92:0) after 7m1s
[06:33:48.123] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9005310881979859200:92:0)
[06:33:48.160] Build status: STARTED
[06:33:48.160] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9005310881979859200:93:0) after 3m3s
[06:36:51.188] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9005310881979859200:93:0)
[06:36:51.216] Build status: STARTED
[06:36:51.216] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9005310881979859200:94:0) after 1m44s
[06:38:35.442] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9005310881979859200:94:0)
[06:38:35.470] Build status: STARTED
[06:38:35.470] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9005310881979859200:95:0) after 7m3s
[06:45:38.566] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9005310881979859200:95:0)
[06:45:38.601] Build status: STARTED
[06:45:38.601] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9005310881979859200:96:0) after 2m3s
[06:47:41.731] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9005310881979859200:96:0)
[06:47:41.768] Build status: STARTED
[06:47:41.768] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9005310881979859200:97:0) after 6m35s
[06:54:16.808] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9005310881979859200:97:0)
[06:54:16.852] Build status: STARTED
[06:54:16.852] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9005310881979859200:98:0) after 7m2s
[07:01:18.877] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9005310881979859200:98:0)
[07:01:18.912] Build status: STARTED
[07:01:18.912] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9005310881979859200:99:0) after 5m36s
[07:06:55.008] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9005310881979859200:99:0)
[07:06:55.135] Build status: STARTED
[07:06:55.135] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9005310881979859200:100:0) after 2m43s
[07:09:38.143] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9005310881979859200:100:0)
[07:09:38.200] Build status: STARTED
[07:09:38.200] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9005310881979859200:101:0) after 3m42s
[07:13:20.227] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9005310881979859200:101:0)
[07:13:20.257] Build status: STARTED
[07:13:20.257] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9005310881979859200:102:0) after 8m15s
[07:21:35.413] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9005310881979859200:102:0)
[07:21:35.445] Build status: STARTED
[07:21:35.445] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9005310881979859200:103:0) after 5m22s
[07:26:57.496] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9005310881979859200:103:0)
[07:26:57.532] Build status: STARTED
[07:26:57.532] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9005310881979859200:104:0) after 1m5s
[07:28:02.789] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9005310881979859200:104:0)
[07:28:02.820] Build status: STARTED
[07:28:02.820] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9005310881979859200:105:0) after 2m32s
[07:30:34.927] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9005310881979859200:105:0)
[07:30:34.964] Build status: STARTED
[07:30:34.964] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9005310881979859200:106:0) after 6m59s
[07:37:33.990] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9005310881979859200:106:0)
[07:37:34.015] Build status: STARTED
[07:37:34.016] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9005310881979859200:107:0) after 9m8s
[07:46:42.461] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9005310881979859200:107:0)
[07:46:42.488] Build status: STARTED
[07:46:42.488] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9005310881979859200:108:0) after 6m14s
[07:52:56.528] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9005310881979859200:108:0)
[07:52:56.560] Build status: STARTED
[07:52:56.560] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9005310881979859200:109:0) after 7m13s
[08:00:09.581] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9005310881979859200:109:0)
[08:00:10.471] Build status: STARTED
[08:00:10.471] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9005310881979859200:110:0) after 1m53s
[08:02:03.717] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9005310881979859200:110:0)
[08:02:03.756] Build status: STARTED
[08:02:03.756] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9005310881979859200:111:0) after 6m32s
[08:08:35.877] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9005310881979859200:111:0)
[08:08:35.907] Build status: STARTED
[08:08:35.907] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9005310881979859200:112:0) after 6m41s
[08:15:17.065] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9005310881979859200:112:0)
[08:15:17.099] Build status: STARTED
[08:15:17.099] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9005310881979859200:113:0) after 5m28s
[08:20:45.265] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9005310881979859200:113:0)
[08:20:45.300] Build status: STARTED
[08:20:45.300] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9005310881979859200:114:0) after 3m13s
[08:21:59.318] Received PubSub notification, asking Buildbucket for the build status
[08:21:59.349] Build:
{
  "id": "8839880819915867040",
  "builder": {
    "project": "nacl",
    "bucket": "ci",
    "builder": "linux-64-validator-opt"
  },
  "number": 222,
  "createdBy": "project:nacl",
  "createTime": "2021-08-03T22:28:44.162148Z",
  "startTime": "2021-08-03T22:28:58.250740Z",
  "endTime": "2021-08-04T08:21:58.643847Z",
  "updateTime": "2021-08-04T08:21:58.921864Z",
  "status": "SUCCESS",
  "input": {
    "gitilesCommit": {
      "host": "chromium.googlesource.com",
      "project": "native_client/src/native_client",
      "id": "55656f56c1e0dfdc73ff624f002257c346be8587",
      "ref": "refs/heads/master"
    }
  }
}
[08:21:59.349] Invocation finished in 9h53m16.539572502s with status SUCCEEDED