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

c5685872d82ea5760455f7304c680ad14abd600c (3 years ago)

Incoming properties

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

Incoming tags

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

Debug log (UTC)

[12:40:12.468] New invocation is queued and will start shortly
[12:40:14.126] Starting the invocation (attempt 1)
[12:40:14.169] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/native_client/src/native_client/+/c5685872d82ea5760455f7304c680ad14abd600c"
[12:40:14.169] Popped gitiles commit info from properties and tags
[12:40:14.169] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[12:40:14.169] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[12:40:14.169] Buildbucket request:
{
  "requestId": "9004079550041260048",
  "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": "c5685872d82ea5760455f7304c680ad14abd600c"
                            },
                        "id": "https://chromium.googlesource.com/native_client/src/native_client/+/refs/heads/master@c5685872d82ea5760455f7304c680ad14abd600c",
                        "title": "c5685872d82ea5760455f7304c680ad14abd600c",
                        "url": "https://chromium.googlesource.com/native_client/src/native_client/+/c5685872d82ea5760455f7304c680ad14abd600c"
                      }
                ]
          }
    },
  "gitilesCommit": {
    "host": "chromium.googlesource.com",
    "project": "native_client/src/native_client",
    "id": "c5685872d82ea5760455f7304c680ad14abd600c",
    "ref": "refs/heads/master"
  },
  "tags": [
    {
      "key": "scheduler_invocation_id",
      "value": "9004079550041260048"
    },
    {
      "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"
  }
}
[12:40:14.950] Scheduled build:
{
  "id": "8838649487464030608",
  "builder": {
    "project": "nacl",
    "bucket": "ci",
    "builder": "linux-64-validator-opt"
  },
  "number": 226,
  "createdBy": "project:nacl",
  "createTime": "2021-08-17T12:40:14.296841Z",
  "updateTime": "2021-08-17T12:40:14.789111Z",
  "status": "SCHEDULED",
  "input": {
    "gitilesCommit": {
      "host": "chromium.googlesource.com",
      "project": "native_client/src/native_client",
      "id": "c5685872d82ea5760455f7304c680ad14abd600c",
      "ref": "refs/heads/master"
    }
  }
}
[12:40:14.950] Task URL: https://cr-buildbucket.appspot.com/build/8838649487464030608
[12:40:14.950] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9004079550041260048:2:0) after 7m47s
[12:40:34.822] Received PubSub notification, asking Buildbucket for the build status
[12:40:34.873] Build status: STARTED
[12:48:02.072] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9004079550041260048:2:0)
[12:48:02.104] Build status: STARTED
[12:48:02.104] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9004079550041260048:4:0) after 5m50s
[12:53:52.142] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9004079550041260048:4:0)
[12:53:52.173] Build status: STARTED
[12:53:52.173] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9004079550041260048:5:0) after 6m0s
[12:59:52.244] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9004079550041260048:5:0)
[12:59:52.269] Build status: STARTED
[12:59:52.269] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9004079550041260048:6:0) after 1m20s
[13:01:12.289] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9004079550041260048:6:0)
[13:01:12.355] Build status: STARTED
[13:01:12.355] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9004079550041260048:7:0) after 8m15s
[13:09:27.403] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9004079550041260048:7:0)
[13:09:27.446] Build status: STARTED
[13:09:27.446] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9004079550041260048:8:0) after 5m6s
[13:14:33.520] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9004079550041260048:8:0)
[13:14:33.554] Build status: STARTED
[13:14:33.554] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9004079550041260048:9:0) after 6m35s
[13:21:08.648] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9004079550041260048:9:0)
[13:21:08.678] Build status: STARTED
[13:21:08.678] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9004079550041260048:10:0) after 9m13s
[13:30:21.701] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9004079550041260048:10:0)
[13:30:21.729] Build status: STARTED
[13:30:21.729] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9004079550041260048:11:0) after 3m12s
[13:33:33.794] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9004079550041260048:11:0)
[13:33:33.819] Build status: STARTED
[13:33:33.819] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9004079550041260048:12:0) after 3m40s
[13:37:13.995] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9004079550041260048:12:0)
[13:37:14.025] Build status: STARTED
[13:37:14.025] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9004079550041260048:13:0) after 8m28s
[13:45:42.116] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9004079550041260048:13:0)
[13:45:42.142] Build status: STARTED
[13:45:42.142] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9004079550041260048:14:0) after 3m45s
[13:49:27.217] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9004079550041260048:14:0)
[13:49:27.285] Build status: STARTED
[13:49:27.285] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9004079550041260048:15:0) after 1m42s
[13:51:09.461] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9004079550041260048:15:0)
[13:51:09.545] Build status: STARTED
[13:51:09.545] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9004079550041260048:16:0) after 3m52s
[13:55:01.673] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9004079550041260048:16:0)
[13:55:01.699] Build status: STARTED
[13:55:01.699] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9004079550041260048:17:0) after 5m46s
[14:00:47.716] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9004079550041260048:17:0)
[14:00:47.743] Build status: STARTED
[14:00:47.743] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9004079550041260048:18:0) after 2m11s
[14:02:58.829] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9004079550041260048:18:0)
[14:02:58.863] Build status: STARTED
[14:02:58.863] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9004079550041260048:19:0) after 3m22s
[14:06:20.878] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9004079550041260048:19:0)
[14:06:20.912] Build status: STARTED
[14:06:20.912] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9004079550041260048:20:0) after 1m35s
[14:07:55.904] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9004079550041260048:20:0)
[14:07:55.932] Build status: STARTED
[14:07:55.932] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9004079550041260048:21:0) after 4m56s
[14:12:52.378] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9004079550041260048:21:0)
[14:12:52.408] Build status: STARTED
[14:12:52.408] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9004079550041260048:22:0) after 5m0s
[14:17:52.430] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9004079550041260048:22:0)
[14:17:52.479] Build status: STARTED
[14:17:52.479] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9004079550041260048:23:0) after 2m52s
[14:20:44.730] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9004079550041260048:23:0)
[14:20:44.759] Build status: STARTED
[14:20:44.759] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9004079550041260048:24:0) after 9m26s
[14:30:10.780] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9004079550041260048:24:0)
[14:30:10.809] Build status: STARTED
[14:30:10.809] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9004079550041260048:25:0) after 4m57s
[14:35:07.830] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9004079550041260048:25:0)
[14:35:07.858] Build status: STARTED
[14:35:07.858] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9004079550041260048:26:0) after 9m17s
[14:44:24.944] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9004079550041260048:26:0)
[14:44:24.972] Build status: STARTED
[14:44:24.972] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9004079550041260048:27:0) after 1m2s
[14:45:27.093] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9004079550041260048:27:0)
[14:45:27.119] Build status: STARTED
[14:45:27.119] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9004079550041260048:28:0) after 4m17s
[14:49:44.142] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9004079550041260048:28:0)
[14:49:44.205] Build status: STARTED
[14:49:44.205] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9004079550041260048:29:0) after 7m0s
[14:56:44.188] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9004079550041260048:29:0)
[14:56:44.227] Build status: STARTED
[14:56:44.227] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9004079550041260048:30:0) after 6m56s
[15:03:40.239] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9004079550041260048:30:0)
[15:03:40.266] Build status: STARTED
[15:03:40.266] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9004079550041260048:31:0) after 2m42s
[15:06:22.583] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9004079550041260048:31:0)
[15:06:22.616] Build status: STARTED
[15:06:22.616] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9004079550041260048:32:0) after 6m16s
[15:12:38.636] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9004079550041260048:32:0)
[15:12:38.679] Build status: STARTED
[15:12:38.679] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9004079550041260048:33:0) after 2m25s
[15:15:03.710] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9004079550041260048:33:0)
[15:15:03.741] Build status: STARTED
[15:15:03.741] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9004079550041260048:34:0) after 8m29s
[15:23:32.761] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9004079550041260048:34:0)
[15:23:32.810] Build status: STARTED
[15:23:32.810] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9004079550041260048:35:0) after 4m59s
[15:28:31.826] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9004079550041260048:35:0)
[15:28:31.853] Build status: STARTED
[15:28:31.853] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9004079550041260048:36:0) after 9m44s
[15:38:15.935] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9004079550041260048:36:0)
[15:38:16.279] Build status: STARTED
[15:38:16.279] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9004079550041260048:37:0) after 1m44s
[15:40:00.535] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9004079550041260048:37:0)
[15:40:00.574] Build status: STARTED
[15:40:00.574] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9004079550041260048:38:0) after 7m35s
[15:47:35.595] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9004079550041260048:38:0)
[15:47:35.621] Build status: STARTED
[15:47:35.621] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9004079550041260048:39:0) after 4m47s
[15:52:22.648] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9004079550041260048:39:0)
[15:52:22.679] Build status: STARTED
[15:52:22.679] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9004079550041260048:40:0) after 1m20s
[15:53:42.805] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9004079550041260048:40:0)
[15:53:42.862] Build status: STARTED
[15:53:42.862] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9004079550041260048:41:0) after 2m35s
[15:56:17.889] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9004079550041260048:41:0)
[15:56:17.980] Build status: STARTED
[15:56:17.980] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9004079550041260048:42:0) after 8m53s
[16:05:11.119] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9004079550041260048:42:0)
[16:05:11.150] Build status: STARTED
[16:05:11.150] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9004079550041260048:43:0) after 7m33s
[16:12:44.525] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9004079550041260048:43:0)
[16:12:44.552] Build status: STARTED
[16:12:44.552] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9004079550041260048:44:0) after 4m53s
[16:17:37.630] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9004079550041260048:44:0)
[16:17:37.666] Build status: STARTED
[16:17:37.666] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9004079550041260048:45:0) after 5m48s
[16:23:25.685] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9004079550041260048:45:0)
[16:23:25.712] Build status: STARTED
[16:23:25.712] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9004079550041260048:46:0) after 5m20s
[16:28:45.844] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9004079550041260048:46:0)
[16:28:45.885] Build status: STARTED
[16:28:45.885] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9004079550041260048:47:0) after 3m43s
[16:32:29.066] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9004079550041260048:47:0)
[16:32:29.096] Build status: STARTED
[16:32:29.096] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9004079550041260048:48:0) after 1m55s
[16:34:24.115] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9004079550041260048:48:0)
[16:34:24.142] Build status: STARTED
[16:34:24.142] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9004079550041260048:49:0) after 8m51s
[16:43:15.523] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9004079550041260048:49:0)
[16:43:15.558] Build status: STARTED
[16:43:15.558] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9004079550041260048:50:0) after 2m15s
[16:45:30.581] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9004079550041260048:50:0)
[16:45:30.631] Build status: STARTED
[16:45:30.631] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9004079550041260048:51:0) after 1m2s
[16:46:32.693] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9004079550041260048:51:0)
[16:46:32.726] Build status: STARTED
[16:46:32.726] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9004079550041260048:52:0) after 7m43s
[16:54:15.747] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9004079550041260048:52:0)
[16:54:15.787] Build status: STARTED
[16:54:15.787] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9004079550041260048:53:0) after 5m20s
[16:59:35.893] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9004079550041260048:53:0)
[16:59:35.922] Build status: STARTED
[16:59:35.922] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9004079550041260048:54:0) after 8m6s
[17:07:41.946] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9004079550041260048:54:0)
[17:07:42.025] Build status: STARTED
[17:07:42.025] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9004079550041260048:55:0) after 1m14s
[17:08:56.139] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9004079550041260048:55:0)
[17:08:56.172] Build status: STARTED
[17:08:56.172] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9004079550041260048:56:0) after 2m9s
[17:11:05.453] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9004079550041260048:56:0)
[17:11:05.488] Build status: STARTED
[17:11:05.488] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9004079550041260048:57:0) after 9m22s
[17:20:28.052] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9004079550041260048:57:0)
[17:20:28.083] Build status: STARTED
[17:20:28.083] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9004079550041260048:58:0) after 5m5s
[17:25:33.088] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9004079550041260048:58:0)
[17:25:33.145] Build status: STARTED
[17:25:33.145] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9004079550041260048:59:0) after 6m49s
[17:32:22.528] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9004079550041260048:59:0)
[17:32:22.570] Build status: STARTED
[17:32:22.570] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9004079550041260048:60:0) after 7m54s
[17:40:16.702] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9004079550041260048:60:0)
[17:40:16.860] Build status: STARTED
[17:40:16.860] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9004079550041260048:61:0) after 5m42s
[17:45:58.877] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9004079550041260048:61:0)
[17:45:58.918] Build status: STARTED
[17:45:58.918] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9004079550041260048:62:0) after 2m52s
[17:48:50.994] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9004079550041260048:62:0)
[17:48:51.025] Build status: STARTED
[17:48:51.025] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9004079550041260048:63:0) after 7m6s
[17:55:57.208] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9004079550041260048:63:0)
[17:55:57.235] Build status: STARTED
[17:55:57.235] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9004079550041260048:64:0) after 3m2s
[17:58:59.255] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9004079550041260048:64:0)
[17:58:59.284] Build status: STARTED
[17:58:59.284] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9004079550041260048:65:0) after 3m24s
[18:02:23.405] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9004079550041260048:65:0)
[18:02:23.435] Build status: STARTED
[18:02:23.435] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9004079550041260048:66:0) after 7m54s
[18:10:17.456] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9004079550041260048:66:0)
[18:10:17.553] Build status: STARTED
[18:10:17.553] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9004079550041260048:67:0) after 6m37s
[18:16:54.580] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9004079550041260048:67:0)
[18:16:54.625] Build status: STARTED
[18:16:54.625] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9004079550041260048:68:0) after 8m13s
[18:25:08.243] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9004079550041260048:68:0)
[18:25:08.283] Build status: STARTED
[18:25:08.283] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9004079550041260048:69:0) after 6m20s
[18:31:28.309] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9004079550041260048:69:0)
[18:31:28.337] Build status: STARTED
[18:31:28.337] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9004079550041260048:70:0) after 5m50s
[18:37:18.390] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9004079550041260048:70:0)
[18:37:18.559] Build status: STARTED
[18:37:18.559] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9004079550041260048:71:0) after 6m18s
[18:43:36.683] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9004079550041260048:71:0)
[18:43:36.718] Build status: STARTED
[18:43:36.718] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9004079550041260048:72:0) after 3m9s
[18:46:46.801] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9004079550041260048:72:0)
[18:46:46.830] Build status: STARTED
[18:46:46.830] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9004079550041260048:73:0) after 2m9s
[18:48:55.919] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9004079550041260048:73:0)
[18:48:55.950] Build status: STARTED
[18:48:55.950] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9004079550041260048:74:0) after 9m31s
[18:58:26.978] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9004079550041260048:74:0)
[18:58:27.007] Build status: STARTED
[18:58:27.007] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9004079550041260048:75:0) after 6m40s
[19:05:07.089] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9004079550041260048:75:0)
[19:05:07.124] Build status: STARTED
[19:05:07.124] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9004079550041260048:76:0) after 5m41s
[19:10:48.333] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9004079550041260048:76:0)
[19:10:48.365] Build status: STARTED
[19:10:48.365] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9004079550041260048:77:0) after 9m37s
[19:20:25.615] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9004079550041260048:77:0)
[19:20:25.644] Build status: STARTED
[19:20:25.644] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9004079550041260048:78:0) after 8m23s
[19:28:48.930] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9004079550041260048:78:0)
[19:28:48.958] Build status: STARTED
[19:28:48.958] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9004079550041260048:79:0) after 6m8s
[19:34:56.981] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9004079550041260048:79:0)
[19:34:57.008] Build status: STARTED
[19:34:57.008] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9004079550041260048:80:0) after 2m11s
[19:37:08.052] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9004079550041260048:80:0)
[19:37:08.092] Build status: STARTED
[19:37:08.092] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9004079550041260048:81:0) after 4m47s
[19:41:55.113] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9004079550041260048:81:0)
[19:41:55.144] Build status: STARTED
[19:41:55.144] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9004079550041260048:82:0) after 4m25s
[19:46:20.346] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9004079550041260048:82:0)
[19:46:20.425] Build status: STARTED
[19:46:20.425] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9004079550041260048:83:0) after 4m58s
[19:51:18.684] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9004079550041260048:83:0)
[19:51:18.726] Build status: STARTED
[19:51:18.726] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9004079550041260048:84:0) after 5m22s
[19:56:40.749] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9004079550041260048:84:0)
[19:56:40.776] Build status: STARTED
[19:56:40.776] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9004079550041260048:85:0) after 8m33s
[20:05:13.862] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9004079550041260048:85:0)
[20:05:13.916] Build status: STARTED
[20:05:13.916] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9004079550041260048:86:0) after 7m21s
[20:12:35.334] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9004079550041260048:86:0)
[20:12:35.364] Build status: STARTED
[20:12:35.364] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9004079550041260048:87:0) after 6m1s
[20:18:36.388] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9004079550041260048:87:0)
[20:18:36.422] Build status: STARTED
[20:18:36.423] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9004079550041260048:88:0) after 1m48s
[20:20:24.674] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9004079550041260048:88:0)
[20:20:24.708] Build status: STARTED
[20:20:24.708] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9004079550041260048:89:0) after 5m43s
[20:26:07.755] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9004079550041260048:89:0)
[20:26:07.788] Build status: STARTED
[20:26:07.788] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9004079550041260048:90:0) after 3m20s
[20:29:27.815] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9004079550041260048:90:0)
[20:29:27.856] Build status: STARTED
[20:29:27.856] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9004079550041260048:91:0) after 1m48s
[20:31:16.410] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9004079550041260048:91:0)
[20:31:16.453] Build status: STARTED
[20:31:16.453] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9004079550041260048:92:0) after 3m10s
[20:34:26.517] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9004079550041260048:92:0)
[20:34:26.559] Build status: STARTED
[20:34:26.559] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9004079550041260048:93:0) after 9m58s
[20:44:24.769] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9004079550041260048:93:0)
[20:44:24.797] Build status: STARTED
[20:44:24.797] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9004079550041260048:94:0) after 5m30s
[20:49:54.850] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9004079550041260048:94:0)
[20:49:54.887] Build status: STARTED
[20:49:54.887] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9004079550041260048:95:0) after 7m31s
[20:57:26.192] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9004079550041260048:95:0)
[20:57:26.240] Build status: STARTED
[20:57:26.240] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9004079550041260048:96:0) after 4m29s
[21:01:55.389] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9004079550041260048:96:0)
[21:01:55.427] Build status: STARTED
[21:01:55.428] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9004079550041260048:97:0) after 4m29s
[21:06:24.536] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9004079550041260048:97:0)
[21:06:24.577] Build status: STARTED
[21:06:24.577] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9004079550041260048:98:0) after 7m23s
[21:13:47.619] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9004079550041260048:98:0)
[21:13:47.646] Build status: STARTED
[21:13:47.646] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9004079550041260048:99:0) after 9m30s
[21:23:17.762] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9004079550041260048:99:0)
[21:23:17.808] Build status: STARTED
[21:23:17.808] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9004079550041260048:100:0) after 9m27s
[21:32:44.802] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9004079550041260048:100:0)
[21:32:44.857] Build status: STARTED
[21:32:44.857] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9004079550041260048:101:0) after 9m27s
[21:42:11.861] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9004079550041260048:101:0)
[21:42:11.895] Build status: STARTED
[21:42:11.895] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9004079550041260048:102:0) after 4m35s
[21:46:46.929] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9004079550041260048:102:0)
[21:46:46.971] Build status: STARTED
[21:46:46.971] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9004079550041260048:103:0) after 2m55s
[21:49:42.085] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9004079550041260048:103:0)
[21:49:42.115] Build status: STARTED
[21:49:42.115] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9004079550041260048:104:0) after 6m32s
[21:54:36.724] Received PubSub notification, asking Buildbucket for the build status
[21:54:36.756] Build:
{
  "id": "8838649487464030608",
  "builder": {
    "project": "nacl",
    "bucket": "ci",
    "builder": "linux-64-validator-opt"
  },
  "number": 226,
  "createdBy": "project:nacl",
  "createTime": "2021-08-17T12:40:14.296841Z",
  "startTime": "2021-08-17T12:40:33.881774Z",
  "endTime": "2021-08-17T21:54:35.801291Z",
  "updateTime": "2021-08-17T21:54:36.515852Z",
  "status": "SUCCESS",
  "input": {
    "gitilesCommit": {
      "host": "chromium.googlesource.com",
      "project": "native_client/src/native_client",
      "id": "c5685872d82ea5760455f7304c680ad14abd600c",
      "ref": "refs/heads/master"
    }
  }
}
[21:54:36.756] Invocation finished in 9h14m24.302027245s with status SUCCEEDED