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

3b97fe83377a2034b2aa4dd34164da2e6c0df1c1 (3 years ago)

Incoming properties

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

Incoming tags

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

Debug log (UTC)

[15:53:30.508] New invocation is queued and will start shortly
[15:53:31.633] Starting the invocation (attempt 1)
[15:53:31.681] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/native_client/src/native_client/+/3b97fe83377a2034b2aa4dd34164da2e6c0df1c1"
[15:53:31.681] Popped gitiles commit info from properties and tags
[15:53:31.681] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[15:53:31.681] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[15:53:31.682] Buildbucket request:
{
  "requestId": "9012402309526748160",
  "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": "3b97fe83377a2034b2aa4dd34164da2e6c0df1c1"
                            },
                        "id": "https://chromium.googlesource.com/native_client/src/native_client/+/refs/heads/master@3b97fe83377a2034b2aa4dd34164da2e6c0df1c1",
                        "title": "3b97fe83377a2034b2aa4dd34164da2e6c0df1c1",
                        "url": "https://chromium.googlesource.com/native_client/src/native_client/+/3b97fe83377a2034b2aa4dd34164da2e6c0df1c1"
                      }
                ]
          }
    },
  "gitilesCommit": {
    "host": "chromium.googlesource.com",
    "project": "native_client/src/native_client",
    "id": "3b97fe83377a2034b2aa4dd34164da2e6c0df1c1",
    "ref": "refs/heads/master"
  },
  "tags": [
    {
      "key": "scheduler_invocation_id",
      "value": "9012402309526748160"
    },
    {
      "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"
  }
}
[15:53:33.223] Scheduled build:
{
  "id": "8846972247378676032",
  "builder": {
    "project": "nacl",
    "bucket": "ci",
    "builder": "linux-64-validator-opt"
  },
  "number": 191,
  "createdBy": "project:nacl",
  "createTime": "2021-05-17T15:53:31.924952Z",
  "updateTime": "2021-05-17T15:53:32.951740Z",
  "status": "SCHEDULED",
  "input": {
    "gitilesCommit": {
      "host": "chromium.googlesource.com",
      "project": "native_client/src/native_client",
      "id": "3b97fe83377a2034b2aa4dd34164da2e6c0df1c1",
      "ref": "refs/heads/master"
    }
  }
}
[15:53:33.223] Task URL: https://cr-buildbucket.appspot.com/build/8846972247378676032
[15:53:33.223] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012402309526748160:2:0) after 3m0s
[15:54:02.803] Received PubSub notification, asking Buildbucket for the build status
[15:54:02.848] Build status: STARTED
[15:56:33.249] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012402309526748160:2:0)
[15:56:33.290] Build status: STARTED
[15:56:33.290] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012402309526748160:4:0) after 4m2s
[16:00:35.510] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012402309526748160:4:0)
[16:00:35.573] Build status: STARTED
[16:00:35.573] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012402309526748160:5:0) after 1m45s
[16:02:20.598] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012402309526748160:5:0)
[16:02:20.632] Build status: STARTED
[16:02:20.632] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012402309526748160:6:0) after 1m17s
[16:03:37.746] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012402309526748160:6:0)
[16:03:37.773] Build status: STARTED
[16:03:37.773] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012402309526748160:7:0) after 6m31s
[16:10:08.792] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012402309526748160:7:0)
[16:10:08.835] Build status: STARTED
[16:10:08.835] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012402309526748160:8:0) after 3m30s
[16:13:38.851] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012402309526748160:8:0)
[16:13:38.908] Build status: STARTED
[16:13:38.908] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012402309526748160:9:0) after 2m40s
[16:16:19.108] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012402309526748160:9:0)
[16:16:19.146] Build status: STARTED
[16:16:19.146] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012402309526748160:10:0) after 5m21s
[16:21:40.499] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012402309526748160:10:0)
[16:21:40.576] Build status: STARTED
[16:21:40.576] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012402309526748160:11:0) after 6m42s
[16:28:22.577] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012402309526748160:11:0)
[16:28:22.698] Build status: STARTED
[16:28:22.698] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012402309526748160:12:0) after 3m29s
[16:31:51.763] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012402309526748160:12:0)
[16:31:51.794] Build status: STARTED
[16:31:51.794] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012402309526748160:13:0) after 5m4s
[16:36:55.814] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012402309526748160:13:0)
[16:36:55.842] Build status: STARTED
[16:36:55.842] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012402309526748160:14:0) after 8m11s
[16:45:06.875] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012402309526748160:14:0)
[16:45:06.905] Build status: STARTED
[16:45:06.905] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012402309526748160:15:0) after 4m24s
[16:49:30.966] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012402309526748160:15:0)
[16:49:31.007] Build status: STARTED
[16:49:31.007] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012402309526748160:16:0) after 9m42s
[16:59:13.025] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012402309526748160:16:0)
[16:59:13.054] Build status: STARTED
[16:59:13.054] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012402309526748160:17:0) after 3m15s
[17:02:28.330] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012402309526748160:17:0)
[17:02:28.359] Build status: STARTED
[17:02:28.359] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012402309526748160:18:0) after 6m18s
[17:08:46.379] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012402309526748160:18:0)
[17:08:46.418] Build status: STARTED
[17:08:46.418] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012402309526748160:19:0) after 8m11s
[17:16:57.444] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012402309526748160:19:0)
[17:16:57.479] Build status: STARTED
[17:16:57.479] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012402309526748160:20:0) after 4m13s
[17:21:10.503] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012402309526748160:20:0)
[17:21:10.532] Build status: STARTED
[17:21:10.532] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012402309526748160:21:0) after 6m56s
[17:28:06.565] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012402309526748160:21:0)
[17:28:06.593] Build status: STARTED
[17:28:06.593] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012402309526748160:22:0) after 6m58s
[17:35:04.616] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012402309526748160:22:0)
[17:35:04.643] Build status: STARTED
[17:35:04.643] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012402309526748160:23:0) after 2m51s
[17:37:56.153] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012402309526748160:23:0)
[17:37:56.180] Build status: STARTED
[17:37:56.180] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012402309526748160:24:0) after 7m4s
[17:45:00.226] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012402309526748160:24:0)
[17:45:00.253] Build status: STARTED
[17:45:00.253] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012402309526748160:25:0) after 5m21s
[17:50:21.296] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012402309526748160:25:0)
[17:50:21.327] Build status: STARTED
[17:50:21.327] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012402309526748160:26:0) after 6m7s
[17:56:28.362] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012402309526748160:26:0)
[17:56:28.389] Build status: STARTED
[17:56:28.390] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012402309526748160:27:0) after 2m31s
[17:58:59.660] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012402309526748160:27:0)
[17:58:59.689] Build status: STARTED
[17:58:59.689] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012402309526748160:28:0) after 6m11s
[18:05:10.749] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012402309526748160:28:0)
[18:05:10.789] Build status: STARTED
[18:05:10.789] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012402309526748160:29:0) after 4m50s
[18:10:01.042] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012402309526748160:29:0)
[18:10:01.077] Build status: STARTED
[18:10:01.077] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012402309526748160:30:0) after 7m54s
[18:17:55.106] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012402309526748160:30:0)
[18:17:55.145] Build status: STARTED
[18:17:55.145] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012402309526748160:31:0) after 1m10s
[18:19:05.164] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012402309526748160:31:0)
[18:19:05.192] Build status: STARTED
[18:19:05.192] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012402309526748160:32:0) after 3m40s
[18:22:45.212] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012402309526748160:32:0)
[18:22:45.244] Build status: STARTED
[18:22:45.244] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012402309526748160:33:0) after 7m3s
[18:29:48.264] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012402309526748160:33:0)
[18:29:48.321] Build status: STARTED
[18:29:48.321] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012402309526748160:34:0) after 2m57s
[18:32:45.478] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012402309526748160:34:0)
[18:32:45.508] Build status: STARTED
[18:32:45.508] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012402309526748160:35:0) after 8m23s
[18:41:08.698] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012402309526748160:35:0)
[18:41:08.758] Build status: STARTED
[18:41:08.758] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012402309526748160:36:0) after 8m31s
[18:49:39.781] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012402309526748160:36:0)
[18:49:39.865] Build status: STARTED
[18:49:39.865] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012402309526748160:37:0) after 6m12s
[18:55:51.900] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012402309526748160:37:0)
[18:55:51.931] Build status: STARTED
[18:55:51.931] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012402309526748160:38:0) after 2m25s
[18:58:17.050] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012402309526748160:38:0)
[18:58:17.085] Build status: STARTED
[18:58:17.085] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012402309526748160:39:0) after 7m34s
[19:05:51.407] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012402309526748160:39:0)
[19:05:51.447] Build status: STARTED
[19:05:51.447] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012402309526748160:40:0) after 6m38s
[19:12:29.494] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012402309526748160:40:0)
[19:12:29.539] Build status: STARTED
[19:12:29.539] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012402309526748160:41:0) after 9m10s
[19:21:39.728] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012402309526748160:41:0)
[19:21:39.754] Build status: STARTED
[19:21:39.754] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012402309526748160:42:0) after 5m9s
[19:26:48.846] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012402309526748160:42:0)
[19:26:48.938] Build status: STARTED
[19:26:48.938] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012402309526748160:43:0) after 9m7s
[19:35:55.965] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012402309526748160:43:0)
[19:35:55.999] Build status: STARTED
[19:35:55.999] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012402309526748160:44:0) after 4m14s
[19:40:10.068] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012402309526748160:44:0)
[19:40:10.096] Build status: STARTED
[19:40:10.096] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012402309526748160:45:0) after 4m59s
[19:45:09.116] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012402309526748160:45:0)
[19:45:09.150] Build status: STARTED
[19:45:09.150] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012402309526748160:46:0) after 9m49s
[19:54:58.363] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012402309526748160:46:0)
[19:54:58.388] Build status: STARTED
[19:54:58.388] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012402309526748160:47:0) after 2m10s
[19:57:08.540] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012402309526748160:47:0)
[19:57:08.587] Build status: STARTED
[19:57:08.587] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012402309526748160:48:0) after 6m43s
[20:03:51.673] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012402309526748160:48:0)
[20:03:51.705] Build status: STARTED
[20:03:51.705] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012402309526748160:49:0) after 8m13s
[20:12:05.208] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012402309526748160:49:0)
[20:12:05.242] Build status: STARTED
[20:12:05.242] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012402309526748160:50:0) after 1m48s
[20:13:53.441] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012402309526748160:50:0)
[20:13:53.530] Build status: STARTED
[20:13:53.530] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012402309526748160:51:0) after 2m44s
[20:16:37.850] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012402309526748160:51:0)
[20:16:37.879] Build status: STARTED
[20:16:37.879] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012402309526748160:52:0) after 1m13s
[20:17:50.898] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012402309526748160:52:0)
[20:17:50.970] Build status: STARTED
[20:17:50.970] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012402309526748160:53:0) after 2m54s
[20:20:44.987] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012402309526748160:53:0)
[20:20:45.019] Build status: STARTED
[20:20:45.019] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012402309526748160:54:0) after 8m9s
[20:28:54.077] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012402309526748160:54:0)
[20:28:54.103] Build status: STARTED
[20:28:54.103] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012402309526748160:55:0) after 3m57s
[20:32:51.146] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012402309526748160:55:0)
[20:32:51.184] Build status: STARTED
[20:32:51.184] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012402309526748160:56:0) after 8m3s
[20:40:54.333] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012402309526748160:56:0)
[20:40:54.432] Build status: STARTED
[20:40:54.432] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012402309526748160:57:0) after 3m53s
[20:44:47.943] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012402309526748160:57:0)
[20:44:48.005] Build status: STARTED
[20:44:48.005] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012402309526748160:58:0) after 4m18s
[20:49:06.311] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012402309526748160:58:0)
[20:49:06.348] Build status: STARTED
[20:49:06.348] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012402309526748160:59:0) after 1m1s
[20:50:07.485] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012402309526748160:59:0)
[20:50:07.513] Build status: STARTED
[20:50:07.513] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012402309526748160:60:0) after 7m4s
[20:57:12.685] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012402309526748160:60:0)
[20:57:12.747] Build status: STARTED
[20:57:12.747] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012402309526748160:61:0) after 4m35s
[21:01:48.141] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012402309526748160:61:0)
[21:01:48.217] Build status: STARTED
[21:01:48.217] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012402309526748160:62:0) after 1m35s
[21:03:23.210] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012402309526748160:62:0)
[21:03:23.339] Build status: STARTED
[21:03:23.339] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012402309526748160:63:0) after 8m20s
[21:11:43.563] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012402309526748160:63:0)
[21:11:43.595] Build status: STARTED
[21:11:43.595] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012402309526748160:64:0) after 6m32s
[21:18:15.721] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012402309526748160:64:0)
[21:18:15.848] Build status: STARTED
[21:18:15.848] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012402309526748160:65:0) after 9m29s
[21:27:45.172] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012402309526748160:65:0)
[21:27:45.224] Build status: STARTED
[21:27:45.224] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012402309526748160:66:0) after 3m57s
[21:31:42.389] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012402309526748160:66:0)
[21:31:42.420] Build status: STARTED
[21:31:42.420] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012402309526748160:67:0) after 7m39s
[21:39:21.552] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012402309526748160:67:0)
[21:39:21.582] Build status: STARTED
[21:39:21.582] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012402309526748160:68:0) after 4m56s
[21:44:17.897] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012402309526748160:68:0)
[21:44:17.948] Build status: STARTED
[21:44:17.948] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012402309526748160:69:0) after 4m24s
[21:48:42.096] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012402309526748160:69:0)
[21:48:42.125] Build status: STARTED
[21:48:42.125] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012402309526748160:70:0) after 7m5s
[21:55:47.246] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012402309526748160:70:0)
[21:55:47.279] Build status: STARTED
[21:55:47.279] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012402309526748160:71:0) after 6m27s
[22:02:14.356] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012402309526748160:71:0)
[22:02:14.397] Build status: STARTED
[22:02:14.397] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012402309526748160:72:0) after 9m43s
[22:11:57.524] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012402309526748160:72:0)
[22:11:57.561] Build status: STARTED
[22:11:57.561] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012402309526748160:73:0) after 4m50s
[22:16:47.558] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012402309526748160:73:0)
[22:16:47.589] Build status: STARTED
[22:16:47.589] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012402309526748160:74:0) after 9m13s
[22:26:00.616] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012402309526748160:74:0)
[22:26:00.672] Build status: STARTED
[22:26:00.672] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012402309526748160:75:0) after 1m0s
[22:27:00.695] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012402309526748160:75:0)
[22:27:00.724] Build status: STARTED
[22:27:00.724] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012402309526748160:76:0) after 9m1s
[22:36:01.747] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012402309526748160:76:0)
[22:36:01.779] Build status: STARTED
[22:36:01.779] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012402309526748160:77:0) after 4m29s
[22:40:30.843] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012402309526748160:77:0)
[22:40:30.870] Build status: STARTED
[22:40:30.870] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012402309526748160:78:0) after 1m26s
[22:41:57.070] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012402309526748160:78:0)
[22:41:57.105] Build status: STARTED
[22:41:57.105] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012402309526748160:79:0) after 7m55s
[22:49:52.129] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012402309526748160:79:0)
[22:49:52.158] Build status: STARTED
[22:49:52.158] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012402309526748160:80:0) after 4m1s
[22:53:53.184] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012402309526748160:80:0)
[22:53:53.355] Build status: STARTED
[22:53:53.355] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012402309526748160:81:0) after 1m47s
[22:55:40.394] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012402309526748160:81:0)
[22:55:40.423] Build status: STARTED
[22:55:40.423] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012402309526748160:82:0) after 3m4s
[22:58:44.578] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012402309526748160:82:0)
[22:58:44.606] Build status: STARTED
[22:58:44.606] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012402309526748160:83:0) after 2m46s
[23:01:31.153] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012402309526748160:83:0)
[23:01:31.205] Build status: STARTED
[23:01:31.205] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012402309526748160:84:0) after 2m57s
[23:04:28.315] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012402309526748160:84:0)
[23:04:28.353] Build status: STARTED
[23:04:28.353] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012402309526748160:85:0) after 2m3s
[23:06:31.374] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012402309526748160:85:0)
[23:06:31.421] Build status: STARTED
[23:06:31.421] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012402309526748160:86:0) after 6m38s
[23:13:09.452] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012402309526748160:86:0)
[23:13:09.483] Build status: STARTED
[23:13:09.483] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012402309526748160:87:0) after 3m52s
[23:17:01.641] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012402309526748160:87:0)
[23:17:01.676] Build status: STARTED
[23:17:01.676] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012402309526748160:88:0) after 4m47s
[23:21:48.745] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012402309526748160:88:0)
[23:21:48.785] Build status: STARTED
[23:21:48.785] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012402309526748160:89:0) after 2m52s
[23:24:40.849] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012402309526748160:89:0)
[23:24:40.879] Build status: STARTED
[23:24:40.880] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012402309526748160:90:0) after 1m13s
[23:25:53.874] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012402309526748160:90:0)
[23:25:53.897] Build status: STARTED
[23:25:53.897] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012402309526748160:91:0) after 3m43s
[23:29:36.995] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012402309526748160:91:0)
[23:29:37.022] Build status: STARTED
[23:29:37.022] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012402309526748160:92:0) after 1m59s
[23:31:36.073] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012402309526748160:92:0)
[23:31:36.117] Build status: STARTED
[23:31:36.117] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012402309526748160:93:0) after 9m34s
[23:41:10.148] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012402309526748160:93:0)
[23:41:10.175] Build status: STARTED
[23:41:10.175] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012402309526748160:94:0) after 1m0s
[23:42:10.289] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012402309526748160:94:0)
[23:42:10.321] Build status: STARTED
[23:42:10.321] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012402309526748160:95:0) after 3m47s
[23:45:57.340] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012402309526748160:95:0)
[23:45:57.378] Build status: STARTED
[23:45:57.378] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012402309526748160:96:0) after 7m35s
[23:53:32.405] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012402309526748160:96:0)
[23:53:32.434] Build status: STARTED
[23:53:32.434] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012402309526748160:97:0) after 8m57s
[00:02:29.487] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012402309526748160:97:0)
[00:02:29.524] Build status: STARTED
[00:02:29.524] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012402309526748160:98:0) after 9m55s
[00:12:24.607] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012402309526748160:98:0)
[00:12:24.637] Build status: STARTED
[00:12:24.637] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012402309526748160:99:0) after 7m38s
[00:20:02.729] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012402309526748160:99:0)
[00:20:02.792] Build status: STARTED
[00:20:02.792] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012402309526748160:100:0) after 7m13s
[00:27:15.868] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012402309526748160:100:0)
[00:27:15.915] Build status: STARTED
[00:27:15.915] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012402309526748160:101:0) after 2m54s
[00:30:10.530] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012402309526748160:101:0)
[00:30:10.572] Build status: STARTED
[00:30:10.572] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012402309526748160:102:0) after 6m44s
[00:36:54.878] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012402309526748160:102:0)
[00:36:54.938] Build status: STARTED
[00:36:54.938] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012402309526748160:103:0) after 6m54s
[00:43:49.238] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012402309526748160:103:0)
[00:43:49.268] Build status: STARTED
[00:43:49.268] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012402309526748160:104:0) after 1m3s
[00:44:52.290] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012402309526748160:104:0)
[00:44:52.320] Build status: STARTED
[00:44:52.320] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012402309526748160:105:0) after 5m9s
[00:50:01.514] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012402309526748160:105:0)
[00:50:01.664] Build status: STARTED
[00:50:01.664] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012402309526748160:106:0) after 1m30s
[00:51:32.090] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012402309526748160:106:0)
[00:51:32.130] Build status: STARTED
[00:51:32.130] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012402309526748160:107:0) after 5m56s
[00:57:28.155] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012402309526748160:107:0)
[00:57:28.192] Build status: STARTED
[00:57:28.192] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012402309526748160:108:0) after 9m46s
[01:07:14.332] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012402309526748160:108:0)
[01:07:14.366] Build status: STARTED
[01:07:14.366] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012402309526748160:109:0) after 4m37s
[01:11:51.534] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012402309526748160:109:0)
[01:11:51.566] Build status: STARTED
[01:11:51.566] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012402309526748160:110:0) after 1m26s
[01:13:17.897] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012402309526748160:110:0)
[01:13:17.929] Build status: STARTED
[01:13:17.929] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012402309526748160:111:0) after 3m22s
[01:16:39.990] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012402309526748160:111:0)
[01:16:40.024] Build status: STARTED
[01:16:40.024] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012402309526748160:112:0) after 2m30s
[01:19:10.083] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012402309526748160:112:0)
[01:19:10.118] Build status: STARTED
[01:19:10.118] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012402309526748160:113:0) after 6m57s
[01:26:06.710] Received PubSub notification, asking Buildbucket for the build status
[01:26:06.740] Build:
{
  "id": "8846972247378676032",
  "builder": {
    "project": "nacl",
    "bucket": "ci",
    "builder": "linux-64-validator-opt"
  },
  "number": 191,
  "createdBy": "project:nacl",
  "createTime": "2021-05-17T15:53:31.924952Z",
  "startTime": "2021-05-17T15:54:01.660801Z",
  "endTime": "2021-05-18T01:26:05.442848Z",
  "updateTime": "2021-05-18T01:26:06.254895Z",
  "status": "SUCCESS",
  "input": {
    "gitilesCommit": {
      "host": "chromium.googlesource.com",
      "project": "native_client/src/native_client",
      "id": "3b97fe83377a2034b2aa4dd34164da2e6c0df1c1",
      "ref": "refs/heads/master"
    }
  }
}
[01:26:06.740] Invocation finished in 9h32m36.249274445s with status SUCCEEDED