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

7ccd070716e66e3a580821620477637b90b641e5 (3 years ago)

Incoming properties

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

Incoming tags

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

Debug log (UTC)

[19:20:27.777] New invocation is queued and will start shortly
[19:20:29.186] Starting the invocation (attempt 1)
[19:20:29.224] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/native_client/src/native_client/+/7ccd070716e66e3a580821620477637b90b641e5"
[19:20:29.224] Popped gitiles commit info from properties and tags
[19:20:29.224] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[19:20:29.224] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[19:20:29.224] Buildbucket request:
{
  "requestId": "9012661079974730400",
  "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": "7ccd070716e66e3a580821620477637b90b641e5"
                            },
                        "id": "https://chromium.googlesource.com/native_client/src/native_client/+/refs/heads/master@7ccd070716e66e3a580821620477637b90b641e5",
                        "title": "7ccd070716e66e3a580821620477637b90b641e5",
                        "url": "https://chromium.googlesource.com/native_client/src/native_client/+/7ccd070716e66e3a580821620477637b90b641e5"
                      }
                ]
          }
    },
  "gitilesCommit": {
    "host": "chromium.googlesource.com",
    "project": "native_client/src/native_client",
    "id": "7ccd070716e66e3a580821620477637b90b641e5",
    "ref": "refs/heads/master"
  },
  "tags": [
    {
      "key": "scheduler_invocation_id",
      "value": "9012661079974730400"
    },
    {
      "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"
  }
}
[19:20:29.772] Scheduled build:
{
  "id": "8847231017665820976",
  "builder": {
    "project": "nacl",
    "bucket": "ci",
    "builder": "linux-64-validator-opt"
  },
  "number": 189,
  "createdBy": "project:nacl",
  "createTime": "2021-05-14T19:20:29.347114Z",
  "updateTime": "2021-05-14T19:20:29.693873Z",
  "status": "SCHEDULED",
  "input": {
    "gitilesCommit": {
      "host": "chromium.googlesource.com",
      "project": "native_client/src/native_client",
      "id": "7ccd070716e66e3a580821620477637b90b641e5",
      "ref": "refs/heads/master"
    }
  }
}
[19:20:29.772] Task URL: https://cr-buildbucket.appspot.com/build/8847231017665820976
[19:20:29.772] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012661079974730400:2:0) after 9m43s
[19:21:20.567] Received PubSub notification, asking Buildbucket for the build status
[19:21:20.595] Build status: STARTED
[19:30:13.101] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012661079974730400:2:0)
[19:30:13.145] Build status: STARTED
[19:30:13.145] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012661079974730400:4:0) after 4m16s
[19:34:29.328] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012661079974730400:4:0)
[19:34:29.357] Build status: STARTED
[19:34:29.357] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012661079974730400:5:0) after 6m56s
[19:41:25.330] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012661079974730400:5:0)
[19:41:25.357] Build status: STARTED
[19:41:25.357] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012661079974730400:6:0) after 9m26s
[19:50:51.578] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012661079974730400:6:0)
[19:50:51.604] Build status: STARTED
[19:50:51.604] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012661079974730400:7:0) after 5m7s
[19:55:58.637] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012661079974730400:7:0)
[19:55:58.663] Build status: STARTED
[19:55:58.663] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012661079974730400:8:0) after 2m59s
[19:58:57.780] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012661079974730400:8:0)
[19:58:57.811] Build status: STARTED
[19:58:57.811] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012661079974730400:9:0) after 8m59s
[20:07:57.107] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012661079974730400:9:0)
[20:07:57.133] Build status: STARTED
[20:07:57.133] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012661079974730400:10:0) after 1m42s
[20:09:39.150] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012661079974730400:10:0)
[20:09:39.204] Build status: STARTED
[20:09:39.204] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012661079974730400:11:0) after 8m48s
[20:18:27.379] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012661079974730400:11:0)
[20:18:27.414] Build status: STARTED
[20:18:27.414] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012661079974730400:12:0) after 7m5s
[20:25:32.522] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012661079974730400:12:0)
[20:25:32.553] Build status: STARTED
[20:25:32.554] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012661079974730400:13:0) after 1m30s
[20:27:02.582] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012661079974730400:13:0)
[20:27:02.631] Build status: STARTED
[20:27:02.631] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012661079974730400:14:0) after 1m21s
[20:28:24.365] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012661079974730400:14:0)
[20:28:24.418] Build status: STARTED
[20:28:24.418] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012661079974730400:15:0) after 5m40s
[20:34:04.439] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012661079974730400:15:0)
[20:34:04.535] Build status: STARTED
[20:34:04.535] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012661079974730400:16:0) after 1m11s
[20:35:15.509] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012661079974730400:16:0)
[20:35:15.540] Build status: STARTED
[20:35:15.540] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012661079974730400:17:0) after 2m31s
[20:37:46.659] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012661079974730400:17:0)
[20:37:46.694] Build status: STARTED
[20:37:46.694] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012661079974730400:18:0) after 1m58s
[20:39:44.905] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012661079974730400:18:0)
[20:39:44.965] Build status: STARTED
[20:39:44.965] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012661079974730400:19:0) after 6m7s
[20:45:52.149] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012661079974730400:19:0)
[20:45:52.220] Build status: STARTED
[20:45:52.220] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012661079974730400:20:0) after 7m12s
[20:53:04.343] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012661079974730400:20:0)
[20:53:04.408] Build status: STARTED
[20:53:04.408] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012661079974730400:21:0) after 5m53s
[20:58:57.975] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012661079974730400:21:0)
[20:58:58.003] Build status: STARTED
[20:58:58.003] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012661079974730400:22:0) after 9m33s
[21:08:31.326] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012661079974730400:22:0)
[21:08:31.363] Build status: STARTED
[21:08:31.363] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012661079974730400:23:0) after 4m0s
[21:12:31.386] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012661079974730400:23:0)
[21:12:31.428] Build status: STARTED
[21:12:31.428] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012661079974730400:24:0) after 3m2s
[21:15:33.450] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012661079974730400:24:0)
[21:15:33.483] Build status: STARTED
[21:15:33.483] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012661079974730400:25:0) after 2m21s
[21:17:54.577] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012661079974730400:25:0)
[21:17:54.670] Build status: STARTED
[21:17:54.670] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012661079974730400:26:0) after 7m56s
[21:25:50.688] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012661079974730400:26:0)
[21:25:50.780] Build status: STARTED
[21:25:50.780] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012661079974730400:27:0) after 3m56s
[21:29:46.860] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012661079974730400:27:0)
[21:29:46.895] Build status: STARTED
[21:29:46.895] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012661079974730400:28:0) after 4m25s
[21:34:11.966] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012661079974730400:28:0)
[21:34:11.990] Build status: STARTED
[21:34:11.990] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012661079974730400:29:0) after 9m25s
[21:43:37.007] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012661079974730400:29:0)
[21:43:37.034] Build status: STARTED
[21:43:37.034] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012661079974730400:30:0) after 6m4s
[21:49:41.071] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012661079974730400:30:0)
[21:49:41.100] Build status: STARTED
[21:49:41.100] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012661079974730400:31:0) after 7m55s
[21:57:36.293] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012661079974730400:31:0)
[21:57:36.320] Build status: STARTED
[21:57:36.320] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012661079974730400:32:0) after 5m27s
[22:03:03.417] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012661079974730400:32:0)
[22:03:03.462] Build status: STARTED
[22:03:03.462] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012661079974730400:33:0) after 1m53s
[22:04:56.624] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012661079974730400:33:0)
[22:04:56.651] Build status: STARTED
[22:04:56.651] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012661079974730400:34:0) after 8m17s
[22:13:13.754] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012661079974730400:34:0)
[22:13:13.784] Build status: STARTED
[22:13:13.784] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012661079974730400:35:0) after 8m31s
[22:21:44.988] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012661079974730400:35:0)
[22:21:45.017] Build status: STARTED
[22:21:45.017] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012661079974730400:36:0) after 6m41s
[22:28:26.138] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012661079974730400:36:0)
[22:28:26.170] Build status: STARTED
[22:28:26.170] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012661079974730400:37:0) after 4m32s
[22:32:58.387] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012661079974730400:37:0)
[22:32:58.419] Build status: STARTED
[22:32:58.419] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012661079974730400:38:0) after 8m26s
[22:41:24.523] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012661079974730400:38:0)
[22:41:24.552] Build status: STARTED
[22:41:24.552] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012661079974730400:39:0) after 2m39s
[22:44:03.716] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012661079974730400:39:0)
[22:44:03.839] Build status: STARTED
[22:44:03.839] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012661079974730400:40:0) after 4m55s
[22:48:58.880] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012661079974730400:40:0)
[22:48:58.906] Build status: STARTED
[22:48:58.906] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012661079974730400:41:0) after 8m27s
[22:57:25.929] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012661079974730400:41:0)
[22:57:25.958] Build status: STARTED
[22:57:25.958] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012661079974730400:42:0) after 4m24s
[23:01:50.102] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012661079974730400:42:0)
[23:01:50.139] Build status: STARTED
[23:01:50.139] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012661079974730400:43:0) after 5m36s
[23:07:26.225] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012661079974730400:43:0)
[23:07:26.256] Build status: STARTED
[23:07:26.256] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012661079974730400:44:0) after 2m40s
[23:10:06.326] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012661079974730400:44:0)
[23:10:06.367] Build status: STARTED
[23:10:06.367] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012661079974730400:45:0) after 2m33s
[23:12:39.384] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012661079974730400:45:0)
[23:12:39.414] Build status: STARTED
[23:12:39.414] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012661079974730400:46:0) after 4m14s
[23:16:53.582] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012661079974730400:46:0)
[23:16:53.607] Build status: STARTED
[23:16:53.607] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012661079974730400:47:0) after 7m57s
[23:24:50.727] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012661079974730400:47:0)
[23:24:50.755] Build status: STARTED
[23:24:50.755] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012661079974730400:48:0) after 5m43s
[23:30:33.775] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012661079974730400:48:0)
[23:30:33.833] Build status: STARTED
[23:30:33.833] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012661079974730400:49:0) after 5m44s
[23:36:17.996] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012661079974730400:49:0)
[23:36:18.023] Build status: STARTED
[23:36:18.023] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012661079974730400:50:0) after 5m58s
[23:42:16.042] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012661079974730400:50:0)
[23:42:16.069] Build status: STARTED
[23:42:16.069] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012661079974730400:51:0) after 4m51s
[23:47:07.268] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012661079974730400:51:0)
[23:47:07.295] Build status: STARTED
[23:47:07.295] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012661079974730400:52:0) after 9m7s
[23:56:14.313] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012661079974730400:52:0)
[23:56:14.349] Build status: STARTED
[23:56:14.349] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012661079974730400:53:0) after 4m4s
[00:00:18.560] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012661079974730400:53:0)
[00:00:18.592] Build status: STARTED
[00:00:18.592] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012661079974730400:54:0) after 5m18s
[00:05:36.604] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012661079974730400:54:0)
[00:05:36.649] Build status: STARTED
[00:05:36.649] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012661079974730400:55:0) after 1m41s
[00:07:18.089] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012661079974730400:55:0)
[00:07:18.114] Build status: STARTED
[00:07:18.114] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012661079974730400:56:0) after 7m31s
[00:14:49.693] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012661079974730400:56:0)
[00:14:49.732] Build status: STARTED
[00:14:49.733] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012661079974730400:57:0) after 5m27s
[00:20:16.919] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012661079974730400:57:0)
[00:20:16.949] Build status: STARTED
[00:20:16.949] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012661079974730400:58:0) after 2m10s
[00:22:27.025] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012661079974730400:58:0)
[00:22:27.063] Build status: STARTED
[00:22:27.063] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012661079974730400:59:0) after 5m16s
[00:27:43.082] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012661079974730400:59:0)
[00:27:43.119] Build status: STARTED
[00:27:43.119] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012661079974730400:60:0) after 2m12s
[00:29:55.140] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012661079974730400:60:0)
[00:29:55.173] Build status: STARTED
[00:29:55.173] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012661079974730400:61:0) after 8m49s
[00:38:44.444] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012661079974730400:61:0)
[00:38:44.545] Build status: STARTED
[00:38:44.545] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012661079974730400:62:0) after 3m28s
[00:42:12.697] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012661079974730400:62:0)
[00:42:12.803] Build status: STARTED
[00:42:12.803] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012661079974730400:63:0) after 6m14s
[00:48:26.936] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012661079974730400:63:0)
[00:48:26.972] Build status: STARTED
[00:48:26.972] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012661079974730400:64:0) after 9m32s
[00:57:58.995] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012661079974730400:64:0)
[00:57:59.025] Build status: STARTED
[00:57:59.025] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012661079974730400:65:0) after 7m4s
[01:05:03.159] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012661079974730400:65:0)
[01:05:03.190] Build status: STARTED
[01:05:03.190] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012661079974730400:66:0) after 6m12s
[01:11:15.234] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012661079974730400:66:0)
[01:11:15.263] Build status: STARTED
[01:11:15.263] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012661079974730400:67:0) after 2m47s
[01:14:02.405] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012661079974730400:67:0)
[01:14:02.434] Build status: STARTED
[01:14:02.434] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012661079974730400:68:0) after 6m16s
[01:20:18.511] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012661079974730400:68:0)
[01:20:18.542] Build status: STARTED
[01:20:18.542] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012661079974730400:69:0) after 6m48s
[01:27:06.584] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012661079974730400:69:0)
[01:27:06.612] Build status: STARTED
[01:27:06.612] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012661079974730400:70:0) after 3m58s
[01:31:04.745] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012661079974730400:70:0)
[01:31:04.775] Build status: STARTED
[01:31:04.775] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012661079974730400:71:0) after 5m49s
[01:36:53.793] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012661079974730400:71:0)
[01:36:53.818] Build status: STARTED
[01:36:53.818] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012661079974730400:72:0) after 3m3s
[01:39:56.837] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012661079974730400:72:0)
[01:39:56.862] Build status: STARTED
[01:39:56.862] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012661079974730400:73:0) after 9m33s
[01:49:30.249] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012661079974730400:73:0)
[01:49:30.273] Build status: STARTED
[01:49:30.273] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012661079974730400:74:0) after 8m35s
[01:58:05.301] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012661079974730400:74:0)
[01:58:05.339] Build status: STARTED
[01:58:05.339] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012661079974730400:75:0) after 9m20s
[02:07:25.346] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012661079974730400:75:0)
[02:07:25.373] Build status: STARTED
[02:07:25.373] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012661079974730400:76:0) after 2m47s
[02:10:12.426] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012661079974730400:76:0)
[02:10:12.456] Build status: STARTED
[02:10:12.456] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012661079974730400:77:0) after 6m41s
[02:16:53.455] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012661079974730400:77:0)
[02:16:53.499] Build status: STARTED
[02:16:53.499] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012661079974730400:78:0) after 7m37s
[02:24:30.474] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012661079974730400:78:0)
[02:24:30.502] Build status: STARTED
[02:24:30.502] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012661079974730400:79:0) after 9m40s
[02:34:10.542] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012661079974730400:79:0)
[02:34:10.570] Build status: STARTED
[02:34:10.570] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012661079974730400:80:0) after 1m16s
[02:35:26.650] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012661079974730400:80:0)
[02:35:26.677] Build status: STARTED
[02:35:26.677] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012661079974730400:81:0) after 5m3s
[02:40:29.701] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012661079974730400:81:0)
[02:40:29.729] Build status: STARTED
[02:40:29.729] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012661079974730400:82:0) after 1m57s
[02:42:26.750] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012661079974730400:82:0)
[02:42:26.780] Build status: STARTED
[02:42:26.780] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012661079974730400:83:0) after 4m6s
[02:46:33.119] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012661079974730400:83:0)
[02:46:33.156] Build status: STARTED
[02:46:33.156] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012661079974730400:84:0) after 2m39s
[02:49:12.176] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012661079974730400:84:0)
[02:49:12.219] Build status: STARTED
[02:49:12.219] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012661079974730400:85:0) after 8m46s
[02:57:58.436] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012661079974730400:85:0)
[02:57:58.468] Build status: STARTED
[02:57:58.468] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012661079974730400:86:0) after 4m55s
[03:02:53.614] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012661079974730400:86:0)
[03:02:53.643] Build status: STARTED
[03:02:53.643] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012661079974730400:87:0) after 4m9s
[03:07:02.663] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012661079974730400:87:0)
[03:07:02.699] Build status: STARTED
[03:07:02.699] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012661079974730400:88:0) after 5m35s
[03:12:37.875] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012661079974730400:88:0)
[03:12:37.904] Build status: STARTED
[03:12:37.904] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012661079974730400:89:0) after 1m16s
[03:13:53.946] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012661079974730400:89:0)
[03:13:54.018] Build status: STARTED
[03:13:54.018] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012661079974730400:90:0) after 7m7s
[03:21:01.160] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012661079974730400:90:0)
[03:21:01.191] Build status: STARTED
[03:21:01.192] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012661079974730400:91:0) after 8m42s
[03:29:43.392] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012661079974730400:91:0)
[03:29:43.426] Build status: STARTED
[03:29:43.426] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012661079974730400:92:0) after 3m37s
[03:33:20.556] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012661079974730400:92:0)
[03:33:20.585] Build status: STARTED
[03:33:20.585] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012661079974730400:93:0) after 9m52s
[03:43:12.698] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012661079974730400:93:0)
[03:43:12.735] Build status: STARTED
[03:43:12.735] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012661079974730400:94:0) after 2m40s
[03:45:52.763] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012661079974730400:94:0)
[03:45:52.790] Build status: STARTED
[03:45:52.790] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012661079974730400:95:0) after 4m56s
[03:50:48.817] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012661079974730400:95:0)
[03:50:48.855] Build status: STARTED
[03:50:48.855] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012661079974730400:96:0) after 1m9s
[03:51:58.080] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012661079974730400:96:0)
[03:51:58.116] Build status: STARTED
[03:51:58.116] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012661079974730400:97:0) after 2m55s
[03:54:53.135] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012661079974730400:97:0)
[03:54:53.173] Build status: STARTED
[03:54:53.173] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012661079974730400:98:0) after 3m5s
[03:57:58.191] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012661079974730400:98:0)
[03:57:58.237] Build status: STARTED
[03:57:58.237] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012661079974730400:99:0) after 3m29s
[04:01:27.278] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012661079974730400:99:0)
[04:01:27.311] Build status: STARTED
[04:01:27.311] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012661079974730400:100:0) after 5m20s
[04:06:47.331] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012661079974730400:100:0)
[04:06:47.363] Build status: STARTED
[04:06:47.363] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012661079974730400:101:0) after 2m10s
[04:08:57.391] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012661079974730400:101:0)
[04:08:57.429] Build status: STARTED
[04:08:57.429] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012661079974730400:102:0) after 4m54s
[04:13:51.423] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012661079974730400:102:0)
[04:13:51.453] Build status: STARTED
[04:13:51.453] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012661079974730400:103:0) after 6m54s
[04:20:45.471] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012661079974730400:103:0)
[04:20:45.510] Build status: STARTED
[04:20:45.510] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012661079974730400:104:0) after 6m36s
[04:27:21.696] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012661079974730400:104:0)
[04:27:21.725] Build status: STARTED
[04:27:21.725] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012661079974730400:105:0) after 7m11s
[04:34:32.746] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012661079974730400:105:0)
[04:34:32.773] Build status: STARTED
[04:34:32.773] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012661079974730400:106:0) after 7m28s
[04:42:00.798] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012661079974730400:106:0)
[04:42:00.825] Build status: STARTED
[04:42:00.825] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012661079974730400:107:0) after 5m3s
[04:47:03.861] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012661079974730400:107:0)
[04:47:03.910] Build status: STARTED
[04:47:03.910] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012661079974730400:108:0) after 4m22s
[04:51:25.974] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012661079974730400:108:0)
[04:51:26.002] Build status: STARTED
[04:51:26.002] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012661079974730400:109:0) after 5m6s
[04:56:32.020] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012661079974730400:109:0)
[04:56:32.046] Build status: STARTED
[04:56:32.046] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9012661079974730400:110:0) after 9m34s
[05:04:26.883] Received PubSub notification, asking Buildbucket for the build status
[05:04:26.911] Build:
{
  "id": "8847231017665820976",
  "builder": {
    "project": "nacl",
    "bucket": "ci",
    "builder": "linux-64-validator-opt"
  },
  "number": 189,
  "createdBy": "project:nacl",
  "createTime": "2021-05-14T19:20:29.347114Z",
  "startTime": "2021-05-14T19:21:19.242436Z",
  "endTime": "2021-05-15T05:04:26.166408Z",
  "updateTime": "2021-05-15T05:04:26.639244Z",
  "status": "SUCCESS",
  "input": {
    "gitilesCommit": {
      "host": "chromium.googlesource.com",
      "project": "native_client/src/native_client",
      "id": "7ccd070716e66e3a580821620477637b90b641e5",
      "ref": "refs/heads/master"
    }
  }
}
[05:04:26.911] Invocation finished in 9h43m59.150272576s with status SUCCEEDED