Status: SUCCEEDED
Triggered by: -
Duration: 10 hours
Actions:

Definition (rev 8647dce0c5b1812bd57953fb611ed390e849ac26)

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

Incoming triggers

Incoming properties

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

Incoming tags

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

Debug log (UTC)

[10:07:53.645] New invocation is queued and will start shortly
[10:07:54.673] Starting the invocation (attempt 1)
[10:07:54.706] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/native_client/src/native_client/+/7f042407ccb79f38fac90233c0f7dd2e206ed58f"
[10:07:54.706] Popped gitiles commit info from properties and tags
[10:07:54.706] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[10:07:54.707] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[10:07:54.707] Buildbucket request:
{
  "requestId": "9016772708090201488",
  "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.git",
                              "revision": "7f042407ccb79f38fac90233c0f7dd2e206ed58f"
                            },
                        "id": "https://chromium.googlesource.com/native_client/src/native_client.git/+/refs/heads/master@7f042407ccb79f38fac90233c0f7dd2e206ed58f",
                        "title": "7f042407ccb79f38fac90233c0f7dd2e206ed58f",
                        "url": "https://chromium.googlesource.com/native_client/src/native_client.git/+/7f042407ccb79f38fac90233c0f7dd2e206ed58f"
                      }
                ]
          }
    },
  "gitilesCommit": {
    "host": "chromium.googlesource.com",
    "project": "native_client/src/native_client",
    "id": "7f042407ccb79f38fac90233c0f7dd2e206ed58f",
    "ref": "refs/heads/master"
  },
  "tags": [
    {
      "key": "scheduler_invocation_id",
      "value": "9016772708090201488"
    },
    {
      "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"
  }
}
[10:07:55.860] Scheduled build:
{
  "id": "8851342645732781760",
  "builder": {
    "project": "nacl",
    "bucket": "ci",
    "builder": "linux-64-validator-opt"
  },
  "number": 169,
  "createdBy": "project:nacl",
  "createTime": "2021-03-30T10:07:55.261352Z",
  "updateTime": "2021-03-30T10:07:55.785316Z",
  "status": "SCHEDULED",
  "input": {
    "gitilesCommit": {
      "host": "chromium.googlesource.com",
      "project": "native_client/src/native_client",
      "id": "7f042407ccb79f38fac90233c0f7dd2e206ed58f",
      "ref": "refs/heads/master"
    }
  }
}
[10:07:55.860] Task URL: https://cr-buildbucket.appspot.com/build/8851342645732781760
[10:07:55.860] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9016772708090201488:2:0) after 6m21s
[10:08:54.873] Received PubSub notification, asking Buildbucket for the build status
[10:08:54.896] Build status: STARTED
[10:14:16.939] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9016772708090201488:2:0)
[10:14:16.963] Build status: STARTED
[10:14:16.963] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9016772708090201488:4:0) after 1m0s
[10:15:16.977] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9016772708090201488:4:0)
[10:15:17.003] Build status: STARTED
[10:15:17.003] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9016772708090201488:5:0) after 6m33s
[10:21:50.289] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9016772708090201488:5:0)
[10:21:50.335] Build status: STARTED
[10:21:50.335] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9016772708090201488:6:0) after 9m46s
[10:31:36.502] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9016772708090201488:6:0)
[10:31:36.542] Build status: STARTED
[10:31:36.542] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9016772708090201488:7:0) after 3m51s
[10:35:27.628] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9016772708090201488:7:0)
[10:35:27.673] Build status: STARTED
[10:35:27.673] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9016772708090201488:8:0) after 1m44s
[10:37:11.723] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9016772708090201488:8:0)
[10:37:11.763] Build status: STARTED
[10:37:11.763] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9016772708090201488:9:0) after 7m24s
[10:44:35.750] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9016772708090201488:9:0)
[10:44:35.846] Build status: STARTED
[10:44:35.846] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9016772708090201488:10:0) after 8m32s
[10:53:07.862] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9016772708090201488:10:0)
[10:53:07.902] Build status: STARTED
[10:53:07.903] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9016772708090201488:11:0) after 5m19s
[10:58:26.920] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9016772708090201488:11:0)
[10:58:26.947] Build status: STARTED
[10:58:26.947] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9016772708090201488:12:0) after 7m0s
[11:05:27.929] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9016772708090201488:12:0)
[11:05:27.964] Build status: STARTED
[11:05:27.964] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9016772708090201488:13:0) after 1m36s
[11:07:03.982] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9016772708090201488:13:0)
[11:07:04.012] Build status: STARTED
[11:07:04.012] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9016772708090201488:14:0) after 9m5s
[11:16:09.153] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9016772708090201488:14:0)
[11:16:09.185] Build status: STARTED
[11:16:09.185] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9016772708090201488:15:0) after 7m5s
[11:23:14.203] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9016772708090201488:15:0)
[11:23:14.229] Build status: STARTED
[11:23:14.229] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9016772708090201488:16:0) after 9m32s
[11:32:46.337] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9016772708090201488:16:0)
[11:32:46.362] Build status: STARTED
[11:32:46.362] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9016772708090201488:17:0) after 7m35s
[11:40:21.381] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9016772708090201488:17:0)
[11:40:21.410] Build status: STARTED
[11:40:21.410] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9016772708090201488:18:0) after 2m5s
[11:42:26.425] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9016772708090201488:18:0)
[11:42:26.888] Build status: STARTED
[11:42:26.888] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9016772708090201488:19:0) after 3m53s
[11:46:19.932] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9016772708090201488:19:0)
[11:46:19.960] Build status: STARTED
[11:46:19.960] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9016772708090201488:20:0) after 4m31s
[11:50:50.980] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9016772708090201488:20:0)
[11:50:51.008] Build status: STARTED
[11:50:51.008] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9016772708090201488:21:0) after 6m44s
[11:57:35.027] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9016772708090201488:21:0)
[11:57:35.054] Build status: STARTED
[11:57:35.054] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9016772708090201488:22:0) after 7m48s
[12:05:23.071] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9016772708090201488:22:0)
[12:05:23.100] Build status: STARTED
[12:05:23.100] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9016772708090201488:23:0) after 9m21s
[12:14:44.168] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9016772708090201488:23:0)
[12:14:44.200] Build status: STARTED
[12:14:44.200] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9016772708090201488:24:0) after 3m35s
[12:18:19.225] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9016772708090201488:24:0)
[12:18:20.109] Build status: STARTED
[12:18:20.109] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9016772708090201488:25:0) after 8m38s
[12:26:58.133] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9016772708090201488:25:0)
[12:26:58.165] Build status: STARTED
[12:26:58.165] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9016772708090201488:26:0) after 4m18s
[12:31:16.290] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9016772708090201488:26:0)
[12:31:16.317] Build status: STARTED
[12:31:16.318] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9016772708090201488:27:0) after 6m1s
[12:37:17.394] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9016772708090201488:27:0)
[12:37:17.439] Build status: STARTED
[12:37:17.439] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9016772708090201488:28:0) after 3m43s
[12:41:00.479] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9016772708090201488:28:0)
[12:41:00.507] Build status: STARTED
[12:41:00.507] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9016772708090201488:29:0) after 4m40s
[12:45:40.526] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9016772708090201488:29:0)
[12:45:40.565] Build status: STARTED
[12:45:40.565] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9016772708090201488:30:0) after 1m5s
[12:46:45.675] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9016772708090201488:30:0)
[12:46:45.726] Build status: STARTED
[12:46:45.726] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9016772708090201488:31:0) after 3m18s
[12:50:03.824] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9016772708090201488:31:0)
[12:50:03.850] Build status: STARTED
[12:50:03.850] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9016772708090201488:32:0) after 6m21s
[12:56:24.959] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9016772708090201488:32:0)
[12:56:24.991] Build status: STARTED
[12:56:24.991] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9016772708090201488:33:0) after 3m15s
[12:59:40.007] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9016772708090201488:33:0)
[12:59:40.033] Build status: STARTED
[12:59:40.033] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9016772708090201488:34:0) after 2m39s
[13:02:19.052] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9016772708090201488:34:0)
[13:02:19.078] Build status: STARTED
[13:02:19.078] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9016772708090201488:35:0) after 8m21s
[13:10:40.104] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9016772708090201488:35:0)
[13:10:40.133] Build status: STARTED
[13:10:40.133] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9016772708090201488:36:0) after 1m10s
[13:11:50.366] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9016772708090201488:36:0)
[13:11:50.406] Build status: STARTED
[13:11:50.406] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9016772708090201488:37:0) after 2m18s
[13:14:08.467] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9016772708090201488:37:0)
[13:14:08.626] Build status: STARTED
[13:14:08.626] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9016772708090201488:38:0) after 8m23s
[13:22:31.655] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9016772708090201488:38:0)
[13:22:31.683] Build status: STARTED
[13:22:31.683] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9016772708090201488:39:0) after 3m58s
[13:26:29.789] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9016772708090201488:39:0)
[13:26:29.819] Build status: STARTED
[13:26:29.819] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9016772708090201488:40:0) after 7m13s
[13:33:42.850] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9016772708090201488:40:0)
[13:33:42.881] Build status: STARTED
[13:33:42.881] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9016772708090201488:41:0) after 2m25s
[13:36:08.015] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9016772708090201488:41:0)
[13:36:08.042] Build status: STARTED
[13:36:08.042] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9016772708090201488:42:0) after 9m55s
[13:46:03.138] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9016772708090201488:42:0)
[13:46:03.177] Build status: STARTED
[13:46:03.177] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9016772708090201488:43:0) after 5m27s
[13:51:30.168] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9016772708090201488:43:0)
[13:51:30.200] Build status: STARTED
[13:51:30.201] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9016772708090201488:44:0) after 2m42s
[13:54:12.230] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9016772708090201488:44:0)
[13:54:12.261] Build status: STARTED
[13:54:12.261] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9016772708090201488:45:0) after 9m17s
[14:03:29.333] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9016772708090201488:45:0)
[14:03:29.362] Build status: STARTED
[14:03:29.362] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9016772708090201488:46:0) after 3m13s
[14:06:42.442] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9016772708090201488:46:0)
[14:06:42.474] Build status: STARTED
[14:06:42.474] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9016772708090201488:47:0) after 9m27s
[14:16:09.497] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9016772708090201488:47:0)
[14:16:09.525] Build status: STARTED
[14:16:09.525] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9016772708090201488:48:0) after 3m29s
[14:19:38.588] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9016772708090201488:48:0)
[14:19:38.614] Build status: STARTED
[14:19:38.614] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9016772708090201488:49:0) after 4m45s
[14:24:23.682] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9016772708090201488:49:0)
[14:24:23.711] Build status: STARTED
[14:24:23.711] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9016772708090201488:50:0) after 9m4s
[14:33:27.783] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9016772708090201488:50:0)
[14:33:27.813] Build status: STARTED
[14:33:27.813] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9016772708090201488:51:0) after 2m32s
[14:35:59.838] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9016772708090201488:51:0)
[14:35:59.866] Build status: STARTED
[14:35:59.866] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9016772708090201488:52:0) after 9m8s
[14:45:08.144] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9016772708090201488:52:0)
[14:45:08.197] Build status: STARTED
[14:45:08.197] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9016772708090201488:53:0) after 5m0s
[14:50:08.292] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9016772708090201488:53:0)
[14:50:08.346] Build status: STARTED
[14:50:08.346] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9016772708090201488:54:0) after 9m35s
[14:59:43.355] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9016772708090201488:54:0)
[14:59:43.399] Build status: STARTED
[14:59:43.399] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9016772708090201488:55:0) after 5m49s
[15:05:32.474] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9016772708090201488:55:0)
[15:05:32.548] Build status: STARTED
[15:05:32.548] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9016772708090201488:56:0) after 2m10s
[15:07:42.590] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9016772708090201488:56:0)
[15:07:42.632] Build status: STARTED
[15:07:42.632] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9016772708090201488:57:0) after 6m49s
[15:14:31.672] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9016772708090201488:57:0)
[15:14:31.708] Build status: STARTED
[15:14:31.708] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9016772708090201488:58:0) after 3m17s
[15:17:48.726] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9016772708090201488:58:0)
[15:17:48.759] Build status: STARTED
[15:17:48.760] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9016772708090201488:59:0) after 4m55s
[15:22:43.778] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9016772708090201488:59:0)
[15:22:43.804] Build status: STARTED
[15:22:43.804] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9016772708090201488:60:0) after 2m0s
[15:24:43.821] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9016772708090201488:60:0)
[15:24:43.882] Build status: STARTED
[15:24:43.882] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9016772708090201488:61:0) after 4m33s
[15:29:17.076] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9016772708090201488:61:0)
[15:29:17.157] Build status: STARTED
[15:29:17.157] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9016772708090201488:62:0) after 2m26s
[15:31:43.186] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9016772708090201488:62:0)
[15:31:43.259] Build status: STARTED
[15:31:43.259] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9016772708090201488:63:0) after 9m51s
[15:41:34.392] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9016772708090201488:63:0)
[15:41:34.429] Build status: STARTED
[15:41:34.429] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9016772708090201488:64:0) after 2m33s
[15:44:07.762] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9016772708090201488:64:0)
[15:44:07.847] Build status: STARTED
[15:44:07.847] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9016772708090201488:65:0) after 7m21s
[15:51:28.927] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9016772708090201488:65:0)
[15:51:29.019] Build status: STARTED
[15:51:29.019] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9016772708090201488:66:0) after 9m55s
[16:01:24.037] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9016772708090201488:66:0)
[16:01:24.063] Build status: STARTED
[16:01:24.063] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9016772708090201488:67:0) after 5m4s
[16:06:28.180] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9016772708090201488:67:0)
[16:06:28.213] Build status: STARTED
[16:06:28.213] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9016772708090201488:68:0) after 1m23s
[16:07:51.358] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9016772708090201488:68:0)
[16:07:51.392] Build status: STARTED
[16:07:51.392] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9016772708090201488:69:0) after 1m44s
[16:09:35.604] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9016772708090201488:69:0)
[16:09:35.642] Build status: STARTED
[16:09:35.642] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9016772708090201488:70:0) after 4m53s
[16:14:28.738] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9016772708090201488:70:0)
[16:14:28.771] Build status: STARTED
[16:14:28.771] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9016772708090201488:71:0) after 7m5s
[16:21:33.833] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9016772708090201488:71:0)
[16:21:33.884] Build status: STARTED
[16:21:33.884] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9016772708090201488:72:0) after 4m53s
[16:26:26.900] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9016772708090201488:72:0)
[16:26:26.926] Build status: STARTED
[16:26:26.926] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9016772708090201488:73:0) after 9m30s
[16:35:57.032] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9016772708090201488:73:0)
[16:35:57.056] Build status: STARTED
[16:35:57.056] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9016772708090201488:74:0) after 9m32s
[16:45:29.752] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9016772708090201488:74:0)
[16:45:29.794] Build status: STARTED
[16:45:29.794] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9016772708090201488:75:0) after 4m1s
[16:49:30.844] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9016772708090201488:75:0)
[16:49:30.869] Build status: STARTED
[16:49:30.869] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9016772708090201488:76:0) after 8m12s
[16:57:43.023] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9016772708090201488:76:0)
[16:57:43.073] Build status: STARTED
[16:57:43.073] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9016772708090201488:77:0) after 2m0s
[16:59:43.161] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9016772708090201488:77:0)
[16:59:43.188] Build status: STARTED
[16:59:43.188] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9016772708090201488:78:0) after 3m21s
[17:03:04.520] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9016772708090201488:78:0)
[17:03:04.553] Build status: STARTED
[17:03:04.553] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9016772708090201488:79:0) after 8m9s
[17:11:13.808] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9016772708090201488:79:0)
[17:11:13.896] Build status: STARTED
[17:11:13.896] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9016772708090201488:80:0) after 7m4s
[17:18:17.920] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9016772708090201488:80:0)
[17:18:17.950] Build status: STARTED
[17:18:17.950] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9016772708090201488:81:0) after 3m16s
[17:21:34.053] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9016772708090201488:81:0)
[17:21:34.080] Build status: STARTED
[17:21:34.080] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9016772708090201488:82:0) after 4m13s
[17:25:47.098] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9016772708090201488:82:0)
[17:25:47.122] Build status: STARTED
[17:25:47.122] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9016772708090201488:83:0) after 3m45s
[17:29:32.238] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9016772708090201488:83:0)
[17:29:32.267] Build status: STARTED
[17:29:32.267] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9016772708090201488:84:0) after 2m4s
[17:31:36.456] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9016772708090201488:84:0)
[17:31:36.481] Build status: STARTED
[17:31:36.481] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9016772708090201488:85:0) after 6m16s
[17:37:52.494] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9016772708090201488:85:0)
[17:37:52.523] Build status: STARTED
[17:37:52.523] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9016772708090201488:86:0) after 9m6s
[17:46:58.541] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9016772708090201488:86:0)
[17:46:58.569] Build status: STARTED
[17:46:58.569] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9016772708090201488:87:0) after 9m28s
[17:56:26.611] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9016772708090201488:87:0)
[17:56:26.650] Build status: STARTED
[17:56:26.650] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9016772708090201488:88:0) after 1m31s
[17:57:57.673] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9016772708090201488:88:0)
[17:57:57.733] Build status: STARTED
[17:57:57.733] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9016772708090201488:89:0) after 5m9s
[18:03:06.779] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9016772708090201488:89:0)
[18:03:06.814] Build status: STARTED
[18:03:06.814] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9016772708090201488:90:0) after 7m24s
[18:10:30.837] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9016772708090201488:90:0)
[18:10:30.866] Build status: STARTED
[18:10:30.866] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9016772708090201488:91:0) after 7m6s
[18:17:36.871] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9016772708090201488:91:0)
[18:17:36.910] Build status: STARTED
[18:17:36.910] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9016772708090201488:92:0) after 3m1s
[18:20:38.306] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9016772708090201488:92:0)
[18:20:38.334] Build status: STARTED
[18:20:38.334] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9016772708090201488:93:0) after 9m18s
[18:29:56.580] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9016772708090201488:93:0)
[18:29:56.608] Build status: STARTED
[18:29:56.608] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9016772708090201488:94:0) after 2m0s
[18:31:56.737] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9016772708090201488:94:0)
[18:31:56.771] Build status: STARTED
[18:31:56.771] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9016772708090201488:95:0) after 4m49s
[18:36:45.773] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9016772708090201488:95:0)
[18:36:45.798] Build status: STARTED
[18:36:45.798] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9016772708090201488:96:0) after 7m15s
[18:44:00.982] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9016772708090201488:96:0)
[18:44:01.013] Build status: STARTED
[18:44:01.013] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9016772708090201488:97:0) after 9m27s
[18:53:28.093] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9016772708090201488:97:0)
[18:53:28.120] Build status: STARTED
[18:53:28.120] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9016772708090201488:98:0) after 1m7s
[18:54:35.177] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9016772708090201488:98:0)
[18:54:35.208] Build status: STARTED
[18:54:35.208] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9016772708090201488:99:0) after 8m47s
[19:03:22.239] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9016772708090201488:99:0)
[19:03:22.267] Build status: STARTED
[19:03:22.267] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9016772708090201488:100:0) after 3m56s
[19:07:18.289] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9016772708090201488:100:0)
[19:07:18.325] Build status: STARTED
[19:07:18.325] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9016772708090201488:101:0) after 9m52s
[19:17:10.356] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9016772708090201488:101:0)
[19:17:10.397] Build status: STARTED
[19:17:10.398] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9016772708090201488:102:0) after 5m0s
[19:22:10.494] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9016772708090201488:102:0)
[19:22:10.532] Build status: STARTED
[19:22:10.532] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9016772708090201488:103:0) after 6m51s
[19:29:01.636] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9016772708090201488:103:0)
[19:29:01.671] Build status: STARTED
[19:29:01.671] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9016772708090201488:104:0) after 5m51s
[19:34:52.692] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9016772708090201488:104:0)
[19:34:52.719] Build status: STARTED
[19:34:52.719] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9016772708090201488:105:0) after 4m56s
[19:39:48.745] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9016772708090201488:105:0)
[19:39:48.825] Build status: STARTED
[19:39:48.825] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9016772708090201488:106:0) after 3m36s
[19:43:24.871] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9016772708090201488:106:0)
[19:43:24.900] Build status: STARTED
[19:43:24.900] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9016772708090201488:107:0) after 8m10s
[19:51:34.954] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9016772708090201488:107:0)
[19:51:35.016] Build status: STARTED
[19:51:35.016] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9016772708090201488:108:0) after 1m37s
[19:53:12.139] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9016772708090201488:108:0)
[19:53:12.167] Build status: STARTED
[19:53:12.167] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9016772708090201488:109:0) after 3m37s
[19:56:49.320] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9016772708090201488:109:0)
[19:56:49.346] Build status: STARTED
[19:56:49.346] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9016772708090201488:110:0) after 6m20s
[20:03:09.669] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9016772708090201488:110:0)
[20:03:09.707] Build status: STARTED
[20:03:09.707] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9016772708090201488:111:0) after 6m53s
[20:10:02.977] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9016772708090201488:111:0)
[20:10:03.007] Build status: STARTED
[20:10:03.007] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9016772708090201488:112:0) after 5m26s
[20:15:29.199] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9016772708090201488:112:0)
[20:15:29.239] Build status: STARTED
[20:15:29.239] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9016772708090201488:113:0) after 9m9s
[20:24:39.416] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9016772708090201488:113:0)
[20:24:39.522] Build status: STARTED
[20:24:39.523] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9016772708090201488:114:0) after 5m18s
[20:29:57.590] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9016772708090201488:114:0)
[20:29:57.636] Build status: STARTED
[20:29:57.636] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9016772708090201488:115:0) after 2m41s
[20:32:38.666] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9016772708090201488:115:0)
[20:32:38.699] Build status: STARTED
[20:32:38.699] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9016772708090201488:116:0) after 1m15s
[20:33:53.791] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9016772708090201488:116:0)
[20:33:53.826] Build status: STARTED
[20:33:53.826] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9016772708090201488:117:0) after 6m9s
[20:36:48.007] Received PubSub notification, asking Buildbucket for the build status
[20:36:48.051] Build:
{
  "id": "8851342645732781760",
  "builder": {
    "project": "nacl",
    "bucket": "ci",
    "builder": "linux-64-validator-opt"
  },
  "number": 169,
  "createdBy": "project:nacl",
  "createTime": "2021-03-30T10:07:55.261352Z",
  "startTime": "2021-03-30T10:08:54.256028Z",
  "endTime": "2021-03-30T20:36:47.267131Z",
  "updateTime": "2021-03-30T20:36:47.537236Z",
  "status": "SUCCESS",
  "input": {
    "gitilesCommit": {
      "host": "chromium.googlesource.com",
      "project": "native_client/src/native_client",
      "id": "7f042407ccb79f38fac90233c0f7dd2e206ed58f",
      "ref": "refs/heads/master"
    }
  }
}
[20:36:48.051] Invocation finished in 10h28m54.421893502s with status SUCCEEDED